Build: https://builds.apache.org/job/Lucene-Solr-Tests-8.x/170/

2 tests failed.
FAILED:  
org.apache.solr.update.processor.CategoryRoutedAliasUpdateProcessorTest.testSliceRouting

Error Message:
Test abandoned because suite timeout was reached.

Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
        at __randomizedtesting.SeedInfo.seed([14F3A3B69EFF36C1]:0)


FAILED:  
junit.framework.TestSuite.org.apache.solr.update.processor.CategoryRoutedAliasUpdateProcessorTest

Error Message:
Suite timeout exceeded (>= 7200000 msec).

Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
        at __randomizedtesting.SeedInfo.seed([14F3A3B69EFF36C1]:0)




Build Log:
[...truncated 15865 lines...]
   [junit4] Suite: 
org.apache.solr.update.processor.CategoryRoutedAliasUpdateProcessorTest
   [junit4]   2> 1278348 INFO  
(SUITE-CategoryRoutedAliasUpdateProcessorTest-seed#[14F3A3B69EFF36C1]-worker) [ 
   ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/init-core-data-001
   [junit4]   2> 1278349 WARN  
(SUITE-CategoryRoutedAliasUpdateProcessorTest-seed#[14F3A3B69EFF36C1]-worker) [ 
   ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=175 numCloses=175
   [junit4]   2> 1278349 INFO  
(SUITE-CategoryRoutedAliasUpdateProcessorTest-seed#[14F3A3B69EFF36C1]-worker) [ 
   ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1278351 INFO  
(SUITE-CategoryRoutedAliasUpdateProcessorTest-seed#[14F3A3B69EFF36C1]-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> 1278354 INFO  
(TEST-CategoryRoutedAliasUpdateProcessorTest.test-seed#[14F3A3B69EFF36C1]) [    
] o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 1278354 INFO  
(TEST-CategoryRoutedAliasUpdateProcessorTest.test-seed#[14F3A3B69EFF36C1]) [    
] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001
   [junit4]   2> 1278355 INFO  
(TEST-CategoryRoutedAliasUpdateProcessorTest.test-seed#[14F3A3B69EFF36C1]) [    
] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1278355 INFO  (ZkTestServer Run Thread) [    ] 
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1278355 INFO  (ZkTestServer Run Thread) [    ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1278455 INFO  
(TEST-CategoryRoutedAliasUpdateProcessorTest.test-seed#[14F3A3B69EFF36C1]) [    
] o.a.s.c.ZkTestServer start zk server on port:36122
   [junit4]   2> 1278455 INFO  
(TEST-CategoryRoutedAliasUpdateProcessorTest.test-seed#[14F3A3B69EFF36C1]) [    
] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:36122
   [junit4]   2> 1278455 INFO  
(TEST-CategoryRoutedAliasUpdateProcessorTest.test-seed#[14F3A3B69EFF36C1]) [    
] o.a.s.c.ZkTestServer connecting to 127.0.0.1 36122
   [junit4]   2> 1278479 INFO  (zkConnectionManagerCallback-9486-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1278489 INFO  (zkConnectionManagerCallback-9488-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1278491 INFO  (zkConnectionManagerCallback-9490-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1278493 WARN  (jetty-launcher-9491-thread-1) [    ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 1278494 INFO  (jetty-launcher-9491-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 1278494 INFO  (jetty-launcher-9491-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 1278494 INFO  (jetty-launcher-9491-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> 1278495 WARN  (jetty-launcher-9491-thread-2) [    ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 1278495 INFO  (jetty-launcher-9491-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 1278495 INFO  (jetty-launcher-9491-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 1278495 WARN  (jetty-launcher-9491-thread-4) [    ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 1278495 INFO  (jetty-launcher-9491-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> 1278495 INFO  (jetty-launcher-9491-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 1278495 INFO  (jetty-launcher-9491-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 1278495 INFO  (jetty-launcher-9491-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1278495 INFO  (jetty-launcher-9491-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1278496 INFO  (jetty-launcher-9491-thread-4) [    ] 
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> 1278496 WARN  (jetty-launcher-9491-thread-3) [    ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 1278496 INFO  (jetty-launcher-9491-thread-1) [    ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1278496 INFO  (jetty-launcher-9491-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 1278496 INFO  (jetty-launcher-9491-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 1278496 INFO  (jetty-launcher-9491-thread-3) [    ] 
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> 1278498 INFO  (jetty-launcher-9491-thread-4) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1278498 INFO  (jetty-launcher-9491-thread-4) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1278498 INFO  (jetty-launcher-9491-thread-4) [    ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1278498 INFO  (jetty-launcher-9491-thread-4) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3891170a{/solr,null,AVAILABLE}
   [junit4]   2> 1278500 INFO  (jetty-launcher-9491-thread-2) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1278500 INFO  (jetty-launcher-9491-thread-2) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1278500 INFO  (jetty-launcher-9491-thread-2) [    ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1278500 INFO  (jetty-launcher-9491-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@70f4845f{/solr,null,AVAILABLE}
   [junit4]   2> 1278501 INFO  (jetty-launcher-9491-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1f4a243c{/solr,null,AVAILABLE}
   [junit4]   2> 1278501 INFO  (jetty-launcher-9491-thread-4) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@1f7bd77d{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:42644}
   [junit4]   2> 1278501 INFO  (jetty-launcher-9491-thread-4) [    ] 
o.e.j.s.Server Started @1278691ms
   [junit4]   2> 1278501 INFO  (jetty-launcher-9491-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=42644}
   [junit4]   2> 1278501 INFO  (jetty-launcher-9491-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@3080046d{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:44146}
   [junit4]   2> 1278501 INFO  (jetty-launcher-9491-thread-1) [    ] 
o.e.j.s.Server Started @1278691ms
   [junit4]   2> 1278501 ERROR (jetty-launcher-9491-thread-4) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1278501 INFO  (jetty-launcher-9491-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1278501 INFO  (jetty-launcher-9491-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=44146}
   [junit4]   2> 1278501 INFO  (jetty-launcher-9491-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.1.0
   [junit4]   2> 1278501 INFO  (jetty-launcher-9491-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1278501 INFO  (jetty-launcher-9491-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1278501 INFO  (jetty-launcher-9491-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-04-27T00:37:15.302Z
   [junit4]   2> 1278501 ERROR (jetty-launcher-9491-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1278501 INFO  (jetty-launcher-9491-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1278502 INFO  (jetty-launcher-9491-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.1.0
   [junit4]   2> 1278502 INFO  (jetty-launcher-9491-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1278502 INFO  (jetty-launcher-9491-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1278502 INFO  (jetty-launcher-9491-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-04-27T00:37:15.303Z
   [junit4]   2> 1278503 INFO  (jetty-launcher-9491-thread-2) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@5708b816{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:38739}
   [junit4]   2> 1278503 INFO  (jetty-launcher-9491-thread-2) [    ] 
o.e.j.s.Server Started @1278692ms
   [junit4]   2> 1278503 INFO  (jetty-launcher-9491-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=38739}
   [junit4]   2> 1278503 ERROR (jetty-launcher-9491-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1278503 INFO  (jetty-launcher-9491-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1278503 INFO  (jetty-launcher-9491-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.1.0
   [junit4]   2> 1278503 INFO  (jetty-launcher-9491-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1278503 INFO  (jetty-launcher-9491-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1278503 INFO  (jetty-launcher-9491-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-04-27T00:37:15.304Z
   [junit4]   2> 1278508 INFO  (jetty-launcher-9491-thread-3) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1278508 INFO  (jetty-launcher-9491-thread-3) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1278508 INFO  (jetty-launcher-9491-thread-3) [    ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1278508 INFO  (jetty-launcher-9491-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@c0f0282{/solr,null,AVAILABLE}
   [junit4]   2> 1278510 INFO  (zkConnectionManagerCallback-9497-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1278510 INFO  (jetty-launcher-9491-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1278519 INFO  (jetty-launcher-9491-thread-3) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@32bd99e3{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:44492}
   [junit4]   2> 1278519 INFO  (jetty-launcher-9491-thread-3) [    ] 
o.e.j.s.Server Started @1278709ms
   [junit4]   2> 1278519 INFO  (zkConnectionManagerCallback-9495-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1278519 INFO  (jetty-launcher-9491-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=44492}
   [junit4]   2> 1278519 INFO  (zkConnectionManagerCallback-9493-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1278519 ERROR (jetty-launcher-9491-thread-3) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1278519 INFO  (jetty-launcher-9491-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1278519 INFO  (jetty-launcher-9491-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.1.0
   [junit4]   2> 1278519 INFO  (jetty-launcher-9491-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1278519 INFO  (jetty-launcher-9491-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1278519 INFO  (jetty-launcher-9491-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-04-27T00:37:15.320Z
   [junit4]   2> 1278520 INFO  (jetty-launcher-9491-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1278523 INFO  (jetty-launcher-9491-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1278563 INFO  (zkConnectionManagerCallback-9499-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1278563 INFO  (jetty-launcher-9491-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1278621 INFO  (jetty-launcher-9491-thread-4) [    ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1278623 WARN  (jetty-launcher-9491-thread-4) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@7f64b6e[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1278627 WARN  (jetty-launcher-9491-thread-4) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@21575742[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1278628 INFO  (jetty-launcher-9491-thread-4) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36122/solr
   [junit4]   2> 1278636 INFO  (zkConnectionManagerCallback-9509-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1278639 INFO  (zkConnectionManagerCallback-9511-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1278668 INFO  (jetty-launcher-9491-thread-2) [    ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1278669 WARN  (jetty-launcher-9491-thread-2) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@3686a759[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1278674 WARN  (jetty-launcher-9491-thread-2) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@5ca8994[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1278675 INFO  (jetty-launcher-9491-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36122/solr
   [junit4]   2> 1278695 INFO  (zkConnectionManagerCallback-9519-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1278708 INFO  (zkConnectionManagerCallback-9521-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1278735 INFO  (jetty-launcher-9491-thread-2) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:38739_solr
   [junit4]   2> 1278737 INFO  (jetty-launcher-9491-thread-2) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.Overseer Overseer 
(id=73201864842280970-127.0.0.1:38739_solr-n_0000000000) starting
   [junit4]   2> 1278742 INFO  (jetty-launcher-9491-thread-3) [    ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1278744 WARN  (jetty-launcher-9491-thread-3) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@3c38f650[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1278749 INFO  (zkConnectionManagerCallback-9530-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1278749 WARN  (jetty-launcher-9491-thread-3) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@8337147[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1278750 INFO  (jetty-launcher-9491-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36122/solr
   [junit4]   2> 1278752 INFO  (zkConnectionManagerCallback-9534-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1278753 INFO  (jetty-launcher-9491-thread-2) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:36122/solr ready
   [junit4]   2> 1278755 INFO  (jetty-launcher-9491-thread-2) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:38739_solr
   [junit4]   2> 1278758 INFO  (zkConnectionManagerCallback-9536-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1278759 INFO  (zkCallback-9529-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1278759 INFO  
(OverseerStateUpdate-73201864842280970-127.0.0.1:38739_solr-n_0000000000) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:38739_solr
   [junit4]   2> 1278768 INFO  
(OverseerStateUpdate-73201864842280970-127.0.0.1:38739_solr-n_0000000000) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1278780 INFO  (jetty-launcher-9491-thread-3) 
[n:127.0.0.1:44492_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1278786 INFO  (jetty-launcher-9491-thread-4) 
[n:127.0.0.1:42644_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1278789 INFO  (jetty-launcher-9491-thread-3) 
[n:127.0.0.1:44492_solr    ] o.a.s.c.ZkController Publish 
node=127.0.0.1:44492_solr as DOWN
   [junit4]   2> 1278791 INFO  (jetty-launcher-9491-thread-3) 
[n:127.0.0.1:44492_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1278791 INFO  (jetty-launcher-9491-thread-3) 
[n:127.0.0.1:44492_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:44492_solr
   [junit4]   2> 1278791 INFO  (jetty-launcher-9491-thread-2) 
[n:127.0.0.1:38739_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1278794 INFO  (jetty-launcher-9491-thread-4) 
[n:127.0.0.1:42644_solr    ] o.a.s.c.ZkController Publish 
node=127.0.0.1:42644_solr as DOWN
   [junit4]   2> 1278794 INFO  (zkCallback-9529-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1278795 INFO  (zkCallback-9520-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1278795 INFO  (zkCallback-9510-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1278796 INFO  (zkCallback-9535-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1278796 INFO  (jetty-launcher-9491-thread-4) 
[n:127.0.0.1:42644_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1278796 INFO  (jetty-launcher-9491-thread-4) 
[n:127.0.0.1:42644_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:42644_solr
   [junit4]   2> 1278804 INFO  (zkCallback-9520-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1278804 INFO  (zkCallback-9529-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1278804 INFO  (zkCallback-9510-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1278815 INFO  (zkCallback-9535-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1278820 INFO  (jetty-launcher-9491-thread-1) [    ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1278824 WARN  (jetty-launcher-9491-thread-1) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@ece5cad[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1278832 WARN  (jetty-launcher-9491-thread-1) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@32e95e14[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1278834 INFO  (jetty-launcher-9491-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36122/solr
   [junit4]   2> 1278837 INFO  (zkConnectionManagerCallback-9545-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1278838 INFO  (zkConnectionManagerCallback-9550-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1278839 INFO  (jetty-launcher-9491-thread-2) 
[n:127.0.0.1:38739_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38739.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
   [junit4]   2> 1278840 INFO  (jetty-launcher-9491-thread-3) 
[n:127.0.0.1:44492_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 1278841 INFO  (zkConnectionManagerCallback-9552-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1278842 INFO  (jetty-launcher-9491-thread-3) 
[n:127.0.0.1:44492_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:36122/solr ready
   [junit4]   2> 1278842 INFO  (jetty-launcher-9491-thread-3) 
[n:127.0.0.1:44492_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1278848 INFO  (zkConnectionManagerCallback-9558-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1278850 INFO  (jetty-launcher-9491-thread-4) 
[n:127.0.0.1:42644_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 1278852 INFO  (jetty-launcher-9491-thread-4) 
[n:127.0.0.1:42644_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:36122/solr ready
   [junit4]   2> 1278852 INFO  (jetty-launcher-9491-thread-1) 
[n:127.0.0.1:44146_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 1278852 INFO  (jetty-launcher-9491-thread-4) 
[n:127.0.0.1:42644_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1278853 INFO  (jetty-launcher-9491-thread-2) 
[n:127.0.0.1:38739_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38739.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
   [junit4]   2> 1278853 INFO  (jetty-launcher-9491-thread-2) 
[n:127.0.0.1:38739_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38739.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
   [junit4]   2> 1278855 INFO  (jetty-launcher-9491-thread-2) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/.
   [junit4]   2> 1278856 INFO  (jetty-launcher-9491-thread-1) 
[n:127.0.0.1:44146_solr    ] o.a.s.c.ZkController Publish 
node=127.0.0.1:44146_solr as DOWN
   [junit4]   2> 1278858 INFO  (jetty-launcher-9491-thread-1) 
[n:127.0.0.1:44146_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1278858 INFO  (jetty-launcher-9491-thread-1) 
[n:127.0.0.1:44146_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:44146_solr
   [junit4]   2> 1278860 INFO  (zkCallback-9520-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1278860 INFO  (zkCallback-9510-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1278861 INFO  (zkCallback-9529-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1278861 INFO  (zkCallback-9535-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1278861 INFO  (zkCallback-9549-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1278862 INFO  (zkCallback-9557-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1278868 INFO  (zkCallback-9551-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1278887 INFO  (jetty-launcher-9491-thread-4) 
[n:127.0.0.1:42644_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42644.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
   [junit4]   2> 1278889 INFO  (jetty-launcher-9491-thread-3) 
[n:127.0.0.1:44492_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44492.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
   [junit4]   2> 1278890 INFO  (zkConnectionManagerCallback-9566-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1278891 INFO  (jetty-launcher-9491-thread-1) 
[n:127.0.0.1:44146_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (4)
   [junit4]   2> 1278893 INFO  (jetty-launcher-9491-thread-1) 
[n:127.0.0.1:44146_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:36122/solr ready
   [junit4]   2> 1278893 INFO  (jetty-launcher-9491-thread-1) 
[n:127.0.0.1:44146_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1278909 INFO  (jetty-launcher-9491-thread-4) 
[n:127.0.0.1:42644_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42644.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
   [junit4]   2> 1278910 INFO  (jetty-launcher-9491-thread-4) 
[n:127.0.0.1:42644_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42644.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
   [junit4]   2> 1278911 INFO  (jetty-launcher-9491-thread-4) 
[n:127.0.0.1:42644_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node3/.
   [junit4]   2> 1278914 INFO  (jetty-launcher-9491-thread-3) 
[n:127.0.0.1:44492_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44492.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
   [junit4]   2> 1278915 INFO  (jetty-launcher-9491-thread-3) 
[n:127.0.0.1:44492_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44492.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
   [junit4]   2> 1278916 INFO  (jetty-launcher-9491-thread-3) 
[n:127.0.0.1:44492_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node4/.
   [junit4]   2> 1278924 INFO  (jetty-launcher-9491-thread-1) 
[n:127.0.0.1:44146_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44146.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
   [junit4]   2> 1278940 INFO  (jetty-launcher-9491-thread-1) 
[n:127.0.0.1:44146_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44146.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
   [junit4]   2> 1278940 INFO  (jetty-launcher-9491-thread-1) 
[n:127.0.0.1:44146_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44146.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
   [junit4]   2> 1278942 INFO  (jetty-launcher-9491-thread-1) 
[n:127.0.0.1:44146_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node1/.
   [junit4]   2> 1279116 INFO  (zkConnectionManagerCallback-9572-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1279118 INFO  
(TEST-CategoryRoutedAliasUpdateProcessorTest.test-seed#[14F3A3B69EFF36C1]) [    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 1279119 INFO  
(TEST-CategoryRoutedAliasUpdateProcessorTest.test-seed#[14F3A3B69EFF36C1]) [    
] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36122/solr ready
   [junit4]   2> 1279120 INFO  
(TEST-CategoryRoutedAliasUpdateProcessorTest.test-seed#[14F3A3B69EFF36C1]) [    
] o.a.s.u.p.CategoryRoutedAliasUpdateProcessorTest SolrClient: 
org.apache.solr.client.solrj.impl.CloudSolrClient@7fa7eb35
   [junit4]   2> 1279120 INFO  
(TEST-CategoryRoutedAliasUpdateProcessorTest.test-seed#[14F3A3B69EFF36C1]) [    
] o.a.s.u.p.CategoryRoutedAliasUpdateProcessorTest ClusterStateProvider 
127.0.0.1:36122/solr
   [junit4]   2> 1279123 INFO  (zkConnectionManagerCallback-9577-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1279125 INFO  
(TEST-CategoryRoutedAliasUpdateProcessorTest.test-seed#[14F3A3B69EFF36C1]) [    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 1279126 INFO  
(TEST-CategoryRoutedAliasUpdateProcessorTest.test-seed#[14F3A3B69EFF36C1]) [    
] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36122/solr ready
   [junit4]   2> 1279128 INFO  (qtp284259657-25635) [n:127.0.0.1:38739_solr    
] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params 
baseConfigSet=_default&name=test&action=CREATE&wt=javabin&version=2 
   [junit4]   2> 1279131 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.OverseerConfigSetMessageHandler 
OverseerConfigSetMessageHandler.processMessage : create , {
   [junit4]   2>   "name":"test",
   [junit4]   2>   "baseConfigSet":"_default",
   [junit4]   2>   "immutable":"false",
   [junit4]   2>   "operation":"configsets:create"}
   [junit4]   2> 1279133 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/managed-schema to /configs/test/managed-schema
   [junit4]   2> 1279135 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/protwords.txt to /configs/test/protwords.txt
   [junit4]   2> 1279137 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/solrconfig.xml to /configs/test/solrconfig.xml
   [junit4]   2> 1279139 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/synonyms.txt to /configs/test/synonyms.txt
   [junit4]   2> 1279141 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/stopwords.txt to /configs/test/stopwords.txt
   [junit4]   2> 1279144 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_it.txt to 
/configs/test/lang/contractions_it.txt
   [junit4]   2> 1279146 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_ca.txt to 
/configs/test/lang/contractions_ca.txt
   [junit4]   2> 1279148 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stemdict_nl.txt to /configs/test/lang/stemdict_nl.txt
   [junit4]   2> 1279150 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_no.txt to /configs/test/lang/stopwords_no.txt
   [junit4]   2> 1279152 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_hy.txt to /configs/test/lang/stopwords_hy.txt
   [junit4]   2> 1279154 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_id.txt to /configs/test/lang/stopwords_id.txt
   [junit4]   2> 1279156 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_hi.txt to /configs/test/lang/stopwords_hi.txt
   [junit4]   2> 1279158 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ga.txt to /configs/test/lang/stopwords_ga.txt
   [junit4]   2> 1279160 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_da.txt to /configs/test/lang/stopwords_da.txt
   [junit4]   2> 1279162 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ja.txt to /configs/test/lang/stopwords_ja.txt
   [junit4]   2> 1279163 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_pt.txt to /configs/test/lang/stopwords_pt.txt
   [junit4]   2> 1279166 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_hu.txt to /configs/test/lang/stopwords_hu.txt
   [junit4]   2> 1279168 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_el.txt to /configs/test/lang/stopwords_el.txt
   [junit4]   2> 1279169 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ru.txt to /configs/test/lang/stopwords_ru.txt
   [junit4]   2> 1279171 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_tr.txt to /configs/test/lang/stopwords_tr.txt
   [junit4]   2> 1279173 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ar.txt to /configs/test/lang/stopwords_ar.txt
   [junit4]   2> 1279175 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/userdict_ja.txt to /configs/test/lang/userdict_ja.txt
   [junit4]   2> 1279177 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_eu.txt to /configs/test/lang/stopwords_eu.txt
   [junit4]   2> 1279179 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_it.txt to /configs/test/lang/stopwords_it.txt
   [junit4]   2> 1279181 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_cz.txt to /configs/test/lang/stopwords_cz.txt
   [junit4]   2> 1279183 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stoptags_ja.txt to /configs/test/lang/stoptags_ja.txt
   [junit4]   2> 1279185 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_fr.txt to 
/configs/test/lang/contractions_fr.txt
   [junit4]   2> 1279187 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_de.txt to /configs/test/lang/stopwords_de.txt
   [junit4]   2> 1279188 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_fa.txt to /configs/test/lang/stopwords_fa.txt
   [junit4]   2> 1279190 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_ga.txt to 
/configs/test/lang/contractions_ga.txt
   [junit4]   2> 1279192 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ca.txt to /configs/test/lang/stopwords_ca.txt
   [junit4]   2> 1279194 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_nl.txt to /configs/test/lang/stopwords_nl.txt
   [junit4]   2> 1279202 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_bg.txt to /configs/test/lang/stopwords_bg.txt
   [junit4]   2> 1279204 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_en.txt to /configs/test/lang/stopwords_en.txt
   [junit4]   2> 1279206 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_es.txt to /configs/test/lang/stopwords_es.txt
   [junit4]   2> 1279209 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_lv.txt to /configs/test/lang/stopwords_lv.txt
   [junit4]   2> 1279211 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ro.txt to /configs/test/lang/stopwords_ro.txt
   [junit4]   2> 1279213 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_th.txt to /configs/test/lang/stopwords_th.txt
   [junit4]   2> 1279215 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_fr.txt to /configs/test/lang/stopwords_fr.txt
   [junit4]   2> 1279217 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_sv.txt to /configs/test/lang/stopwords_sv.txt
   [junit4]   2> 1279219 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_fi.txt to /configs/test/lang/stopwords_fi.txt
   [junit4]   2> 1279221 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/hyphenations_ga.txt to 
/configs/test/lang/hyphenations_ga.txt
   [junit4]   2> 1279222 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_gl.txt to /configs/test/lang/stopwords_gl.txt
   [junit4]   2> 1279224 INFO  
(OverseerThreadFactory-7922-thread-1-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/params.json to /configs/test/params.json
   [junit4]   2> 1279227 INFO  (qtp284259657-25635) [n:127.0.0.1:38739_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/configs 
params={baseConfigSet=_default&name=test&action=CREATE&wt=javabin&version=2} 
status=0 QTime=99
   [junit4]   2> 1279228 INFO  (qtp284259657-25634) [n:127.0.0.1:38739_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
collection.configName=test&name=test&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1279233 INFO  
(OverseerThreadFactory-7922-thread-2-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
test
   [junit4]   2> 1279233 INFO  
(OverseerCollectionConfigSetProcessor-73201864842280970-127.0.0.1:38739_solr-n_0000000000)
 [n:127.0.0.1:38739_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> 1279345 INFO  
(OverseerStateUpdate-73201864842280970-127.0.0.1:38739_solr-n_0000000000) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"test",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"test_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:38739/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1279548 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr    
x:test_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node2&collection.configName=test&newCollection=true&name=test_shard1_replica_n1&action=CREATE&numShards=1&collection=test&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1279548 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr    
x:test_shard1_replica_n1] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1280566 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.RequestParams 
conf resource params.json loaded . version : 0 
   [junit4]   2> 1280566 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.RequestParams 
request params refreshed to version 0
   [junit4]   2> 1280567 WARN  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.SolrConfig 
Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../contrib/extraction/lib
 filtered by .*\.jar to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../contrib/extraction/lib
   [junit4]   2> 1280567 WARN  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.SolrConfig 
Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
 filtered by solr-cell-\d.*\.jar to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
   [junit4]   2> 1280567 WARN  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.SolrConfig 
Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../contrib/clustering/lib
 filtered by .*\.jar to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../contrib/clustering/lib
   [junit4]   2> 1280568 WARN  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.SolrConfig 
Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
 filtered by solr-clustering-\d.*\.jar to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
   [junit4]   2> 1280568 WARN  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.SolrConfig 
Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../contrib/langid/lib
 filtered by .*\.jar to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../contrib/langid/lib
   [junit4]   2> 1280568 WARN  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.SolrConfig 
Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
 filtered by solr-langid-\d.*\.jar to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
   [junit4]   2> 1280568 WARN  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.SolrConfig 
Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../contrib/velocity/lib
 filtered by .*\.jar to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../contrib/velocity/lib
   [junit4]   2> 1280569 WARN  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.SolrConfig 
Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
 filtered by solr-velocity-\d.*\.jar to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
   [junit4]   2> 1280569 WARN  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.SolrConfig 
Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
 filtered by solr-ltr-\d.*\.jar to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
   [junit4]   2> 1280569 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 8.1.0
   [junit4]   2> 1280602 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.s.IndexSchema 
[test_shard1_replica_n1] Schema name=default-config
   [junit4]   2> 1280873 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.s.IndexSchema 
Loaded schema default-config/1.6 with uniqueid field id
   [junit4]   2> 1280940 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.CoreContainer 
Creating SolrCore 'test_shard1_replica_n1' using configuration from collection 
test, trusted=true
   [junit4]   2> 1280941 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38739.solr.core.test.shard1.replica_n1' (registry 
'solr.core.test.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
   [junit4]   2> 1280941 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.SolrCore 
[[test_shard1_replica_n1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/./test_shard1_replica_n1/data/]
   [junit4]   2> 1280947 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
   [junit4]   2> 1281043 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1281043 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1281046 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.u.CommitTracker 
Hard AutoCommit: if uncommitted for 15000ms; 
   [junit4]   2> 1281046 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1281048 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@54e862da[test_shard1_replica_n1] 
main]
   [junit4]   2> 1281050 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/test
   [junit4]   2> 1281051 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/test
   [junit4]   2> 1281051 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/test/managed-schema
   [junit4]   2> 1281052 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1281052 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1281052 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
   [junit4]   2> 1281054 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1281054 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1631925502324244480
   [junit4]   2> 1281058 INFO  
(searcherExecutor-7942-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.c.QuerySenderListener QuerySenderListener sending requests to 
Searcher@54e862da[test_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1281059 INFO  
(searcherExecutor-7942-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.c.QuerySenderListener QuerySenderListener done.
   [junit4]   2> 1281059 INFO  
(searcherExecutor-7942-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1281062 INFO  
(searcherExecutor-7942-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.SolrCore 
[test_shard1_replica_n1] Registered new searcher 
Searcher@54e862da[test_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1281068 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.ZkShardTerms 
Successful update of terms at /collections/test/terms/shard1 to 
Terms{values={core_node2=0}, version=0}
   [junit4]   2> 1281068 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/test/leaders/shard1
   [junit4]   2> 1281073 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1281073 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1281073 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:38739/solr/test_shard1_replica_n1/
   [junit4]   2> 1281074 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 1281074 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.SyncStrategy 
http://127.0.0.1:38739/solr/test_shard1_replica_n1/ has no replicas
   [junit4]   2> 1281074 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/test/leaders/shard1/leader after winning as 
/collections/test/leader_elect/shard1/election/73201864842280970-core_node2-n_0000000000
   [junit4]   2> 1281076 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:38739/solr/test_shard1_replica_n1/ shard1
   [junit4]   2> 1281178 INFO  (zkCallback-9520-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/test/state.json] for 
collection [test] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 1281178 INFO  (zkCallback-9520-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/test/state.json] for 
collection [test] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 1281179 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.ZkController I 
am the leader, no recovery necessary
   [junit4]   2> 1281182 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=test&newCollection=true&name=test_shard1_replica_n1&action=CREATE&numShards=1&collection=test&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1634
   [junit4]   2> 1281187 INFO  (qtp284259657-25634) [n:127.0.0.1:38739_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> 1281236 INFO  
(OverseerCollectionConfigSetProcessor-73201864842280970-127.0.0.1:38739_solr-n_0000000000)
 [n:127.0.0.1:38739_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000002 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1281281 INFO  (zkCallback-9520-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/test/state.json] for 
collection [test] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 1281281 INFO  (zkCallback-9520-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/test/state.json] for 
collection [test] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 1281281 INFO  (zkCallback-9520-thread-3) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/test/state.json] for 
collection [test] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 1281282 INFO  (qtp284259657-25634) [n:127.0.0.1:38739_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={collection.configName=test&name=test&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2}
 status=0 QTime=2053
   [junit4]   2> 1281306 INFO  (qtp284259657-25632) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler Executed config commands successfully and persisted 
to ZK [{"set-user-property":{"update.autoCreateFields":false}}, 
{"add-updateprocessor":{
   [junit4]   2>     "name":"tolerant",
   [junit4]   2>     "class":"solr.TolerantUpdateProcessorFactory"}}, 
{"add-updateprocessor":{
   [junit4]   2>     "name":"tracking-testSliceRouting",
   [junit4]   2>     "class":"solr.TrackingUpdateProcessorFactory",
   [junit4]   2>     "group":"test"}}, {"add-updateprocessor":{
   [junit4]   2>     "name":"inc",
   [junit4]   2>     
"class":"org.apache.solr.update.processor.RoutedAliasUpdateProcessorTest$IncrementURPFactory",
   [junit4]   2>     "fieldName":"integer_i"}}]
   [junit4]   2> 1281307 INFO  (qtp284259657-25632) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler Waiting up to 30 secs for 1 replicas to set the 
property overlay to be of version 0 for collection test
   [junit4]   2> 1281307 INFO  (Thread-3927) [    ] o.a.s.c.SolrCore config 
update listener called for core test_shard1_replica_n1
   [junit4]   2> 1281308 INFO  (Thread-3927) [    ] o.a.s.c.SolrCore core 
reload test_shard1_replica_n1
   [junit4]   2> 1281309 INFO  
(solrHandlerExecutor-7947-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
   [junit4]   2> 1281320 INFO  (Thread-3927) [    ] o.a.s.c.RequestParams conf 
resource params.json loaded . version : 0 
   [junit4]   2> 1281320 INFO  (Thread-3927) [    ] o.a.s.c.RequestParams 
request params refreshed to version 0
   [junit4]   2> 1281321 WARN  (Thread-3927) [    ] o.a.s.c.SolrConfig Couldn't 
add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../contrib/extraction/lib
 filtered by .*\.jar to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../contrib/extraction/lib
   [junit4]   2> 1281321 WARN  (Thread-3927) [    ] o.a.s.c.SolrConfig Couldn't 
add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
 filtered by solr-cell-\d.*\.jar to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
   [junit4]   2> 1281321 WARN  (Thread-3927) [    ] o.a.s.c.SolrConfig Couldn't 
add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../contrib/clustering/lib
 filtered by .*\.jar to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../contrib/clustering/lib
   [junit4]   2> 1281321 WARN  (Thread-3927) [    ] o.a.s.c.SolrConfig Couldn't 
add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
 filtered by solr-clustering-\d.*\.jar to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
   [junit4]   2> 1281321 WARN  (Thread-3927) [    ] o.a.s.c.SolrConfig Couldn't 
add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../contrib/langid/lib
 filtered by .*\.jar to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../contrib/langid/lib
   [junit4]   2> 1281321 WARN  (Thread-3927) [    ] o.a.s.c.SolrConfig Couldn't 
add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
 filtered by solr-langid-\d.*\.jar to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
   [junit4]   2> 1281322 WARN  (Thread-3927) [    ] o.a.s.c.SolrConfig Couldn't 
add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../contrib/velocity/lib
 filtered by .*\.jar to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../contrib/velocity/lib
   [junit4]   2> 1281322 WARN  (Thread-3927) [    ] o.a.s.c.SolrConfig Couldn't 
add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
 filtered by solr-velocity-\d.*\.jar to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
   [junit4]   2> 1281322 WARN  (Thread-3927) [    ] o.a.s.c.SolrConfig Couldn't 
add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
 filtered by solr-ltr-\d.*\.jar to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1/../../../../dist
   [junit4]   2> 1281342 INFO  (Thread-3927) [    ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 8.1.0
   [junit4]   2> 1281374 INFO  (Thread-3927) [    ] o.a.s.s.IndexSchema 
[test_shard1_replica_n1] Schema name=default-config
   [junit4]   2> 1281410 INFO  (qtp284259657-25637) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
   [junit4]   2> 1281411 INFO  (qtp284259657-25637) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.S.Request 
[test_shard1_replica_n1]  webapp=/solr path=/config/znodeVersion 
params={overlay=0&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1281411 INFO  (SolrConfigHandler-refreshconf) [    ] 
o.a.s.h.SolrConfigHandler Another reload is in progress . Not doing anything
   [junit4]   2> 1281411 INFO  
(solrHandlerExecutor-7947-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler Could not get expectedVersion 0 from 
http://127.0.0.1:38739/solr/test_shard1_replica_n1/ for prop overlay   after 1 
attempts
   [junit4]   2> 1281411 INFO  
(solrHandlerExecutor-7947-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
   [junit4]   2> 1281512 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
   [junit4]   2> 1281512 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.S.Request 
[test_shard1_replica_n1]  webapp=/solr path=/config/znodeVersion 
params={overlay=0&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1281513 INFO  (SolrConfigHandler-refreshconf) [    ] 
o.a.s.h.SolrConfigHandler Another reload is in progress . Not doing anything
   [junit4]   2> 1281513 INFO  
(solrHandlerExecutor-7947-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler Could not get expectedVersion 0 from 
http://127.0.0.1:38739/solr/test_shard1_replica_n1/ for prop overlay   after 2 
attempts
   [junit4]   2> 1281513 INFO  
(solrHandlerExecutor-7947-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
   [junit4]   2> 1281571 INFO  (Thread-3927) [    ] o.a.s.s.IndexSchema Loaded 
schema default-config/1.6 with uniqueid field id
   [junit4]   2> 1281614 INFO  (qtp284259657-25634) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
   [junit4]   2> 1281614 INFO  (qtp284259657-25634) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.S.Request 
[test_shard1_replica_n1]  webapp=/solr path=/config/znodeVersion 
params={overlay=0&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1281614 INFO  (Thread-3927) [    ] o.a.s.c.CoreContainer 
Reloading SolrCore 'test_shard1_replica_n1' using configuration from collection 
test
   [junit4]   2> 1281614 INFO  (SolrConfigHandler-refreshconf) [    ] 
o.a.s.h.SolrConfigHandler Another reload is in progress . Not doing anything
   [junit4]   2> 1281615 INFO  
(solrHandlerExecutor-7947-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler Could not get expectedVersion 0 from 
http://127.0.0.1:38739/solr/test_shard1_replica_n1/ for prop overlay   after 3 
attempts
   [junit4]   2> 1281615 INFO  
(solrHandlerExecutor-7947-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
   [junit4]   2> 1281655 INFO  (Thread-3927) [n:127.0.0.1:38739_solr c:test 
s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 'solr_38739.solr.core.test.shard1.replica_n1' (registry 
'solr.core.test.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f058f00
   [junit4]   2> 1281655 INFO  (Thread-3927) [n:127.0.0.1:38739_solr c:test 
s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.SolrCore 
[[test_shard1_replica_n1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/test_shard1_replica_n1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001/tempDir-001/node2/./test_shard1_replica_n1/data/]
   [junit4]   2> 1281659 INFO  (Thread-3927) [n:127.0.0.1:38739_solr c:test 
s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.r.XSLTResponseWriter 
xsltCacheLifetimeSeconds=5
   [junit4]   2> 1281716 INFO  (qtp284259657-25635) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
   [junit4]   2> 1281716 INFO  (qtp284259657-25635) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.S.Request 
[test_shard1_replica_n1]  webapp=/solr path=/config/znodeVersion 
params={overlay=0&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1281716 INFO  (SolrConfigHandler-refreshconf) [    ] 
o.a.s.h.SolrConfigHandler Another reload is in progress . Not doing anything
   [junit4]   2> 1281717 INFO  
(solrHandlerExecutor-7947-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler Could not get expectedVersion 0 from 
http://127.0.0.1:38739/solr/test_shard1_replica_n1/ for prop overlay   after 4 
attempts
   [junit4]   2> 1281717 INFO  
(solrHandlerExecutor-7947-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
   [junit4]   2> 1281729 INFO  (Thread-3927) [n:127.0.0.1:38739_solr c:test 
s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.u.CommitTracker Hard 
AutoCommit: if uncommitted for 15000ms; 
   [junit4]   2> 1281729 INFO  (Thread-3927) [n:127.0.0.1:38739_solr c:test 
s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 1281731 INFO  (Thread-3927) [n:127.0.0.1:38739_solr c:test 
s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@1e7735d9[test_shard1_replica_n1] main]
   [junit4]   2> 1281733 INFO  (Thread-3927) [n:127.0.0.1:38739_solr c:test 
s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/test
   [junit4]   2> 1281733 INFO  (Thread-3927) [n:127.0.0.1:38739_solr c:test 
s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.r.ManagedResourceStorage 
Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/test
   [junit4]   2> 1281733 INFO  (Thread-3927) [n:127.0.0.1:38739_solr c:test 
s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.s.ZkIndexSchemaReader 
Creating ZooKeeper watch for the managed schema at /configs/test/managed-schema
   [junit4]   2> 1281734 INFO  (Thread-3927) [n:127.0.0.1:38739_solr c:test 
s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.s.ZkIndexSchemaReader 
Current schema version 0 is already the latest
   [junit4]   2> 1281734 INFO  (Thread-3927) [n:127.0.0.1:38739_solr c:test 
s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.h.c.SpellCheckComponent 
Initializing spell checkers
   [junit4]   2> 1281734 INFO  (Thread-3927) [n:127.0.0.1:38739_solr c:test 
s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.s.DirectSolrSpellChecker 
init: 
{name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
   [junit4]   2> 1281735 INFO  (Thread-3927) [n:127.0.0.1:38739_solr c:test 
s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.h.ReplicationHandler 
Commits will be reserved for 10000ms.
   [junit4]   2> 1281736 INFO  (Thread-3927) [n:127.0.0.1:38739_solr c:test 
s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1631925503039373312
   [junit4]   2> 1281739 INFO  
(searcherExecutor-7948-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.c.QuerySenderListener QuerySenderListener sending requests to 
Searcher@1e7735d9[test_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1281739 INFO  
(searcherExecutor-7948-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.c.QuerySenderListener QuerySenderListener done.
   [junit4]   2> 1281739 INFO  
(searcherExecutor-7948-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1281740 INFO  (Thread-3927) [n:127.0.0.1:38739_solr c:test 
s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.u.DefaultSolrCoreState 
New IndexWriter is ready to be used.
   [junit4]   2> 1281748 INFO  
(searcherExecutor-7948-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.SolrCore 
[test_shard1_replica_n1] Registered new searcher 
Searcher@1e7735d9[test_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1281748 INFO  (Thread-3927) [n:127.0.0.1:38739_solr c:test 
s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@54a01ab2[test_shard1_replica_n1] main]
   [junit4]   2> 1281749 INFO  
(searcherExecutor-7948-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.c.QuerySenderListener QuerySenderListener sending requests to 
Searcher@54a01ab2[test_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1281749 INFO  
(searcherExecutor-7948-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.c.QuerySenderListener QuerySenderListener done.
   [junit4]   2> 1281753 INFO  
(searcherExecutor-7948-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.SolrCore 
[test_shard1_replica_n1] Registered new searcher 
Searcher@54a01ab2[test_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1281818 INFO  (qtp284259657-25637) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler I already have the expected version 0 of config
   [junit4]   2> 1281818 INFO  (qtp284259657-25637) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler isStale false , resourceloader 
org.apache.solr.cloud.ZkSolrResourceLoader
   [junit4]   2> 1281818 INFO  (qtp284259657-25637) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.S.Request 
[test_shard1_replica_n1]  webapp=/solr path=/config/znodeVersion 
params={overlay=0&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1281819 INFO  (qtp284259657-25632) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler Took 512.0ms to set the property overlay to be of 
version 0 for collection test
   [junit4]   2> 1281819 INFO  (qtp284259657-25632) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.SolrCore 
[test_shard1_replica_n1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@179b2750
   [junit4]   2> 1281819 INFO  (qtp284259657-25632) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.test.shard1.replica_n1, tag=179b2750
   [junit4]   2> 1281819 INFO  (qtp284259657-25632) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@31c5c679: rootName = 
solr_38739, domain = solr.core.test.shard1.replica_n1, service url = null, 
agent id = null] for registry solr.core.test.shard1.replica_n1 / 
com.codahale.metrics.MetricRegistry@28e0facd
   [junit4]   2> 1281831 INFO  (qtp284259657-25632) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.test.shard1.leader, tag=179b2750
   [junit4]   2> 1281836 INFO  (qtp284259657-25637) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.ZkController 
Persisted config data to node /configs/test/params.json 
   [junit4]   2> 1281837 INFO  (qtp284259657-25637) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler Waiting up to 30 secs for 1 replicas to set the 
property params to be of version 1 for collection test
   [junit4]   2> 1281838 INFO  (Thread-3928) [    ] o.a.s.c.SolrCore config 
update listener called for core test_shard1_replica_n1
   [junit4]   2> 1281839 INFO  (Thread-3928) [    ] o.a.s.c.RequestParams conf 
resource params.json loaded . version : 1 
   [junit4]   2> 1281839 INFO  (Thread-3928) [    ] o.a.s.c.RequestParams 
request params refreshed to version 1
   [junit4]   2> 1281840 INFO  
(solrHandlerExecutor-7952-thread-1-processing-n:127.0.0.1:38739_solr 
x:test_shard1_replica_n1 c:test s:shard1 r:core_node2) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
   [junit4]   2> 1281942 INFO  (qtp284259657-25634) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler I already have the expected version 1 of params
   [junit4]   2> 1281942 INFO  (qtp284259657-25634) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler isStale false , resourceloader 
org.apache.solr.cloud.ZkSolrResourceLoader
   [junit4]   2> 1281942 INFO  (qtp284259657-25634) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] o.a.s.c.S.Request 
[test_shard1_replica_n1]  webapp=/solr path=/config/znodeVersion 
params={params=1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1281943 INFO  (qtp284259657-25637) [n:127.0.0.1:38739_solr 
c:test s:shard1 r:core_node2 x:test_shard1_replica_n1] 
o.a.s.h.SolrConfigHandler Took 105.0ms to set the property params to be of 
version 1 for collection test
   [junit4]   2> 1281944 INFO  (qtp284259657-25633) [n:127.0.0.1:38739_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params 
name=test&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 1281947 INFO  
(OverseerThreadFactory-7922-thread-3-processing-n:127.0.0.1:38739_solr) 
[n:127.0.0.1:38739_solr    ] o.a.s.c.a.c.OverseerCollectionMessageHandler 
Executing Collection 
Cmd=action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true&deleteMetricsHistory=true,
 asyncId=null
   [junit4]   2> 1281948 INFO  (qtp284259657-25634) [n:127.0.0.1:38739_solr    
x:test_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters 
for registry=solr.core.test.shard1.replica_n1, tag=null
   [junit4]   2> 1281948 INFO  (qtp284259657-25634) [n:127.0.0.1:38739_solr    
x:test_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@4c69333b: rootName = 
solr_38739, domain = solr.core.test.shard1.replica_n1, service url = null, 
agent id = null] for registry solr.core.test.shard1.replica_n1 / 
com.codahale.metrics.MetricRegistry@28e0facd
   [junit4]   2> 1281969 INFO  (qtp284259657-25634) [n:127.0.0.1:38739_solr    
x:test_shard1_replica_n1] o.a.s.c.SolrCore [test_shard1_replica_n1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@62b5810f
   [junit4]   2> 1281969 INFO  (qtp284259657-25634) [n:127.0.0.1:38739_solr    
x:test_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters 
for registry=solr.core.test.shard1.replica_n1, tag=62b5810f
   [junit4]   2> 1281969 INFO  (qtp284259657-25634) [n:127.0.0.1:38739_solr    
x:test_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters 
for registry=solr.collection.test.shard1.leader, tag=62b5810f
   [junit4]   2> 1281972 INFO  (qtp284259657-25634) [n:127.0.0.1:38739_solr    
x:test_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/test/terms/shard1 to Terms{values={}, version=1}
   [junit4]   2> 1281973 INFO  (qtp284259657-25634) [n:127.0.0.1:38739_solr    
x:test_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/admin/cores par

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

) ~[?:1.8.0_191]
   [junit4]   2>        at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) 
~[?:1.8.0_191]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:504) 
~[zookeeper-3.4.14.jar:3.4.14-4c25d480e66aadd371de8bd2fd8da255ac140bcf]
   [junit4]   2> 8488755 ERROR 
(zkConnectionManagerCallback-10117-thread-1-EventThread) [    ] 
o.a.z.ClientCnxn Event thread exiting due to interruption
   [junit4]   2>           => java.lang.InterruptedException
   [junit4]   2>        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
   [junit4]   2> java.lang.InterruptedException: null
   [junit4]   2>        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
 ~[?:1.8.0_191]
   [junit4]   2>        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2048)
 ~[?:1.8.0_191]
   [junit4]   2>        at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) 
~[?:1.8.0_191]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:504) 
~[zookeeper-3.4.14.jar:3.4.14-4c25d480e66aadd371de8bd2fd8da255ac140bcf]
   [junit4]   2> 8488768 INFO  
(TEST-CategoryRoutedAliasUpdateProcessorTest.testSliceRouting-seed#[14F3A3B69EFF36C1])
 [    ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
   [junit4]   2> 8488771 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Exception causing close of session 0x10410b66dcb001e: null
   [junit4]   2> 8488771 INFO  (jetty-closer-10265-thread-4) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@7c1b522a{/solr,null,UNAVAILABLE}
   [junit4]   2> 8488771 INFO  (jetty-closer-10265-thread-4) [    ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 8488772 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Exception causing close of session 0x10410b66dcb001c: null
   [junit4]   2> 8488776 INFO  (jetty-closer-10265-thread-4) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@6e25fa4f{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:0}
   [junit4]   2> 8488781 INFO  
(TEST-CategoryRoutedAliasUpdateProcessorTest.testSliceRouting-seed#[14F3A3B69EFF36C1])
 [    ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:43883
   [junit4]   2> 8488781 INFO  
(TEST-CategoryRoutedAliasUpdateProcessorTest.testSliceRouting-seed#[14F3A3B69EFF36C1])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 43883
   [junit4]   2> 8488783 INFO  
(TEST-CategoryRoutedAliasUpdateProcessorTest.testSliceRouting-seed#[14F3A3B69EFF36C1])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testSliceRouting
   [junit4]   2> 8488795 INFO  
(SUITE-CategoryRoutedAliasUpdateProcessorTest-seed#[14F3A3B69EFF36C1]-worker) [ 
   ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
   [junit4]   2> 8488795 INFO  
(SUITE-CategoryRoutedAliasUpdateProcessorTest-seed#[14F3A3B69EFF36C1]-worker) [ 
   ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:43883
   [junit4]   2> 8488795 INFO  
(SUITE-CategoryRoutedAliasUpdateProcessorTest-seed#[14F3A3B69EFF36C1]-worker) [ 
   ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 43883
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_14F3A3B69EFF36C1-001
   [junit4]   2> Apr 27, 2019 2:37:28 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
   [junit4]   2> SEVERE: There are still zombie threads that couldn't be 
terminated:
   [junit4]   2>    1) Thread[id=27573, name=jetty-closer-10265-thread-4, 
state=TIMED_WAITING, group=TGRP-CategoryRoutedAliasUpdateProcessorTest]
   [junit4]   2>         at sun.misc.Unsafe.park(Native Method)
   [junit4]   2>         at 
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
   [junit4]   2>         at 
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
   [junit4]   2>         at 
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:362)
   [junit4]   2>         at 
java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:941)
   [junit4]   2>         at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1073)
   [junit4]   2>         at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
   [junit4]   2>         at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]   2>         at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene80): {}, 
docValues:{}, maxPointsInLeafNode=1010, maxMBSortInHeap=6.785869483793773, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@4755989),
 locale=es-CR, timezone=America/Argentina/Salta
   [junit4]   2> NOTE: Linux 4.4.0-137-generic amd64/Oracle Corporation 
1.8.0_191 (64-bit)/cpus=4,threads=2,free=109337368,total=477626368
   [junit4]   2> NOTE: All tests run in this JVM: [TestConfigOverlay, 
TestLRUStatsCache, TestRebalanceLeaders, TestApiFramework, TestBinaryField, 
SpatialHeatmapFacetsTest, ReturnFieldsTest, TestLazyCores, 
QueryElevationComponentTest, TestCloudRecovery, SyncSliceTest, 
TestFreeTextSuggestions, TestSolrConfigHandlerCloud, 
TestJsonFacetsWithNestedObjects, DateMathParserTest, SuggestComponentTest, 
PeerSyncWithIndexFingerprintCachingTest, TestSchemaManager, MBeansHandlerTest, 
AutoAddReplicasIntegrationTest, InfoHandlerTest, SolrGraphiteReporterTest, 
SpellCheckComponentTest, PropertiesRequestHandlerTest, 
TestUniqueKeyFieldResource, TestConfigSets, TestLMDirichletSimilarityFactory, 
UnloadDistributedZkTest, TestSafeXMLParsing, RootFieldTest, TestUpdate, 
TestCoreAdminApis, NumericFieldsTest, ClusterStateUpdateTest, 
WordBreakSolrSpellCheckerTest, SampleTest, TestOnReconnectListenerSupport, 
MissingSegmentRecoveryTest, DeleteReplicaTest, CacheHeaderTest, 
TestExtendedDismaxParser, TestJettySolrRunner, 
OverriddenZkACLAndCredentialsProvidersTest, TestEmbeddedSolrServerAdminHandler, 
TestBadConfig, TaggingAttributeTest, V2ApiIntegrationTest, 
TestHalfAndHalfDocValues, AnalysisAfterCoreReloadTest, HighlighterConfigTest, 
TestBinaryResponseWriter, TestNumericTerms32, BasicAuthIntegrationTest, 
TestCloudConsistency, TestSimGenericDistributedQueue, TestTestInjection, 
TestInfoStreamLogging, HdfsWriteToMultipleCollectionsTest, 
CSVRequestHandlerTest, TestSchemaSimilarityResource, TestUseDocValuesAsStored, 
CollectionsAPIDistributedZkTest, TermsComponentTest, TestMacros, 
TestSegmentSorting, DistributedUpdateProcessorTest, 
TestSolrCloudWithSecureImpersonation, SolrSlf4jReporterTest, AddReplicaTest, 
NumberUtilsTest, ExplicitHLLTest, DistributedFacetPivotSmallTest, 
ReplaceNodeNoTargetTest, TestXmlQParserPlugin, SpellPossibilityIteratorTest, 
DistributedSpellCheckComponentTest, RuleEngineTest, 
TestPHPSerializedResponseWriter, TestUnInvertedFieldException, 
TestClusterProperties, RandomizedTaggerTest, BasicZkTest, 
TestCloudPhrasesIdentificationComponent, TestInPlaceUpdateWithRouteField, 
HttpPartitionWithTlogReplicasTest, HdfsRecoveryZkTest, MoveReplicaTest, 
ConnectionManagerTest, QueryEqualityTest, 
DistributedQueryComponentCustomSortTest, RequestHandlersTest, 
CleanupOldIndexTest, DocValuesMissingTest, TestChildDocTransformer, 
ZkControllerTest, TestSolrDeletionPolicy1, ParsingFieldUpdateProcessorsTest, 
SolrCloudExampleTest, TestRestoreCore, HealthCheckHandlerTest, 
TestDistributedMissingSort, TestSolrCoreProperties, TestCloudSchemaless, 
TestInPlaceUpdatesStandalone, SimplePostToolTest, TestQuerySenderListener, 
TestTrieFacet, RecoveryZkTest, SolrRrdBackendFactoryTest, TestSolrQueryParser, 
HttpTriggerListenerTest, DistribCursorPagingTest, MaxSizeAutoCommitTest, 
DistributedDebugComponentTest, TestInitQParser, TestFieldTypeResource, 
TestMaxTokenLenTokenizer, TestDocBasedVersionConstraints, TestRTGBase, 
CategoryRoutedAliasUpdateProcessorTest]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=CategoryRoutedAliasUpdateProcessorTest -Dtests.seed=14F3A3B69EFF36C1 
-Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=es-CR 
-Dtests.timezone=America/Argentina/Salta -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.00s J0 | CategoryRoutedAliasUpdateProcessorTest (suite) 
<<<
   [junit4]    > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 
7200000 msec).
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([14F3A3B69EFF36C1]:0)
   [junit4] Completed [836/855 (1!)] on J0 in 7212.93s, 6 tests, 2 errors <<< 
FAILURES!

[...truncated 69 lines...]
   [junit4] JVM J0: stdout was not empty, see: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/temp/junit4-J0-20190427_001556_52667385788894574198.sysout
   [junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
   [junit4] java.lang.OutOfMemoryError: GC overhead limit exceeded
   [junit4] Dumping heap to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/heapdumps/java_pid29487.hprof
 ...
   [junit4] Heap dump file created [701058200 bytes in 6.195 secs]
   [junit4] <<< JVM J0: EOF ----

[...truncated 8948 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/build.xml:634: The 
following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/build.xml:586: Some 
of the tests produced a heap dump, but did not fail. Maybe a suppressed 
OutOfMemoryError? Dumps created:
* java_pid29487.hprof

Total time: 197 minutes 6 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[Fast Archiver] No artifacts from Lucene-Solr-Tests-8.x #169 to compare, so 
performing full copy of artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to