Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.10/126/

1 tests failed.
FAILED:  
org.apache.solr.cloud.TestCloudSearcherWarming.testPeersyncFailureReplicationSuccess

Error Message:
No registered leader was found after waiting for 1000ms , collection: 
testPeersyncFailureReplicationSuccess slice: shard1 saw 
state=DocCollection(testPeersyncFailureReplicationSuccess//collections/testPeersyncFailureReplicationSuccess/state.json/10
 )={   "pullReplicas":"0",   "replicationFactor":"1",   "shards":{"shard1":{    
   "range":"80000000-7fffffff",       "state":"active",       "replicas":{      
   "core_node2":{           
"core":"testPeersyncFailureReplicationSuccess_shard1_replica_n1",           
"node_name":"127.0.0.1:44583_solr",           
"base_url":"https://127.0.0.1:44583/solr";,           "state":"down",           
"type":"NRT",           "force_set_state":"false"},         "core_node4":{      
     "core":"testPeersyncFailureReplicationSuccess_shard1_replica_n3",          
 "node_name":"127.0.0.1:35639_solr",           
"base_url":"https://127.0.0.1:35639/solr";,           "state":"active",          
 "type":"NRT",           "force_set_state":"false"}}}},   
"router":{"name":"compositeId"},   "maxShardsPerNode":"2",   
"autoAddReplicas":"false",   "nrtReplicas":"1",   "tlogReplicas":"0"} with 
live_nodes=[127.0.0.1:35639_solr]

Stack Trace:
org.apache.solr.common.SolrException: No registered leader was found after 
waiting for 1000ms , collection: testPeersyncFailureReplicationSuccess slice: 
shard1 saw 
state=DocCollection(testPeersyncFailureReplicationSuccess//collections/testPeersyncFailureReplicationSuccess/state.json/10
 )={
  "pullReplicas":"0",
  "replicationFactor":"1",
  "shards":{"shard1":{
      "range":"80000000-7fffffff",
      "state":"active",
      "replicas":{
        "core_node2":{
          "core":"testPeersyncFailureReplicationSuccess_shard1_replica_n1",
          "node_name":"127.0.0.1:44583_solr",
          "base_url":"https://127.0.0.1:44583/solr";,
          "state":"down",
          "type":"NRT",
          "force_set_state":"false"},
        "core_node4":{
          "core":"testPeersyncFailureReplicationSuccess_shard1_replica_n3",
          "node_name":"127.0.0.1:35639_solr",
          "base_url":"https://127.0.0.1:35639/solr";,
          "state":"active",
          "type":"NRT",
          "force_set_state":"false"}}}},
  "router":{"name":"compositeId"},
  "maxShardsPerNode":"2",
  "autoAddReplicas":"false",
  "nrtReplicas":"1",
  "tlogReplicas":"0"} with live_nodes=[127.0.0.1:35639_solr]
        at 
__randomizedtesting.SeedInfo.seed([F907AE23393C524A:2D56CD6CE8826529]:0)
        at 
org.apache.solr.common.cloud.ZkStateReader.getLeaderRetry(ZkStateReader.java:993)
        at 
org.apache.solr.common.cloud.ZkStateReader.getLeaderRetry(ZkStateReader.java:968)
        at 
org.apache.solr.cloud.TestCloudSearcherWarming.testPeersyncFailureReplicationSuccess(TestCloudSearcherWarming.java:205)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 15241 lines...]
   [junit4] Suite: org.apache.solr.cloud.TestCloudSearcherWarming
   [junit4]   2> 1492148 INFO  
(SUITE-TestCloudSearcherWarming-seed#[F907AE23393C524A]-worker) [     ] 
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to 
test-framework derived value of 
'/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.10/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 1492148 INFO  
(SUITE-TestCloudSearcherWarming-seed#[F907AE23393C524A]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1492149 INFO  
(SUITE-TestCloudSearcherWarming-seed#[F907AE23393C524A]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.10/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F907AE23393C524A-001/data-dir-161-001
   [junit4]   2> 1492149 WARN  
(SUITE-TestCloudSearcherWarming-seed#[F907AE23393C524A]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4
   [junit4]   2> 1492149 INFO  
(SUITE-TestCloudSearcherWarming-seed#[F907AE23393C524A]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1492151 INFO  
(SUITE-TestCloudSearcherWarming-seed#[F907AE23393C524A]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 1492151 INFO  
(SUITE-TestCloudSearcherWarming-seed#[F907AE23393C524A]-worker) [     ] 
o.a.s.c.SolrCloudTestCase Using per-replica state
   [junit4]   2> 1492153 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.SolrTestCaseJ4 ###Starting testRepFactor1LeaderStartup
   [junit4]   2> 1492154 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.10/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F907AE23393C524A-001/tempDir-001
   [junit4]   2> 1492154 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1492154 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
   [junit4]   2> 1492154 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1492155 WARN  (ZkTestServer Run Thread) [     ] 
o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
   [junit4]   2> 1492254 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.ZkTestServer start zk server on port: 35919
   [junit4]   2> 1492254 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:35919
   [junit4]   2> 1492254 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:35919
   [junit4]   2> 1492254 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 35919
   [junit4]   2> 1492256 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1492257 INFO  (zkConnectionManagerCallback-15484-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1492257 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1492260 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1492260 INFO  (zkConnectionManagerCallback-15486-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1492260 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1492261 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1492262 INFO  (zkConnectionManagerCallback-15488-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1492262 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1492364 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1492364 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1492365 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 
98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
   [junit4]   2> 1492365 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1492365 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1492365 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1492365 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@49cf5d99{/solr,null,AVAILABLE}
   [junit4]   2> 1492366 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@778ba767{SSL, (ssl, 
http/1.1)}{127.0.0.1:36677}
   [junit4]   2> 1492366 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.e.j.s.Server Started @1492443ms
   [junit4]   2> 1492366 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
zkHost=127.0.0.1:35919/solr, hostPort=36677}
   [junit4]   2> 1492366 ERROR (jetty-launcher-15489-thread-1) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1492366 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1492366 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.10.1
   [junit4]   2> 1492366 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1492366 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.10/solr
   [junit4]   2> 1492366 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2021-09-29T03:35:45.308Z
   [junit4]   2> 1492367 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1492367 INFO  (zkConnectionManagerCallback-15491-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1492367 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1492368 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1492371 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.a.s.c.SolrXmlConfig Metrics collection is disabled.
   [junit4]   2> 1492994 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1492994 WARN  (jetty-launcher-15489-thread-1) [     ] 
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport 
since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 1492995 WARN  (jetty-launcher-15489-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@2dd2d56f[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1492995 WARN  (jetty-launcher-15489-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@2dd2d56f[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1492996 WARN  (jetty-launcher-15489-thread-1) [     ] 
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport 
since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 1492997 WARN  (jetty-launcher-15489-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@241e5d00[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1492997 WARN  (jetty-launcher-15489-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@241e5d00[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1492998 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35919/solr
   [junit4]   2> 1492999 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1492999 INFO  (zkConnectionManagerCallback-15502-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1492999 INFO  (jetty-launcher-15489-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1493101 INFO  (jetty-launcher-15489-thread-1) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1493102 INFO  (zkConnectionManagerCallback-15504-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1493102 INFO  (jetty-launcher-15489-thread-1) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 1493157 WARN  (jetty-launcher-15489-thread-1) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.ZkController Contents of zookeeper 
/security.json are world-readable; consider setting up ACLs as described in 
https://solr.apache.org/guide/zookeeper-access-control.html
   [junit4]   2> 1493161 INFO  (jetty-launcher-15489-thread-1) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:36677_solr
   [junit4]   2> 1493162 INFO  (jetty-launcher-15489-thread-1) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.Overseer Overseer 
(id=72489864089239557-127.0.0.1:36677_solr-n_0000000000) starting
   [junit4]   2> 1493166 INFO  
(OverseerStateUpdate-72489864089239557-127.0.0.1:36677_solr-n_0000000000) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:36677_solr
   [junit4]   2> 1493166 INFO  (jetty-launcher-15489-thread-1) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:36677_solr
   [junit4]   2> 1493167 INFO  
(OverseerStateUpdate-72489864089239557-127.0.0.1:36677_solr-n_0000000000) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1493168 INFO  (jetty-launcher-15489-thread-1) 
[n:127.0.0.1:36677_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 1493169 WARN  (jetty-launcher-15489-thread-1) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.CoreContainer Not all security plugins 
configured!  authentication=disabled authorization=disabled.  Solr is only as 
secure as you make it. Consider configuring authentication/authorization before 
exposing Solr to users internal or external.  See 
https://s.apache.org/solrsecurity for more info
   [junit4]   2> 1493193 INFO  (jetty-launcher-15489-thread-1) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.10/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F907AE23393C524A-001/tempDir-001/node1
   [junit4]   2> 1493202 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=1
   [junit4]   2> 1493204 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1493205 INFO  (zkConnectionManagerCallback-15519-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1493205 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1493206 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1493207 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:35919/solr ready
   [junit4]   2> 1493235 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
testRepFactor1LeaderStartup
   [junit4]   2> 1493235 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default to /configs/testRepFactor1LeaderStartup.AUTOCREATED
   [junit4]   2> 1493236 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/protwords.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/protwords.txt
   [junit4]   2> 1493237 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/managed-schema to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/managed-schema
   [junit4]   2> 1493239 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/solrconfig.xml to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/solrconfig.xml
   [junit4]   2> 1493241 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_it.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/contractions_it.txt
   [junit4]   2> 1493243 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_no.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_no.txt
   [junit4]   2> 1493244 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_ca.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/contractions_ca.txt
   [junit4]   2> 1493246 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stemdict_nl.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stemdict_nl.txt
   [junit4]   2> 1493247 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_hy.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_hy.txt
   [junit4]   2> 1493249 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_id.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_id.txt
   [junit4]   2> 1493250 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_et.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_et.txt
   [junit4]   2> 1493252 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ga.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_ga.txt
   [junit4]   2> 1493253 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_da.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_da.txt
   [junit4]   2> 1493254 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_hi.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_hi.txt
   [junit4]   2> 1493255 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ja.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_ja.txt
   [junit4]   2> 1493257 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_pt.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_pt.txt
   [junit4]   2> 1493258 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_hu.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_hu.txt
   [junit4]   2> 1493259 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_el.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_el.txt
   [junit4]   2> 1493261 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ru.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_ru.txt
   [junit4]   2> 1493262 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_tr.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_tr.txt
   [junit4]   2> 1493263 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ar.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_ar.txt
   [junit4]   2> 1493265 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/userdict_ja.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/userdict_ja.txt
   [junit4]   2> 1493266 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_it.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_it.txt
   [junit4]   2> 1493268 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_eu.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_eu.txt
   [junit4]   2> 1493269 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_cz.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_cz.txt
   [junit4]   2> 1493270 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stoptags_ja.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stoptags_ja.txt
   [junit4]   2> 1493271 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_fr.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/contractions_fr.txt
   [junit4]   2> 1493273 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_de.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_de.txt
   [junit4]   2> 1493274 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_fa.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_fa.txt
   [junit4]   2> 1493275 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_ga.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/contractions_ga.txt
   [junit4]   2> 1493276 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ca.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_ca.txt
   [junit4]   2> 1493278 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_nl.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_nl.txt
   [junit4]   2> 1493279 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_bg.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_bg.txt
   [junit4]   2> 1493280 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_en.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_en.txt
   [junit4]   2> 1493281 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_lv.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_lv.txt
   [junit4]   2> 1493283 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_es.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_es.txt
   [junit4]   2> 1493284 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_th.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_th.txt
   [junit4]   2> 1493285 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ro.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_ro.txt
   [junit4]   2> 1493287 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_fr.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_fr.txt
   [junit4]   2> 1493288 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_sv.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_sv.txt
   [junit4]   2> 1493289 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_fi.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_fi.txt
   [junit4]   2> 1493290 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/hyphenations_ga.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/hyphenations_ga.txt
   [junit4]   2> 1493292 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_gl.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/lang/stopwords_gl.txt
   [junit4]   2> 1493293 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/synonyms.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/synonyms.txt
   [junit4]   2> 1493294 INFO  
(OverseerThreadFactory-15511-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/stopwords.txt to 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/stopwords.txt
   [junit4]   2> 1493405 INFO  
(OverseerStateUpdate-72489864089239557-127.0.0.1:36677_solr-n_0000000000) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"testRepFactor1LeaderStartup_shard1_replica_n1",
   [junit4]   2>   "node_name":"127.0.0.1:36677_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:36677/solr";,
   [junit4]   2>   "collection":"testRepFactor1LeaderStartup",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1493613 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr    
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation 
core create command 
qt=/admin/cores&coreNodeName=core_node2&collection.configName=testRepFactor1LeaderStartup.AUTOCREATED&newCollection=true&name=testRepFactor1LeaderStartup_shard1_replica_n1&action=CREATE&numShards=1&collection=testRepFactor1LeaderStartup&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1493613 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr    
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 
2147483647 cores with initial capacity of 1024
   [junit4]   2> 1493623 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 8.10.1
   [junit4]   2> 1493623 WARN  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.c.SolrConfig 
solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter 
section instead
   [junit4]   2> 1493626 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema 
name=default-config
   [junit4]   2> 1493662 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded 
schema default-config/1.6 with uniqueid field id
   [junit4]   2> 1493702 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.c.CoreContainer 
Creating SolrCore 'testRepFactor1LeaderStartup_shard1_replica_n1' using 
configuration from configset testRepFactor1LeaderStartup.AUTOCREATED, 
trusted=true
   [junit4]   2> 1493703 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.c.SolrCore 
[[testRepFactor1LeaderStartup_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.10/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F907AE23393C524A-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.10/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F907AE23393C524A-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/data/]
   [junit4]   2> 1493755 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1493755 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1493756 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard 
AutoCommit: if uncommitted for 15000ms; 
   [junit4]   2> 1493756 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 1493758 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/testRepFactor1LeaderStartup.AUTOCREATED
   [junit4]   2> 1493758 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/testRepFactor1LeaderStartup.AUTOCREATED
   [junit4]   2> 1493758 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader 
Creating ZooKeeper watch for the managed schema at 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/managed-schema
   [junit4]   2> 1493759 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader 
Current schema version 0 is already the latest
   [junit4]   2> 1493759 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent 
Initializing spell checkers
   [junit4]   2> 1493759 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxQueryFrequency=0.01,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4}
   [junit4]   2> 1493760 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.h.ReplicationHandler 
Commits will be reserved for 10000 ms
   [junit4]   2> 1493760 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1712205643594596352
   [junit4]   2> 1493762 INFO  
(searcherExecutor-15521-thread-1-processing-n:127.0.0.1:36677_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2) [n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2 x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.c.QuerySenderListener QuerySenderListener done.
   [junit4]   2> 1493762 INFO  
(searcherExecutor-15521-thread-1-processing-n:127.0.0.1:36677_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2) [n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2 x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1493762 INFO  
(searcherExecutor-15521-thread-1-processing-n:127.0.0.1:36677_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2) [n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2 x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.c.SolrCore [testRepFactor1LeaderStartup_shard1_replica_n1]  Registered 
new searcher autowarm time: 0 ms
   [junit4]   2> 1493767 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.c.ZkShardTerms 
Successful update of terms at 
/collections/testRepFactor1LeaderStartup/terms/shard1 to 
Terms{values={core_node2=0}, version=0}
   [junit4]   2> 1493768 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/testRepFactor1LeaderStartup/leaders/shard1
   [junit4]   2> 1493771 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1493771 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1493771 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync 
replicas to 
https://127.0.0.1:36677/solr/testRepFactor1LeaderStartup_shard1_replica_n1/
   [junit4]   2> 1493771 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync 
Success - now sync replicas to me
   [junit4]   2> 1493771 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.c.SyncStrategy 
https://127.0.0.1:36677/solr/testRepFactor1LeaderStartup_shard1_replica_n1/ has 
no replicas
   [junit4]   2> 1493771 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/testRepFactor1LeaderStartup/leaders/shard1/leader after winning as 
/collections/testRepFactor1LeaderStartup/leader_elect/shard1/election/72489864089239557-core_node2-n_0000000000
   [junit4]   2> 1493773 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:36677/solr/testRepFactor1LeaderStartup_shard1_replica_n1/ 
shard1
   [junit4]   2> 1493875 INFO  (zkCallback-15503-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testRepFactor1LeaderStartup/state.json] for collection 
[testRepFactor1LeaderStartup] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1493875 INFO  (zkCallback-15503-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testRepFactor1LeaderStartup/state.json] for collection 
[testRepFactor1LeaderStartup] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1493875 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.c.ZkController I am the 
leader, no recovery necessary
   [junit4]   2> 1493878 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=testRepFactor1LeaderStartup.AUTOCREATED&newCollection=true&name=testRepFactor1LeaderStartup_shard1_replica_n1&action=CREATE&numShards=1&collection=testRepFactor1LeaderStartup&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=265
   [junit4]   2> 1493880 INFO  (qtp2104740887-24674) [n:127.0.0.1:36677_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> 1493978 INFO  (zkCallback-15503-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testRepFactor1LeaderStartup/state.json] for collection 
[testRepFactor1LeaderStartup] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1493978 INFO  (zkCallback-15503-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testRepFactor1LeaderStartup/state.json] for collection 
[testRepFactor1LeaderStartup] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1493978 INFO  (zkCallback-15503-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testRepFactor1LeaderStartup/state.json] for collection 
[testRepFactor1LeaderStartup] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1493978 INFO  (qtp2104740887-24674) [n:127.0.0.1:36677_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={pullReplicas=0&name=testRepFactor1LeaderStartup&nrtReplicas=1&action=CREATE&numShards=1&tlogReplicas=0&createNodeSet=127.0.0.1:36677_solr&wt=javabin&version=2}
 status=0 QTime=745
   [junit4]   2> 1493979 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: 
testRepFactor1LeaderStartup
   [junit4]   2> 1493985 INFO  (qtp2104740887-24673) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_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 testRepFactor1LeaderStartup
   [junit4]   2> 1493985 INFO  (Thread-2553) [     ] o.a.s.c.SolrCore config 
update listener called for core testRepFactor1LeaderStartup_shard1_replica_n1
   [junit4]   2> 1493986 INFO  (Thread-2553) [n:127.0.0.1:36677_solr     ] 
o.a.s.c.SolrCore core reload testRepFactor1LeaderStartup_shard1_replica_n1
   [junit4]   2> 1493987 INFO  
(solrHandlerExecutor-15526-thread-1-processing-n:127.0.0.1:36677_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2) [n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2 x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
   [junit4]   2> 1493991 INFO  (Thread-2553) [n:127.0.0.1:36677_solr     ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.1
   [junit4]   2> 1493991 WARN  (Thread-2553) [n:127.0.0.1:36677_solr     ] 
o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use 
solr.xml:/metrics/reporter section instead
   [junit4]   2> 1493992 INFO  (Thread-2553) [n:127.0.0.1:36677_solr     ] 
o.a.s.s.IndexSchema Schema name=default-config
   [junit4]   2> 1494027 INFO  (Thread-2553) [n:127.0.0.1:36677_solr     ] 
o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
   [junit4]   2> 1494057 INFO  (Thread-2553) [n:127.0.0.1:36677_solr     ] 
o.a.s.c.CoreContainer Reloading SolrCore 
'testRepFactor1LeaderStartup_shard1_replica_n1' using configuration from 
configset testRepFactor1LeaderStartup.AUTOCREATED
   [junit4]   2> 1494058 INFO  (Thread-2553) [n:127.0.0.1:36677_solr     ] 
o.a.s.c.SolrCore [[testRepFactor1LeaderStartup_shard1_replica_n1] ] Opening new 
SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.10/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F907AE23393C524A-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.10/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F907AE23393C524A-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/data/]
   [junit4]   2> 1494093 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
expecting overlay version 0 but my version is -1
   [junit4]   2> 1494093 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.c.S.Request 
[testRepFactor1LeaderStartup_shard1_replica_n1]  webapp=/solr 
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0 
QTime=0
   [junit4]   2> 1494093 INFO  (SolrConfigHandler-refreshconf) [     ] 
o.a.s.h.SolrConfigHandler Another reload is in progress . Not doing anything
   [junit4]   2> 1494093 INFO  
(solrHandlerExecutor-15526-thread-1-processing-n:127.0.0.1:36677_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2) [n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2 x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.h.SolrConfigHandler Could not get expectedVersion 0 from 
https://127.0.0.1:36677/solr/testRepFactor1LeaderStartup_shard1_replica_n1/ for 
prop overlay   after 1 attempts
   [junit4]   2> 1494093 INFO  
(solrHandlerExecutor-15526-thread-1-processing-n:127.0.0.1:36677_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2) [n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2 x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.h.SolrConfigHandler Time elapsed : 0 secs, maxWait 30
   [junit4]   2> 1494095 INFO  (Thread-2553) [n:127.0.0.1:36677_solr     ] 
o.a.s.u.CommitTracker Hard AutoCommit: if uncommitted for 15000ms; 
   [junit4]   2> 1494095 INFO  (Thread-2553) [n:127.0.0.1:36677_solr     ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1494096 INFO  (Thread-2553) [n:127.0.0.1:36677_solr     ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/testRepFactor1LeaderStartup.AUTOCREATED
   [junit4]   2> 1494096 INFO  (Thread-2553) [n:127.0.0.1:36677_solr     ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/testRepFactor1LeaderStartup.AUTOCREATED
   [junit4]   2> 1494096 INFO  (Thread-2553) [n:127.0.0.1:36677_solr     ] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/managed-schema
   [junit4]   2> 1494097 INFO  (Thread-2553) [n:127.0.0.1:36677_solr     ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1494097 INFO  (Thread-2553) [n:127.0.0.1:36677_solr     ] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1494097 INFO  (Thread-2553) [n:127.0.0.1:36677_solr     ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxQueryFrequency=0.01,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4}
   [junit4]   2> 1494097 INFO  (Thread-2553) [n:127.0.0.1:36677_solr     ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1494098 INFO  (Thread-2553) [n:127.0.0.1:36677_solr     ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1712205643949015040
   [junit4]   2> 1494099 INFO  
(searcherExecutor-15528-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.QuerySenderListener QuerySenderListener 
done.
   [junit4]   2> 1494099 INFO  
(searcherExecutor-15528-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.h.c.SpellCheckComponent Loading spell index 
for spellchecker: default
   [junit4]   2> 1494099 INFO  
(searcherExecutor-15528-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.SolrCore 
[testRepFactor1LeaderStartup_shard1_replica_n1]  Registered new searcher 
autowarm time: 0 ms
   [junit4]   2> 1494100 INFO  (Thread-2553) [n:127.0.0.1:36677_solr     ] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1494101 INFO  
(searcherExecutor-15528-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.QuerySenderListener QuerySenderListener 
done.
   [junit4]   2> 1494101 INFO  
(searcherExecutor-15528-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.SolrCore 
[testRepFactor1LeaderStartup_shard1_replica_n1]  Registered new searcher 
autowarm time: 0 ms
   [junit4]   2> 1494194 INFO  (qtp2104740887-24674) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler I 
already have the expected version 0 of config
   [junit4]   2> 1494194 INFO  (qtp2104740887-24674) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
isStale false , resourceloader org.apache.solr.cloud.ZkSolrResourceLoader
   [junit4]   2> 1494194 INFO  (qtp2104740887-24674) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.c.S.Request 
[testRepFactor1LeaderStartup_shard1_replica_n1]  webapp=/solr 
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0 
QTime=0
   [junit4]   2> 1494196 INFO  (qtp2104740887-24673) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
Took 210.0ms to set the property overlay to be of version 0 for collection 
testRepFactor1LeaderStartup
   [junit4]   2> 1494196 INFO  (qtp2104740887-24673) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.c.S.Request 
[testRepFactor1LeaderStartup_shard1_replica_n1]  webapp=/solr path=/config 
params={wt=javabin&version=2} status=0 QTime=213
   [junit4]   2> 1494196 INFO  (qtp2104740887-24673) [n:127.0.0.1:36677_solr    
 ] o.a.s.c.SolrCore [testRepFactor1LeaderStartup_shard1_replica_n1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@1d77f4b8
   [junit4]   2> 1494196 INFO  (qtp2104740887-24673) [n:127.0.0.1:36677_solr    
 ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.testRepFactor1LeaderStartup.shard1.replica_n1 
tag=SolrCore@1d77f4b8
   [junit4]   2> 1494196 INFO  (qtp2104740887-24673) [n:127.0.0.1:36677_solr    
 ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.testRepFactor1LeaderStartup.shard1.leader 
tag=SolrCore@1d77f4b8
   [junit4]   2> 1494201 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.c.ZkShardTerms 
Successful update of terms at 
/collections/testRepFactor1LeaderStartup/terms/shard1 to 
Terms{values={core_node2=1}, version=1}
   [junit4]   2> 1494201 INFO  (qtp2104740887-24672) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.u.p.LogUpdateProcessorFactory 
[testRepFactor1LeaderStartup_shard1_replica_n1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[1 (1712205644054921216)]} 0 2
   [junit4]   2> 1494322 INFO  
(searcherExecutor-15528-thread-1-processing-n:127.0.0.1:36677_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2) [n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2 x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.c.QuerySenderListener QuerySenderListener done.
   [junit4]   2> 1494322 INFO  
(searcherExecutor-15528-thread-1-processing-n:127.0.0.1:36677_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2) [n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2 x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.c.SolrCore [testRepFactor1LeaderStartup_shard1_replica_n1]  Registered 
new searcher autowarm time: 0 ms
   [junit4]   2> 1494323 INFO  (qtp2104740887-24674) [n:127.0.0.1:36677_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.u.p.LogUpdateProcessorFactory 
[testRepFactor1LeaderStartup_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=testRepFactor1LeaderStartup:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 121
   [junit4]   2> 1494324 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1563463164
   [junit4]   2> 1494324 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:36677_solr
   [junit4]   2> 1494324 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.ZkController Publish this node as DOWN...
   [junit4]   2> 1494324 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.ZkController Publish node=127.0.0.1:36677_solr as DOWN
   [junit4]   2> 1494326 INFO  (coreCloseExecutor-15537-thread-1) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.SolrCore 
[testRepFactor1LeaderStartup_shard1_replica_n1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@49421158
   [junit4]   2> 1494326 INFO  (coreCloseExecutor-15537-thread-1) 
[n:127.0.0.1:36677_solr     ] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.core.testRepFactor1LeaderStartup.shard1.replica_n1 
tag=SolrCore@49421158
   [junit4]   2> 1494326 INFO  (coreCloseExecutor-15537-thread-1) 
[n:127.0.0.1:36677_solr     ] o.a.s.m.SolrMetricManager Closing metric 
reporters for 
registry=solr.collection.testRepFactor1LeaderStartup.shard1.leader 
tag=SolrCore@49421158
   [junit4]   2> 1494327 INFO  (coreCloseExecutor-15537-thread-1) 
[n:127.0.0.1:36677_solr     ] o.a.s.u.DirectUpdateHandler2 Committing on 
IndexWriter.close()  ... SKIPPED (unnecessary).
   [junit4]   2> 1494328 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.node tag=null
   [junit4]   2> 1494328 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jvm tag=null
   [junit4]   2> 1494328 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jetty tag=null
   [junit4]   2> 1494328 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.cluster tag=null
   [junit4]   2> 1494328 INFO  (closeThreadPool-15539-thread-2) [     ] 
o.a.s.c.Overseer Overseer 
(id=72489864089239557-127.0.0.1:36677_solr-n_0000000000) closing
   [junit4]   2> 1494328 INFO  
(OverseerStateUpdate-72489864089239557-127.0.0.1:36677_solr-n_0000000000) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:36677_solr
   [junit4]   2> 1494329 INFO  
(OverseerAutoScalingTriggerThread-72489864089239557-127.0.0.1:36677_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 1494331 INFO  (closeThreadPool-15539-thread-1) [     ] 
o.a.s.c.Overseer Overseer 
(id=72489864089239557-127.0.0.1:36677_solr-n_0000000000) closing
   [junit4]   2> 1494331 INFO  (zkCallback-15518-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 1494431 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.Overseer Overseer 
(id=72489864089239557-127.0.0.1:36677_solr-n_0000000000) closing
   [junit4]   2> 1494432 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.e.j.s.AbstractConnector Stopped ServerConnector@778ba767{SSL, (ssl, 
http/1.1)}{127.0.0.1:0}
   [junit4]   2> 1494432 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@49cf5d99{/solr,null,STOPPED}
   [junit4]   2> 1494432 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1494433 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.MiniSolrCloudCluster waitForJettyToStop: 36677
   [junit4]   2> 1494433 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.SolrCloudTestCase waitForState (testRepFactor1LeaderStartup): 
jetty count:1
   [junit4]   2> 1494434 INFO  (watches-15516-thread-1) [     ] 
o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
   [junit4]   2> 1494434 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica 
count: 0
   [junit4]   2> 1494435 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica 
count: 0
   [junit4]   2> 1494435 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica 
count: 0
   [junit4]   2> 1494435 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding 
port=36677)
   [junit4]   2> 1494436 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 36677 try 
number 2 ...
   [junit4]   2> 1494436 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 
2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 
1.8.0_291-b10
   [junit4]   2> 1494436 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1494436 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1494436 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1494437 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@59cd20a4{/solr,null,AVAILABLE}
   [junit4]   2> 1494437 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.e.j.s.AbstractConnector Started ServerConnector@3dc00458{SSL, (ssl, 
http/1.1)}{127.0.0.1:36677}
   [junit4]   2> 1494437 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.e.j.s.Server Started @1494515ms
   [junit4]   2> 1494437 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
zkHost=127.0.0.1:35919/solr, hostPort=36677}
   [junit4]   2> 1494438 ERROR 
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1494438 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1494438 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 8.10.1
   [junit4]   2> 1494438 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on 
port null
   [junit4]   2> 1494438 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.10/solr
   [junit4]   2> 1494438 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2021-09-29T03:35:47.380Z
   [junit4]   2> 1494439 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1494439 INFO  (zkConnectionManagerCallback-15541-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1494439 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1494439 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1494443 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.SolrXmlConfig Metrics collection is disabled.
   [junit4]   2> 1495594 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1495594 WARN  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 
transport since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 1495595 WARN  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@319ba490[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1495595 WARN  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@319ba490[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1495597 WARN  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 
transport since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 1495597 WARN  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@11ce6084[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1495597 WARN  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@11ce6084[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1495599 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35919/solr
   [junit4]   2> 1495599 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1495600 INFO  (zkConnectionManagerCallback-15552-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1495600 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1495702 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [n:127.0.0.1:36677_solr     ] o.a.s.c.c.ConnectionManager Waiting for client 
to connect to ZooKeeper
   [junit4]   2> 1495703 INFO  (zkConnectionManagerCallback-15554-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1495703 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [n:127.0.0.1:36677_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 1495706 WARN  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [n:127.0.0.1:36677_solr     ] o.a.s.c.ZkController Contents of zookeeper 
/security.json are world-readable; consider setting up ACLs as described in 
https://solr.apache.org/guide/zookeeper-access-control.html
   [junit4]   2> 1495729 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [n:127.0.0.1:36677_solr     ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:36677_solr
   [junit4]   2> 1495730 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [n:127.0.0.1:36677_solr     ] o.a.s.c.Overseer Overseer 
(id=72489864089239561-127.0.0.1:36677_solr-n_0000000001) starting
   [junit4]   2> 1495733 INFO  
(OverseerStateUpdate-72489864089239561-127.0.0.1:36677_solr-n_0000000001) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:36677_solr
   [junit4]   2> 1495733 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [n:127.0.0.1:36677_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:36677_solr
   [junit4]   2> 1495733 INFO  
(OverseerStateUpdate-72489864089239561-127.0.0.1:36677_solr-n_0000000001) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1495734 INFO  (zkCallback-15518-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1495736 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [n:127.0.0.1:36677_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 1495736 WARN  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [n:127.0.0.1:36677_solr     ] o.a.s.c.CoreContainer Not all security plugins 
configured!  authentication=disabled authorization=disabled.  Solr is only as 
secure as you make it. Consider configuring authentication/authorization before 
exposing Solr to users internal or external.  See 
https://s.apache.org/solrsecurity for more info
   [junit4]   2> 1495762 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [n:127.0.0.1:36677_solr     ] o.a.s.c.CorePropertiesLocator Found 1 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.10/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F907AE23393C524A-001/tempDir-001/node1
   [junit4]   2> 1495762 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [n:127.0.0.1:36677_solr     ] o.a.s.c.CorePropertiesLocator Cores are: 
[testRepFactor1LeaderStartup_shard1_replica_n1]
   [junit4]   2> 1495763 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient core cache for max 2147483647 cores with initial capacity of 1024
   [junit4]   2> 1495773 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 
8.10.1
   [junit4]   2> 1495773 WARN  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no 
longer supported, use solr.xml:/metrics/reporter section instead
   [junit4]   2> 1495776 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.s.IndexSchema Schema name=default-config
   [junit4]   2> 1495811 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr     ] o.a.s.s.IndexSchema Loaded schema 
default-config/1.6 with uniqueid field id
   [junit4]   2> 1495846 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 8.10.1
   [junit4]   2> 1495846 WARN  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.c.SolrConfig 
solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter 
section instead
   [junit4]   2> 1495846 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema 
name=default-config
   [junit4]   2> 1495883 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded 
schema default-config/1.6 with uniqueid field id
   [junit4]   2> 1495913 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.c.CoreContainer 
Creating SolrCore 'testRepFactor1LeaderStartup_shard1_replica_n1' using 
configuration from configset testRepFactor1LeaderStartup.AUTOCREATED, 
trusted=true
   [junit4]   2> 1495913 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.c.SolrCore 
[[testRepFactor1LeaderStartup_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.10/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F907AE23393C524A-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.10/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F907AE23393C524A-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/data/]
   [junit4]   2> 1495952 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1495952 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1495953 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard 
AutoCommit: if uncommitted for 15000ms; 
   [junit4]   2> 1495953 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 1495956 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/testRepFactor1LeaderStartup.AUTOCREATED
   [junit4]   2> 1495957 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/testRepFactor1LeaderStartup.AUTOCREATED
   [junit4]   2> 1495957 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader 
Creating ZooKeeper watch for the managed schema at 
/configs/testRepFactor1LeaderStartup.AUTOCREATED/managed-schema
   [junit4]   2> 1495957 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader 
Current schema version 0 is already the latest
   [junit4]   2> 1495957 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent 
Initializing spell checkers
   [junit4]   2> 1495957 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxQueryFrequency=0.01,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4}
   [junit4]   2> 1495958 INFO  
(coreLoadExecutor-15564-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] o.a.s.h.ReplicationHandler 
Commits will be reserved for 10000 ms
   [junit4]   2> 1495960 INFO  
(searcherExecutor-15566-thread-1-processing-n:127.0.0.1:36677_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2) [n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2 x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.c.QuerySenderListener QuerySenderListener done.
   [junit4]   2> 1495960 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=1
   [junit4]   2> 1495960 INFO  
(searcherExecutor-15566-thread-1-processing-n:127.0.0.1:36677_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2) [n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup 
s:shard1 r:core_node2 x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.c.TestCloudSearcherWarming Sleeping for 1000 on newSearcher: 
Searcher@2c758374[testRepFactor1LeaderStartup_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.10.1):C1:[diagnostics={java.vendor=Oracle
 Corporation, os=Linux, java.version=1.8.0_291, java.vm.version=25.291-b10, 
lucene.version=8.10.1, os.arch=amd64, java.runtime.version=1.8.0_291-b10, 
source=flush, os.version=4.15.0-147-generic, 
timestamp=1632886547146}]:[attributes={Lucene87StoredFieldsFormat.mode=BEST_SPEED}]
 :id=5e3ve66pna99oxvvbhvduemz7)))}, currentSearcher: null belonging to (newest) 
core: testRepFactor1LeaderStartup_shard1_replica_n1, id: 
org.apache.solr.core.SolrCore@1542607e
   [junit4]   2> 1495960 INFO  (watches-15516-thread-1) [     ] 
o.a.s.c.TestCloudSearcherWarming Collection state: 
DocCollection(testRepFactor1LeaderStartup//collections/testRepFactor1LeaderStartup/state.json/5
 )={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"1",
   [junit4]   2>   "shards":{"shard1":{
   [junit4]   2>       "range":"80000000-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{"core_node2":{
   [junit4]   2>           
"core":"testRepFactor1LeaderStartup_shard1_replica_n1",
   [junit4]   2>           "node_name":"127.0.0.1:36677_solr",
   [junit4]   2>           "base_url":"https://127.0.0.1:36677/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false",
   [junit4]   2>           "leader":"true"}}}},
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"1",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"1",
   [junit4]   2>   "tlogReplicas":"0"}
   [junit4]   2> 1495961 INFO  (watches-15516-thread-1) [     ] 
o.a.s.c.TestCloudSearcherWarming Collection state: 
DocCollection(testRepFactor1LeaderStartup//collections/testRepFactor1LeaderStartup/state.json/5
 )={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"1",
   [junit4]   2>   "shards":{"shard1":{
   [junit4]   2>       "range":"80000000-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{"core_node2":{
   [junit4]   2>           
"core":"testRepFactor1LeaderStartup_shard1_replica_n1",
   [junit4]   2>           "node_name":"127.0.0.1:36677_solr",
   [junit4]   2>           "base_url":"https://127.0.0.1:36677/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false",
   [junit4]   2>           "leader":"true"}}}},
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"1",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"1",
   [junit4]   2>   "tlogReplicas":"0"}
   [junit4]   2> 1495961 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.TestCloudSearcherWarming Collection state: 
DocCollection(testRepFactor1LeaderStartup//collections/testRepFactor1LeaderStartup/state.json/5
 )={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"1",
   [junit4]   2>   "shards":{"shard1":{
   [junit4]   2>       "range":"80000000-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{"core_node2":{
   [junit4]   2>           
"core":"testRepFactor1LeaderStartup_shard1_replica_n1",
   [junit4]   2>           "node_name":"127.0.0.1:36677_solr",
   [junit4]   2>           "base_url":"https://127.0.0.1:36677/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false",
   [junit4]   2>           "leader":"true"}}}},
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"1",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"1",
   [junit4]   2>   "tlogReplicas":"0"}
   [junit4]   2> 1495961 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.TestCloudSearcherWarming Collection state: 
DocCollection(testRepFactor1LeaderStartup//collections/testRepFactor1LeaderStartup/state.json/5
 )={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"1",
   [junit4]   2>   "shards":{"shard1":{
   [junit4]   2>       "range":"80000000-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{"core_node2":{
   [junit4]   2>           
"core":"testRepFactor1LeaderStartup_shard1_replica_n1",
   [junit4]   2>           "node_name":"127.0.0.1:36677_solr",
   [junit4]   2>           "base_url":"https://127.0.0.1:36677/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false",
   [junit4]   2>           "leader":"true"}}}},
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"1",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"1",
   [junit4]   2>   "tlogReplicas":"0"}
   [junit4]   2> 1495961 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.TestCloudSearcherWarming Collection state: 
DocCollection(testRepFactor1LeaderStartup//collections/testRepFactor1LeaderStartup/state.json/5
 )={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"1",
   [junit4]   2>   "shards":{"shard1":{
   [junit4]   2>       "range":"80000000-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{"core_node2":{
   [junit4]   2>           
"core":"testRepFactor1LeaderStartup_shard1_replica_n1",
   [junit4]   2>           "node_name":"127.0.0.1:36677_solr",
   [junit4]   2>           "base_url":"https://127.0.0.1:36677/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false",
   [junit4]   2>           "leader":"true"}}}},
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"1",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"1",
   [junit4]   2>   "tlogReplicas":"0"}
   [junit4]   2> 1495961 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F907AE23393C524A])
 [     ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: 
testRepFactor1LeaderStartup
   [junit4]   2> 1495964 INFO  
(coreZkRegister-15542-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/testRepFactor1LeaderStartup/leaders/shard1
   [junit4]   2> 1495965 INFO  
(coreZkRegister-15542-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1495965 INFO  
(coreZkRegister-15542-thread-1-processing-n:127.0.0.1:36677_solr) 
[n:127.0.0.1:36677_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1495966 INFO  
(coreZkRegister-15542-thread-1-processing-n:127.0.0.1:36677_solr) [n:12

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

SocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) 
[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 1514685 WARN  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        11      
/solr/collections/testPeersyncFailureReplicationSuccess/terms/shard1
   [junit4]   2>        7       
/solr/collections/testPeersyncFailureReplicationSuccess/state.json
   [junit4]   2>        4       /solr/aliases.json
   [junit4]   2>        3       
/solr/configs/testPeersyncFailureReplicationSuccess.AUTOCREATED
   [junit4]   2>        3       
/solr/configs/testPeersyncFailureReplicationSuccess.AUTOCREATED/managed-schema
   [junit4]   2>        2       /solr/packages.json
   [junit4]   2>        2       /solr/security.json
   [junit4]   2>        2       
/solr/collections/testPeersyncFailureReplicationSuccess/collectionprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        51      
/solr/collections/testPeersyncFailureReplicationSuccess/state.json
   [junit4]   2>        4       /solr/clusterstate.json
   [junit4]   2>        4       /solr/clusterprops.json
   [junit4]   2>        3       /solr/aliases.json
   [junit4]   2>        2       /solr/autoscaling.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        30      /solr/overseer/queue
   [junit4]   2>        17      /solr/overseer/collection-queue-work
   [junit4]   2>        11      
/solr/collections/testPeersyncFailureReplicationSuccess/state.json
   [junit4]   2>        10      /solr/live_nodes
   [junit4]   2>        9       /solr/collections
   [junit4]   2>        2       /solr/autoscaling/events/.scheduled_maintenance
   [junit4]   2>        2       /solr/autoscaling/events/.auto_add_replicas
   [junit4]   2>        2       /solr/overseer/queue-work
   [junit4]   2> 
   [junit4]   2> 1514688 INFO  
(TEST-TestCloudSearcherWarming.testPeersyncFailureReplicationSuccess-seed#[F907AE23393C524A])
 [     ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:34585
   [junit4]   2> 1514688 INFO  
(TEST-TestCloudSearcherWarming.testPeersyncFailureReplicationSuccess-seed#[F907AE23393C524A])
 [     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:34585
   [junit4]   2> 1514688 INFO  
(TEST-TestCloudSearcherWarming.testPeersyncFailureReplicationSuccess-seed#[F907AE23393C524A])
 [     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 34585
   [junit4]   2> 1514689 INFO  
(TEST-TestCloudSearcherWarming.testPeersyncFailureReplicationSuccess-seed#[F907AE23393C524A])
 [     ] o.a.s.SolrTestCaseJ4 ###Ending testPeersyncFailureReplicationSuccess
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestCloudSearcherWarming 
-Dtests.method=testPeersyncFailureReplicationSuccess 
-Dtests.seed=F907AE23393C524A -Dtests.multiplier=2 -Dtests.slow=true 
-Dtests.locale=cs-CZ -Dtests.timezone=America/Argentina/Catamarca 
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   17.0s J0 | 
TestCloudSearcherWarming.testPeersyncFailureReplicationSuccess <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: No 
registered leader was found after waiting for 1000ms , collection: 
testPeersyncFailureReplicationSuccess slice: shard1 saw 
state=DocCollection(testPeersyncFailureReplicationSuccess//collections/testPeersyncFailureReplicationSuccess/state.json/10
 )={
   [junit4]    >   "pullReplicas":"0",
   [junit4]    >   "replicationFactor":"1",
   [junit4]    >   "shards":{"shard1":{
   [junit4]    >       "range":"80000000-7fffffff",
   [junit4]    >       "state":"active",
   [junit4]    >       "replicas":{
   [junit4]    >         "core_node2":{
   [junit4]    >           
"core":"testPeersyncFailureReplicationSuccess_shard1_replica_n1",
   [junit4]    >           "node_name":"127.0.0.1:44583_solr",
   [junit4]    >           "base_url":"https://127.0.0.1:44583/solr";,
   [junit4]    >           "state":"down",
   [junit4]    >           "type":"NRT",
   [junit4]    >           "force_set_state":"false"},
   [junit4]    >         "core_node4":{
   [junit4]    >           
"core":"testPeersyncFailureReplicationSuccess_shard1_replica_n3",
   [junit4]    >           "node_name":"127.0.0.1:35639_solr",
   [junit4]    >           "base_url":"https://127.0.0.1:35639/solr";,
   [junit4]    >           "state":"active",
   [junit4]    >           "type":"NRT",
   [junit4]    >           "force_set_state":"false"}}}},
   [junit4]    >   "router":{"name":"compositeId"},
   [junit4]    >   "maxShardsPerNode":"2",
   [junit4]    >   "autoAddReplicas":"false",
   [junit4]    >   "nrtReplicas":"1",
   [junit4]    >   "tlogReplicas":"0"} with live_nodes=[127.0.0.1:35639_solr]
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([F907AE23393C524A:2D56CD6CE8826529]:0)
   [junit4]    >        at 
org.apache.solr.common.cloud.ZkStateReader.getLeaderRetry(ZkStateReader.java:993)
   [junit4]    >        at 
org.apache.solr.common.cloud.ZkStateReader.getLeaderRetry(ZkStateReader.java:968)
   [junit4]    >        at 
org.apache.solr.cloud.TestCloudSearcherWarming.testPeersyncFailureReplicationSuccess(TestCloudSearcherWarming.java:205)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.10/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F907AE23393C524A-001
   [junit4]   2> Sep 29, 2021 3:36:07 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene87): {}, 
docValues:{}, maxPointsInLeafNode=270, maxMBSortInHeap=6.433769446686843, 
sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=cs-CZ, 
timezone=America/Argentina/Catamarca
   [junit4]   2> NOTE: Linux 4.15.0-147-generic amd64/Oracle Corporation 
1.8.0_291 (64-bit)/cpus=4,threads=1,free=217947168,total=488636416
   [junit4]   2> NOTE: All tests run in this JVM: [TestPullReplica, 
SpatialRPTFieldTypeTest, SearchHandlerTest, TestObjectReleaseTracker, 
CopyFieldTest, UniqFieldsUpdateProcessorFactoryTest, 
TestAtomicUpdateErrorCases, OutputWriterTest, AliasIntegrationTest, 
TestPayloadCheckQParserPlugin, TestFieldResource, TestCloudPivotFacet, 
TestRetrieveFieldsOptimizer, TestLRUCache, FileBasedSpellCheckerTest, 
TestJsonFacetErrors, TestSchemalessBufferedUpdates, BaseCdcrDistributedZkTest, 
TestXIncludeConfig, DistributedVersionInfoTest, 
TestRuleBasedAuthorizationWithKerberos, CoreAdminHandlerTest, TestJsonRequest, 
OverseerTest, ShowFileRequestHandlerTest, TestSchemaResource, DeleteNodeTest, 
TestFilteredDocIdSet, ConcurrentCreateCollectionTest, TestSimScenario, 
AutoAddReplicasIntegrationTest, MetricsHistoryIntegrationTest, JsonLoaderTest, 
SystemInfoHandlerTest, PathHierarchyTokenizerFactoryTest, 
IndexSizeTriggerSizeEstimationTest, BasicZkTest, RecoveryZkTest, 
MetricsHistoryHandlerTest, AtomicUpdatesTest, DirectSolrConnectionTest, 
CustomHighlightComponentTest, TestSQLHandler, TestNonDefinedSimilarityFactory, 
CreateCollectionCleanupTest, MoreLikeThisComponentTest, DistanceFunctionTest, 
TestJsonFacetsWithNestedObjects, TestInPlaceUpdatesDistrib, 
NodeAddedTriggerIntegrationTest, RandomizedTaggerTest, CircularListTest, 
PreAnalyzedUpdateProcessorTest, LeaderFailureAfterFreshStartTest, 
TestNestedDocsSort, SolrJmxReporterCloudTest, TestExpandComponent, 
LeaderElectionContextKeyTest, TestDistribDocBasedVersion, DocValuesMissingTest, 
ConfigureRecoveryStrategyTest, DistributedQueryComponentCustomSortTest, 
TestReplicationHandlerBackup, TriLevelCompositeIdRoutingTest, 
TestCloudDeduplication, ZkCollectionPropsCachingTest, 
MoveReplicaHDFSFailoverTest, CdcrReplicationHandlerTest, 
TestSimpleQParserPlugin, SignatureUpdateProcessorFactoryTest, 
CurrencyRangeFacetCloudTest, TestNestedUpdateProcessor, 
TestIBSimilarityFactory, TestStressRecovery, TestConfigSetsAPIShareSchema, 
TestHalfAndHalfDocValues, TestUninvertingReader, TestExplainDocTransformer, 
TestSolrCachePerf, TestQueryUtils, ClassificationUpdateProcessorTest, 
TestExclusionRuleCollectionAccess, SolrCoreCheckLockOnStartupTest, 
BinaryUpdateRequestHandlerTest, ZkControllerTest, RouteFieldTest, 
SolrShardReporterTest, DataDrivenBlockJoinTest, TestNumericRangeQuery32, 
JvmMetricsTest, SliceStateTest, TestBlockCollapse, TestExactStatsCache, 
DisMaxRequestHandlerTest, TestUnifiedSolrHighlighterWithoutStoredId, 
TestSimLargeCluster, TestSolrQueryParser, SecurityHeadersTest, PrimUtilsTest, 
TestXmlQParser, TestReload, DistributedUpdateProcessorTest, 
TestElisionMultitermQuery, TestContainerPlugin, MaxSizeAutoCommitTest, 
MetricUtilsTest, SolrIndexSearcherTest, TestTlogReplica, 
TestSurroundQueryParser, CollectionReloadTest, TestLuceneIndexBackCompat, 
TestUseDocValuesAsStored2, BlockJoinFacetSimpleTest, TestDynamicLoadingUrl, 
ZkSolrClientTest, TestDistributedMissingSort, ConvertedLegacyTest, 
SolrTestCaseJ4DeleteCoreTest, SolrTestCaseJ4Test, TestCrossCoreJoin, 
TestHighlightDedupGrouping, TestRandomDVFaceting, TestDeprecatedFilters, 
TestReversedWildcardFilterFactory, TestJettySolrRunner, ActionThrottleTest, 
BasicDistributedZkTest, ClusterStateMockUtilTest, ClusterStateTest, 
ClusterStateUpdateTest, CollectionStateFormat2Test, DistribCursorPagingTest, 
DistribJoinFromCollectionTest, DistributedQueueTest, 
FullSolrCloudDistribCmdsTest, HttpPartitionOnCommitTest, 
NestedShardedAtomicUpdateTest, NodeMutatorTest, 
OutOfBoxZkACLAndCredentialsProvidersTest, 
OverriddenZkACLAndCredentialsProvidersTest, 
OverseerCollectionConfigSetProcessorTest, OverseerModifyCollectionTest, 
OverseerRolesTest, ReplaceNodeTest, ShardRoutingTest, 
SystemCollectionCompatTest, TestAuthenticationFramework, 
TestCloudDeleteByQuery, TestCloudInspectUtil, 
TestCloudPhrasesIdentificationComponent, TestCloudSearcherWarming]
   [junit4] Completed [550/947 (1!)] on J0 in 23.53s, 2 tests, 1 error <<< 
FAILURES!

[...truncated 55579 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to