Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/3161/

2 tests failed.
FAILED:  
junit.framework.TestSuite.org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest

Error Message:
1 thread leaked from SUITE scope at 
org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest:     1) 
Thread[id=6804, name=zkConnectionManagerCallback-1814-thread-1, state=WAITING, 
group=TGRP-AutoscalingHistoryHandlerTest]         at 
sun.misc.Unsafe.park(Native Method)         at 
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)     
    at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)   
      at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134) 
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) 
        at java.lang.Thread.run(Thread.java:748)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest: 
   1) Thread[id=6804, name=zkConnectionManagerCallback-1814-thread-1, 
state=WAITING, group=TGRP-AutoscalingHistoryHandlerTest]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
        at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
        at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
        at java.lang.Thread.run(Thread.java:748)
        at __randomizedtesting.SeedInfo.seed([DC6FBEBE97287ADA]:0)


FAILED:  
junit.framework.TestSuite.org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest

Error Message:
There are still zombie threads that couldn't be terminated:    1) 
Thread[id=6804, name=zkConnectionManagerCallback-1814-thread-1, state=WAITING, 
group=TGRP-AutoscalingHistoryHandlerTest]         at 
sun.misc.Unsafe.park(Native Method)         at 
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)     
    at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)   
      at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134) 
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) 
        at java.lang.Thread.run(Thread.java:748)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   1) Thread[id=6804, name=zkConnectionManagerCallback-1814-thread-1, 
state=WAITING, group=TGRP-AutoscalingHistoryHandlerTest]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
        at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
        at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
        at java.lang.Thread.run(Thread.java:748)
        at __randomizedtesting.SeedInfo.seed([DC6FBEBE97287ADA]:0)




Build Log:
[...truncated 13054 lines...]
   [junit4] Suite: org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest
   [junit4]   2> 809452 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[DC6FBEBE97287ADA]-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/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_DC6FBEBE97287ADA-001/init-core-data-001
   [junit4]   2> 809453 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[DC6FBEBE97287ADA]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 809468 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[DC6FBEBE97287ADA]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 809468 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[DC6FBEBE97287ADA]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_DC6FBEBE97287ADA-001/tempDir-001
   [junit4]   2> 809469 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[DC6FBEBE97287ADA]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 809502 INFO  (ZkTestServer Run Thread) [    ] 
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 809503 INFO  (ZkTestServer Run Thread) [    ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 809503 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[DC6FBEBE97287ADA]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:37965
   [junit4]   2> 809503 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[DC6FBEBE97287ADA]-worker) [    ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:37965
   [junit4]   2> 809503 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[DC6FBEBE97287ADA]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 37965
   [junit4]   2> 809638 INFO  (zkConnectionManagerCallback-1684-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 809670 INFO  (zkConnectionManagerCallback-1686-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 809674 INFO  (zkConnectionManagerCallback-1688-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 809758 WARN  (jetty-launcher-1689-thread-1) [    ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 809759 INFO  (jetty-launcher-1689-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 809759 INFO  (jetty-launcher-1689-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 809759 INFO  (jetty-launcher-1689-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: 
c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
   [junit4]   2> 809778 WARN  (jetty-launcher-1689-thread-2) [    ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 809778 INFO  (jetty-launcher-1689-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 809778 INFO  (jetty-launcher-1689-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 809778 INFO  (jetty-launcher-1689-thread-2) [    ] 
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: 
c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
   [junit4]   2> 809823 INFO  (jetty-launcher-1689-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 809823 INFO  (jetty-launcher-1689-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 809823 INFO  (jetty-launcher-1689-thread-1) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 809824 INFO  (jetty-launcher-1689-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@18cacaf5{/solr,null,AVAILABLE}
   [junit4]   2> 809825 INFO  (jetty-launcher-1689-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@62c6a42a{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:46254}
   [junit4]   2> 809825 INFO  (jetty-launcher-1689-thread-1) [    ] 
o.e.j.s.Server Started @810168ms
   [junit4]   2> 809825 INFO  (jetty-launcher-1689-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=46254}
   [junit4]   2> 809826 ERROR (jetty-launcher-1689-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 809826 INFO  (jetty-launcher-1689-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 809826 INFO  (jetty-launcher-1689-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
9.0.0
   [junit4]   2> 809826 INFO  (jetty-launcher-1689-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 809826 INFO  (jetty-launcher-1689-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 809826 INFO  (jetty-launcher-1689-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-01-29T02:21:44.943Z
   [junit4]   2> 809828 INFO  (zkConnectionManagerCallback-1691-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 809867 INFO  (jetty-launcher-1689-thread-2) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 809867 INFO  (jetty-launcher-1689-thread-2) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 809867 INFO  (jetty-launcher-1689-thread-2) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 809868 INFO  (jetty-launcher-1689-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@47d06082{/solr,null,AVAILABLE}
   [junit4]   2> 809887 INFO  (jetty-launcher-1689-thread-2) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@a8ee8a8{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:36118}
   [junit4]   2> 809887 INFO  (jetty-launcher-1689-thread-2) [    ] 
o.e.j.s.Server Started @810230ms
   [junit4]   2> 809888 INFO  (jetty-launcher-1689-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=36118}
   [junit4]   2> 809888 ERROR (jetty-launcher-1689-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 809888 INFO  (jetty-launcher-1689-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 809888 INFO  (jetty-launcher-1689-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
9.0.0
   [junit4]   2> 809888 INFO  (jetty-launcher-1689-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 809888 INFO  (jetty-launcher-1689-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 809888 INFO  (jetty-launcher-1689-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-01-29T02:21:45.005Z
   [junit4]   2> 809891 INFO  (jetty-launcher-1689-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 809912 INFO  (zkConnectionManagerCallback-1693-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 809958 INFO  (jetty-launcher-1689-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 810480 INFO  (jetty-launcher-1689-thread-1) [    ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 810491 WARN  (jetty-launcher-1689-thread-1) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@27610e41[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 810497 WARN  (jetty-launcher-1689-thread-1) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@1d996537[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 810498 INFO  (jetty-launcher-1689-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37965/solr
   [junit4]   2> 810502 INFO  (jetty-launcher-1689-thread-2) [    ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 810551 INFO  (zkConnectionManagerCallback-1699-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 810633 WARN  (jetty-launcher-1689-thread-2) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@f5604c8[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 810638 WARN  (jetty-launcher-1689-thread-2) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@67457bfa[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 810638 INFO  (jetty-launcher-1689-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37965/solr
   [junit4]   2> 810695 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 
0x1073bac19a00005, likely client has closed socket
   [junit4]   2> 810722 INFO  (zkConnectionManagerCallback-1703-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 810738 INFO  (zkConnectionManagerCallback-1707-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 810771 INFO  (zkConnectionManagerCallback-1711-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 811529 INFO  (jetty-launcher-1689-thread-1) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:46254_solr
   [junit4]   2> 811530 INFO  (jetty-launcher-1689-thread-1) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.Overseer Overseer 
(id=74093529225232390-127.0.0.1:46254_solr-n_0000000000) starting
   [junit4]   2> 811590 INFO  (zkConnectionManagerCallback-1718-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 811606 INFO  (jetty-launcher-1689-thread-1) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:37965/solr ready
   [junit4]   2> 811634 INFO  
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:46254_solr
   [junit4]   2> 811634 INFO  (jetty-launcher-1689-thread-1) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:46254_solr
   [junit4]   2> 811634 DEBUG 
(OverseerAutoScalingTriggerThread-74093529225232390-127.0.0.1:46254_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and 
.scheduled_maintenance triggers
   [junit4]   2> 811635 INFO  
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 811635 DEBUG 
(OverseerAutoScalingTriggerThread-74093529225232390-127.0.0.1:46254_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode 
version 1
   [junit4]   2> 811636 DEBUG 
(OverseerAutoScalingTriggerThread-74093529225232390-127.0.0.1:46254_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, 
lastZnodeVersion 0
   [junit4]   2> 811636 DEBUG 
(OverseerAutoScalingTriggerThread-74093529225232390-127.0.0.1:46254_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto 
znodeVersion 1
   [junit4]   2> 811636 INFO  (zkCallback-1717-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 811667 DEBUG 
(OverseerAutoScalingTriggerThread-74093529225232390-127.0.0.1:46254_solr-n_0000000000)
 [    ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial 
livenodes: [127.0.0.1:46254_solr]
   [junit4]   2> 811668 DEBUG (ScheduledTrigger-2251-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1 and last live nodes: 1
   [junit4]   2> 811698 DEBUG 
(OverseerAutoScalingTriggerThread-74093529225232390-127.0.0.1:46254_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread -- cleaning old nodeLost / nodeAdded 
markers
   [junit4]   2> 811699 DEBUG 
(OverseerAutoScalingTriggerThread-74093529225232390-127.0.0.1:46254_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, 
lastZnodeVersion 1
   [junit4]   2> 811714 INFO  (jetty-launcher-1689-thread-1) 
[n:127.0.0.1:46254_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 811715 INFO  (jetty-launcher-1689-thread-2) 
[n:127.0.0.1:36118_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 811786 INFO  (jetty-launcher-1689-thread-2) 
[n:127.0.0.1:36118_solr    ] o.a.s.c.ZkController Publish 
node=127.0.0.1:36118_solr as DOWN
   [junit4]   2> 811786 INFO  (jetty-launcher-1689-thread-2) 
[n:127.0.0.1:36118_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 811787 INFO  (jetty-launcher-1689-thread-2) 
[n:127.0.0.1:36118_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:36118_solr
   [junit4]   2> 811812 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:36118_solr"} current state version: 0
   [junit4]   2> 811812 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.NodeMutator DownNode state invoked for 
node: 127.0.0.1:36118_solr
   [junit4]   2> 811814 INFO  (zkCallback-1702-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 811814 INFO  (zkCallback-1717-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 811849 INFO  (jetty-launcher-1689-thread-1) 
[n:127.0.0.1:46254_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_46254.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@128a7d48
   [junit4]   2> 811885 INFO  (zkCallback-1710-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 811885 INFO  (jetty-launcher-1689-thread-1) 
[n:127.0.0.1:46254_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_46254.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@128a7d48
   [junit4]   2> 811885 INFO  (jetty-launcher-1689-thread-1) 
[n:127.0.0.1:46254_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_46254.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@128a7d48
   [junit4]   2> 811886 INFO  (jetty-launcher-1689-thread-1) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_DC6FBEBE97287ADA-001/tempDir-001/node1/.
   [junit4]   2> 812044 INFO  (zkConnectionManagerCallback-1724-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 812058 INFO  (jetty-launcher-1689-thread-2) 
[n:127.0.0.1:36118_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 812124 INFO  (jetty-launcher-1689-thread-2) 
[n:127.0.0.1:36118_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:37965/solr ready
   [junit4]   2> 812140 INFO  (jetty-launcher-1689-thread-2) 
[n:127.0.0.1:36118_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 812202 INFO  (jetty-launcher-1689-thread-2) 
[n:127.0.0.1:36118_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_36118.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@128a7d48
   [junit4]   2> 812239 INFO  (jetty-launcher-1689-thread-2) 
[n:127.0.0.1:36118_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_36118.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@128a7d48
   [junit4]   2> 812239 INFO  (jetty-launcher-1689-thread-2) 
[n:127.0.0.1:36118_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_36118.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@128a7d48
   [junit4]   2> 812240 INFO  (jetty-launcher-1689-thread-2) 
[n:127.0.0.1:36118_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_DC6FBEBE97287ADA-001/tempDir-001/node2/.
   [junit4]   2> 812379 INFO  (zkConnectionManagerCallback-1730-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 812397 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[DC6FBEBE97287ADA]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 812412 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[DC6FBEBE97287ADA]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:37965/solr ready
   [junit4]   2> 812431 INFO  (qtp1967697770-6542) [n:127.0.0.1:46254_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
name=.system&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:46254_solr&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 812488 INFO  
(OverseerThreadFactory-2253-thread-1-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
.system
   [junit4]   2> 812507 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "name":".system",
   [junit4]   2>   "fromApi":"true",
   [junit4]   2>   "numShards":1,
   [junit4]   2>   "createNodeSet":"127.0.0.1:46254_solr",
   [junit4]   2>   "nrtReplicas":"1",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "replicationFactor":"1",
   [junit4]   2>   "operation":"create"} current state version: 0
   [junit4]   2> 812508 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.ClusterStateMutator building a new 
cName: .system
   [junit4]   2> 812508 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/.system/state.json
   [junit4]   2> 812620 DEBUG 
(OverseerThreadFactory-2253-thread-1-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.s.c.a.PolicyHelper Creating a new session
   [junit4]   2> 812634 INFO  (qtp1967697770-6544) [n:127.0.0.1:46254_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 812635 INFO  (qtp1967697770-6544) [n:127.0.0.1:46254_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 812636 INFO  (qtp1967697770-6544) [n:127.0.0.1:46254_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 812651 INFO  (qtp1967697770-6544) [n:127.0.0.1:46254_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=14
   [junit4]   2> 812652 INFO  (qtp1967697770-6544) [n:127.0.0.1:46254_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 812654 INFO  (qtp894338431-6553) [n:127.0.0.1:36118_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 812691 DEBUG (ScheduledTrigger-2251-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2 and last live nodes: 1
   [junit4]   2> 812692 INFO  (qtp894338431-6554) [n:127.0.0.1:36118_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 812693 INFO  (qtp894338431-6555) [n:127.0.0.1:36118_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 812694 INFO  (qtp894338431-6556) [n:127.0.0.1:36118_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 812711 INFO  (qtp894338431-6552) [n:127.0.0.1:36118_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 812727 DEBUG 
(OverseerThreadFactory-2253-thread-1-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.s.c.a.PolicyHelper New session created 
   [junit4]   2> 812784 DEBUG 
(OverseerThreadFactory-2253-thread-1-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.s.c.a.PolicyHelper returnSession, 
curr-time 31065908838 sessionWrapper.createTime 31065908781740086, 
this.sessionWrapper.createTime 31065908781740086 
   [junit4]   2> 812858 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_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":"http://127.0.0.1:46254/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 812858 INFO  
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_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":"http://127.0.0.1:46254/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 812905 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{}}
   [junit4]   2> 812905 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_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":"http://127.0.0.1:46254/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 813035 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 0
   [junit4]   2> 813149 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_solr    
x:.system_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node2&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 813150 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_solr    
x:.system_shard1_replica_n1] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 813262 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_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":"http://127.0.0.1:46254/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:46254_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 813262 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_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":"http://127.0.0.1:46254/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:46254_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 813262 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.ReplicaMutator Will update state for 
replica: 
core_node2:{"core":".system_shard1_replica_n1","base_url":"http://127.0.0.1:46254/solr","node_name":"127.0.0.1:46254_solr","state":"down","type":"NRT","force_set_state":"false"}
   [junit4]   2> 813262 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_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":"http://127.0.0.1:46254/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:46254_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false"}}}}}
   [junit4]   2> 813372 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 1
   [junit4]   2> 813773 DEBUG (ScheduledTrigger-2251-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 814408 WARN  (qtp1967697770-6538) [n:127.0.0.1:46254_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrConfig 
You should not use LATEST as luceneMatchVersion property: if you use this 
setting, and then Solr upgrades to a newer release of Lucene, sizable changes 
may happen. If precise back compatibility is important then you should instead 
explicitly specify an actual Lucene version.
   [junit4]   2> 814426 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 9.0.0
   [junit4]   2> 814443 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_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> 814479 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_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> 814516 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_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> 814550 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_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> 814552 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_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> 814552 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_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> 814552 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_46254.solr.core..system.shard1.replica_n1' (registry 
'solr.core..system.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@128a7d48
   [junit4]   2> 814552 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrCore 
[[.system_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_DC6FBEBE97287ADA-001/tempDir-001/node1/.system_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_DC6FBEBE97287ADA-001/tempDir-001/node1/./.system_shard1_replica_n1/data/]
   [junit4]   2> 814789 DEBUG (ScheduledTrigger-2251-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 815045 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_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> 815045 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_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> 815047 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.u.CommitTracker Hard AutoCommit: if 1 uncommitted docs; 
   [junit4]   2> 815047 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 815061 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@38f3f94f[.system_shard1_replica_n1] 
main]
   [junit4]   2> 815062 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_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> 815063 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_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> 815063 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_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> 815063 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_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> 815063 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_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> 815064 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_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 
1623959546291552256
   [junit4]   2> 815083 INFO  
(searcherExecutor-2262-thread-1-processing-n:127.0.0.1:46254_solr 
x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node2) 
[n:127.0.0.1:46254_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@38f3f94f[.system_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 815098 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/.system/terms/shard1 to Terms{values={core_node2=0}, version=0}
   [junit4]   2> 815098 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/.system/leaders/shard1
   [junit4]   2> 815101 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_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> 815101 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_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> 815101 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:46254/solr/.system_shard1_replica_n1/
   [junit4]   2> 815118 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_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> 815118 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.c.SyncStrategy http://127.0.0.1:46254/solr/.system_shard1_replica_n1/ has 
no replicas
   [junit4]   2> 815118 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/.system/leaders/shard1/leader after winning as 
/collections/.system/leader_elect/shard1/election/74093529225232390-core_node2-n_0000000000
   [junit4]   2> 815120 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:46254/solr/.system_shard1_replica_n1/ shard1
   [junit4]   2> 815120 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_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":"http://127.0.0.1:46254/solr";,
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "state":"active"} current state version: 0
   [junit4]   2> 815221 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 2
   [junit4]   2> 815223 INFO  (zkCallback-1702-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] 
for collection [.system] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 815223 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_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> 815289 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_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=2140
   [junit4]   2> 815296 INFO  (zkCallback-1702-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] 
for collection [.system] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 815296 DEBUG 
(OverseerThreadFactory-2253-thread-1-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.s.c.a.PolicyHelper session set to NULL
   [junit4]   2> 815317 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_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":"http://127.0.0.1:46254/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:46254_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 815318 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_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":"http://127.0.0.1:46254/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:46254_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 815318 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.ReplicaMutator Will update state for 
replica: 
core_node2:{"core":".system_shard1_replica_n1","base_url":"http://127.0.0.1:46254/solr","node_name":"127.0.0.1:46254_solr","state":"active","type":"NRT","force_set_state":"false","leader":"true"}
   [junit4]   2> 815318 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_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":"http://127.0.0.1:46254/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:46254_solr",
   [junit4]   2>           "state":"active",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false",
   [junit4]   2>           "leader":"true"}}}}}
   [junit4]   2> 815354 INFO  (qtp1967697770-6542) [n:127.0.0.1:46254_solr    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
45 seconds. Check all shard replicas
   [junit4]   2> 815418 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 3
   [junit4]   2> 815424 INFO  (zkCallback-1702-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] 
for collection [.system] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 815424 INFO  (zkCallback-1702-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] 
for collection [.system] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 815438 INFO  (zkCallback-1702-thread-3) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] 
for collection [.system] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 815445 INFO  (qtp1967697770-6542) [n:127.0.0.1:46254_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={name=.system&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:46254_solr&wt=javabin&version=2}
 status=0 QTime=3014
   [junit4]   2> 815460 INFO  (qtp1967697770-6541) [n:127.0.0.1:46254_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
maxShardsPerNode=3&name=AutoscalingHistoryHandlerTest_collection&nrtReplicas=3&action=CREATE&numShards=1&createNodeSet=127.0.0.1:36118_solr&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 815481 INFO  
(OverseerCollectionConfigSetProcessor-74093529225232390-127.0.0.1:46254_solr-n_0000000000)
 [n:127.0.0.1:46254_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> 815482 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
AutoscalingHistoryHandlerTest_collection
   [junit4]   2> 815483 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/protwords.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/protwords.txt
   [junit4]   2> 815484 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/managed-schema to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/managed-schema
   [junit4]   2> 815485 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/solrconfig.xml to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/solrconfig.xml
   [junit4]   2> 815507 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/synonyms.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/synonyms.txt
   [junit4]   2> 815508 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/stopwords.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/stopwords.txt
   [junit4]   2> 815509 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/params.json to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/params.json
   [junit4]   2> 815523 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815524 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815526 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815544 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815545 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815655 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815685 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815687 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815688 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815689 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815690 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815691 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815692 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815711 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815712 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815716 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815738 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815743 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815779 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815795 DEBUG (ScheduledTrigger-2251-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 815801 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815816 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815831 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815834 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815846 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815861 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815863 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815878 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815893 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815894 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815910 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815925 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815926 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815928 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815956 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815981 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815983 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 815998 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 816010 INFO  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_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> 816022 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "name":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "fromApi":"true",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "maxShardsPerNode":"3",
   [junit4]   2>   "createNodeSet":"127.0.0.1:36118_solr",
   [junit4]   2>   "nrtReplicas":"3",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "replicationFactor":"3",
   [junit4]   2>   "operation":"create"} current state version: 0
   [junit4]   2> 816023 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.ClusterStateMutator building a new 
cName: AutoscalingHistoryHandlerTest_collection
   [junit4]   2> 816131 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/AutoscalingHistoryHandlerTest_collection/state.json
   [junit4]   2> 816245 WARN  
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.a.c.CreateCollectionCmd Specified number 
of replicas of 3 on collection AutoscalingHistoryHandlerTest_collection is 
higher than the number of Solr instances currently live or live and part of 
your createNodeSet(1). It's unusual to run two replica of the same slice on the 
same Solr-instance.
   [junit4]   2> 816245 DEBUG 
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.s.c.a.PolicyHelper Creating a new session
   [junit4]   2> 816341 INFO  (qtp1967697770-6543) [n:127.0.0.1:46254_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core..system.shard1.replica_n1:INDEX.sizeInBytes}
 status=0 QTime=73
   [junit4]   2> 816342 INFO  (qtp1967697770-6544) [n:127.0.0.1:46254_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core..system.shard1.replica_n1:INDEX.sizeInBytes}
 status=0 QTime=0
   [junit4]   2> 816343 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core..system.shard1.replica_n1:INDEX.sizeInBytes}
 status=0 QTime=0
   [junit4]   2> 816344 INFO  (qtp1967697770-6542) [n:127.0.0.1:46254_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 816358 INFO  (qtp1967697770-6543) [n:127.0.0.1:46254_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 816359 INFO  (qtp1967697770-6544) [n:127.0.0.1:46254_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 816360 INFO  (qtp1967697770-6538) [n:127.0.0.1:46254_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 816361 INFO  (qtp1967697770-6542) [n:127.0.0.1:46254_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 816363 INFO  (qtp894338431-6553) [n:127.0.0.1:36118_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 816363 INFO  (qtp894338431-6554) [n:127.0.0.1:36118_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 816364 INFO  (qtp894338431-6555) [n:127.0.0.1:36118_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 816365 INFO  (qtp894338431-6556) [n:127.0.0.1:36118_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 816382 INFO  (qtp894338431-6552) [n:127.0.0.1:36118_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 816383 DEBUG 
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.s.c.a.PolicyHelper New session created 
   [junit4]   2> 816471 DEBUG 
(OverseerThreadFactory-2253-thread-2-processing-n:127.0.0.1:46254_solr) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.s.c.a.PolicyHelper returnSession, 
curr-time 31065912525 sessionWrapper.createTime 31065912437104996, 
this.sessionWrapper.createTime 31065912437104996 
   [junit4]   2> 816488 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_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":"http://127.0.0.1:36118/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 816488 INFO  
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_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":"http://127.0.0.1:36118/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 816490 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{}}
   [junit4]   2> 816490 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.SliceMutator New Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{"core_node3":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "base_url":"http://127.0.0.1:36118/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 816504 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.Overseer processMessage: queueSize: 2, 
message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:36118/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 816504 INFO  
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_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":"http://127.0.0.1:36118/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 816520 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{"core_node3":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "base_url":"http://127.0.0.1:36118/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 816520 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.SliceMutator New Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{
   [junit4]   2>     "core_node3":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "base_url":"http://127.0.0.1:36118/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":"http://127.0.0.1:36118/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 816537 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.Overseer processMessage: queueSize: 3, 
message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:36118/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 816537 INFO  
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:36118/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 816539 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{
   [junit4]   2>     "core_node3":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "base_url":"http://127.0.0.1:36118/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":"http://127.0.0.1:36118/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 816539 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.SliceMutator New Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{
   [junit4]   2>     "core_node3":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "base_url":"http://127.0.0.1:36118/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":"http://127.0.0.1:36118/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node6":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>       "base_url":"http://127.0.0.1:36118/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 816652 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/AutoscalingHistoryHandlerTest_collection/state.json version: 0
   [junit4]   2> 816740 INFO  (qtp894338431-6553) [n:127.0.0.1:36118_solr    
x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 816750 INFO  (qtp894338431-6552) [n:127.0.0.1:36118_solr    
x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] 
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> 816771 INFO  (qtp894338431-6556) [n:127.0.0.1:36118_solr    
x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n4] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node6&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n4&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 816783 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>   "core_node_name":"core_node6",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:36118/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:36118_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 816783 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>   "core_node_name":"core_node6",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:36118/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:36118_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 816783 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.ReplicaMutator Will update state for 
replica: 
core_node6:{"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4","base_url":"http://127.0.0.1:36118/solr","node_name":"127.0.0.1:36118_solr","state":"down","type":"NRT","force_set_state":"false"}
   [junit4]   2> 816783 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.ReplicaMutator Collection is now: 
DocCollection(AutoscalingHistoryHandlerTest_collection//collections/AutoscalingHistoryHandlerTest_collection/state.json/1)={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"3",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"3",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"3",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "shards":{"shard1":{
   [junit4]   2>       "range":"80000000-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node3":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>           "base_url":"http://127.0.0.1:36118/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":"http://127.0.0.1:36118/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":null,
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node6":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>           "base_url":"http://127.0.0.1:36118/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:36118_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false"}}}}}
   [junit4]   2> 816789 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.Overseer processMessage: queueSize: 3, 
message = {
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>   "core_node_name":"core_node5",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:36118/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:36118_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 816789 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_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":"http://127.0.0.1:36118/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:36118_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 816789 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.ReplicaMutator Will update state for 
replica: 
core_node5:{"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2","base_url":"http://127.0.0.1:36118/solr","node_name":"127.0.0.1:36118_solr","state":"down","type":"NRT","force_set_state":"false"}
   [junit4]   2> 816789 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.ReplicaMutator Collection is now: 
DocCollection(AutoscalingHistoryHandlerTest_collection//collections/AutoscalingHistoryHandlerTest_collection/state.json/1)={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"3",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"3",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"3",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "shards":{"shard1":{
   [junit4]   2>       "range":"80000000-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node3":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>           "base_url":"http://127.0.0.1:36118/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":"http://127.0.0.1:36118/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:36118_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false"},
   [junit4]   2>         "core_node6":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>           "base_url":"http://127.0.0.1:36118/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:36118_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false"}}}}}
   [junit4]   2> 816790 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.Overseer processMessage: queueSize: 3, 
message = {
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node3",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:36118/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:36118_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 816790 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node3",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:36118/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:36118_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 816790 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.ReplicaMutator Will update state for 
replica: 
core_node3:{"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1","base_url":"http://127.0.0.1:36118/solr","node_name":"127.0.0.1:36118_solr","state":"down","type":"NRT","force_set_state":"false"}
   [junit4]   2> 816790 DEBUG 
(OverseerStateUpdate-74093529225232390-127.0.0.1:46254_solr-n_0000000000) 
[n:127.0.0.1:46254_solr    ] o.a.s.c.o.ReplicaMutator Collection is now: 
DocCollection(AutoscalingHistoryHandlerTest_collection//collections/AutoscalingHistoryHandlerTest_collection/state.json/1)={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"3",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"3",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"3",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "shards":{"shard1":{
   [junit4]   2>       "range":"80000000-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node3":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>           "base_url":"http://127.0.0.1:36118/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:36118_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false"},
   [junit4]   2>         "core_node5":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>           "base_url":"http://127.0.0.1:36118/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:36118_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"N

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

il:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml

resolve:

jar-checksums:
    [mkdir] Created dir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/null1878326964
     [copy] Copying 257 files to 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/null1878326964
   [delete] Deleting directory 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/null1878326964

check-working-copy:
[ivy:cachepath] :: resolving dependencies :: 
org.eclipse.jgit#org.eclipse.jgit-caller;working
[ivy:cachepath]         confs: [default]
[ivy:cachepath]         found 
org.eclipse.jgit#org.eclipse.jgit;4.6.0.201612231935-r in public
[ivy:cachepath]         found com.jcraft#jsch;0.1.53 in public
[ivy:cachepath]         found com.googlecode.javaewah#JavaEWAH;1.1.6 in public
[ivy:cachepath]         found org.apache.httpcomponents#httpclient;4.3.6 in 
public
[ivy:cachepath]         found org.apache.httpcomponents#httpcore;4.3.3 in public
[ivy:cachepath]         found commons-logging#commons-logging;1.1.3 in public
[ivy:cachepath]         found commons-codec#commons-codec;1.6 in public
[ivy:cachepath]         found org.slf4j#slf4j-api;1.7.2 in public
[ivy:cachepath] :: resolution report :: resolve 23ms :: artifacts dl 1ms
        ---------------------------------------------------------------------
        |                  |            modules            ||   artifacts   |
        |       conf       | number| search|dwnlded|evicted|| number|dwnlded|
        ---------------------------------------------------------------------
        |      default     |   8   |   0   |   0   |   0   ||   8   |   0   |
        ---------------------------------------------------------------------
[wc-checker] Initializing working copy...
[wc-checker] SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
[wc-checker] SLF4J: Defaulting to no-operation (NOP) logger implementation
[wc-checker] SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for 
further details.
[wc-checker] Checking working copy status...

-jenkins-base:

BUILD SUCCESSFUL
Total time: 180 minutes 41 seconds
Archiving artifacts
java.lang.InterruptedException: no matches found within 10000
        at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:2847)
        at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2726)
        at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2707)
        at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3086)
Also:   hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene2
                at 
hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1741)
                at 
hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:357)
                at hudson.remoting.Channel.call(Channel.java:955)
                at hudson.FilePath.act(FilePath.java:1072)
                at hudson.FilePath.act(FilePath.java:1061)
                at hudson.FilePath.validateAntFileMask(FilePath.java:2705)
                at 
hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
                at 
hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
                at 
hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
                at 
hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
                at 
hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
                at hudson.model.Build$BuildExecution.post2(Build.java:186)
                at 
hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
                at hudson.model.Run.execute(Run.java:1835)
                at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
                at 
hudson.model.ResourceController.execute(ResourceController.java:97)
                at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
        at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3088)
        at hudson.remoting.UserRequest.perform(UserRequest.java:212)
        at hudson.remoting.UserRequest.perform(UserRequest.java:54)
        at hudson.remoting.Request$2.run(Request.java:369)
        at 
hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:748)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no 
matches found within 10000
        at hudson.FilePath.act(FilePath.java:1074)
        at hudson.FilePath.act(FilePath.java:1061)
        at hudson.FilePath.validateAntFileMask(FilePath.java:2705)
        at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
        at 
hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
        at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
        at 
hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
        at 
hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
        at hudson.model.Build$BuildExecution.post2(Build.java:186)
        at 
hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
        at hudson.model.Run.execute(Run.java:1835)
        at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
        at hudson.model.ResourceController.execute(ResourceController.java:97)
        at hudson.model.Executor.run(Executor.java:429)
No artifacts found that match the file pattern 
"**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
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: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to