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

2 tests failed.
FAILED:  
org.apache.solr.cloud.TestCloudSearcherWarming.testRepFactor1LeaderStartup

Error Message:
 null Live Nodes: [127.0.0.1:40523_solr] Last available state: 
DocCollection(testRepFactor1LeaderStartup//collections/testRepFactor1LeaderStartup/state.json/5)={
   "pullReplicas":"0",   "replicationFactor":"1",   "shards":{"shard1":{       
"range":"80000000-7fffffff",       "state":"active",       
"replicas":{"core_node2":{           
"core":"testRepFactor1LeaderStartup_shard1_replica_n1",           
"base_url":"http://127.0.0.1:40523/solr";,           
"node_name":"127.0.0.1:40523_solr",           "state":"active",           
"type":"NRT",           "leader":"true"}}}},   "router":{"name":"compositeId"}, 
  "maxShardsPerNode":"1",   "autoAddReplicas":"false",   "nrtReplicas":"1",   
"tlogReplicas":"0"}

Stack Trace:
java.lang.AssertionError: 
null
Live Nodes: [127.0.0.1:40523_solr]
Last available state: 
DocCollection(testRepFactor1LeaderStartup//collections/testRepFactor1LeaderStartup/state.json/5)={
  "pullReplicas":"0",
  "replicationFactor":"1",
  "shards":{"shard1":{
      "range":"80000000-7fffffff",
      "state":"active",
      "replicas":{"core_node2":{
          "core":"testRepFactor1LeaderStartup_shard1_replica_n1",
          "base_url":"http://127.0.0.1:40523/solr";,
          "node_name":"127.0.0.1:40523_solr",
          "state":"active",
          "type":"NRT",
          "leader":"true"}}}},
  "router":{"name":"compositeId"},
  "maxShardsPerNode":"1",
  "autoAddReplicas":"false",
  "nrtReplicas":"1",
  "tlogReplicas":"0"}
        at 
__randomizedtesting.SeedInfo.seed([F3F26008472333D7:24DA2DD056C37A39]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at 
org.apache.solr.cloud.SolrCloudTestCase.waitForState(SolrCloudTestCase.java:269)
        at 
org.apache.solr.cloud.TestCloudSearcherWarming.testRepFactor1LeaderStartup(TestCloudSearcherWarming.java:126)
        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:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  
org.apache.solr.cloud.TestCloudSearcherWarming.testPeersyncFailureReplicationSuccess

Error Message:
0

Stack Trace:
java.lang.ArrayIndexOutOfBoundsException: 0
        at 
__randomizedtesting.SeedInfo.seed([F3F26008472333D7:27A30347969D04B4]:0)
        at 
java.util.concurrent.CopyOnWriteArrayList.get(CopyOnWriteArrayList.java:387)
        at 
java.util.concurrent.CopyOnWriteArrayList.get(CopyOnWriteArrayList.java:396)
        at 
org.apache.solr.cloud.MiniSolrCloudCluster.getJettySolrRunner(MiniSolrCloudCluster.java:367)
        at 
org.apache.solr.cloud.TestCloudSearcherWarming.testPeersyncFailureReplicationSuccess(TestCloudSearcherWarming.java:141)
        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:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 12712 lines...]
   [junit4] Suite: org.apache.solr.cloud.TestCloudSearcherWarming
   [junit4]   2> 3875596 INFO  
(SUITE-TestCloudSearcherWarming-seed#[F3F26008472333D7]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/init-core-data-001
   [junit4]   2> 3875596 WARN  
(SUITE-TestCloudSearcherWarming-seed#[F3F26008472333D7]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=9 numCloses=9
   [junit4]   2> 3875596 INFO  
(SUITE-TestCloudSearcherWarming-seed#[F3F26008472333D7]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 3875626 INFO  
(SUITE-TestCloudSearcherWarming-seed#[F3F26008472333D7]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 3875627 INFO  
(SUITE-TestCloudSearcherWarming-seed#[F3F26008472333D7]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001
   [junit4]   2> 3875627 INFO  
(SUITE-TestCloudSearcherWarming-seed#[F3F26008472333D7]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 3875650 INFO  (Thread-6885) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 3875650 INFO  (Thread-6885) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 3875670 ERROR (Thread-6885) [    ] o.a.z.s.ZooKeeperServer 
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action 
on ERROR or SHUTDOWN server state changes
   [junit4]   2> 3875755 INFO  
(SUITE-TestCloudSearcherWarming-seed#[F3F26008472333D7]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:33602
   [junit4]   2> 3875787 INFO  (jetty-launcher-1954-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 3875820 INFO  (jetty-launcher-1954-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3822f462{/solr,null,AVAILABLE}
   [junit4]   2> 3875833 INFO  (jetty-launcher-1954-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@4d5d0def{HTTP/1.1,[http/1.1]}{127.0.0.1:40523}
   [junit4]   2> 3875833 INFO  (jetty-launcher-1954-thread-1) [    ] 
o.e.j.s.Server Started @3887671ms
   [junit4]   2> 3875833 INFO  (jetty-launcher-1954-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=40523}
   [junit4]   2> 3875833 ERROR (jetty-launcher-1954-thread-1) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 3875834 INFO  (jetty-launcher-1954-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 3875834 INFO  (jetty-launcher-1954-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 3875834 INFO  (jetty-launcher-1954-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 3875834 INFO  (jetty-launcher-1954-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-08-10T09:08:30.665Z
   [junit4]   2> 3875853 INFO  (jetty-launcher-1954-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 3875859 INFO  (jetty-launcher-1954-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33602/solr
   [junit4]   2> 3876115 INFO  (jetty-launcher-1954-thread-1) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 3876115 INFO  (jetty-launcher-1954-thread-1) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:40523_solr
   [junit4]   2> 3876116 INFO  (jetty-launcher-1954-thread-1) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.Overseer Overseer 
(id=98458410056548355-127.0.0.1:40523_solr-n_0000000000) starting
   [junit4]   2> 3876128 INFO  (jetty-launcher-1954-thread-1) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:40523_solr
   [junit4]   2> 3876153 INFO  
(OverseerStateUpdate-98458410056548355-127.0.0.1:40523_solr-n_0000000000) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 3876552 INFO  (jetty-launcher-1954-thread-1) 
[n:127.0.0.1:40523_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40523.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@47d01e93
   [junit4]   2> 3876555 INFO  (jetty-launcher-1954-thread-1) 
[n:127.0.0.1:40523_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40523.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@47d01e93
   [junit4]   2> 3876555 INFO  (jetty-launcher-1954-thread-1) 
[n:127.0.0.1:40523_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40523.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@47d01e93
   [junit4]   2> 3876568 INFO  (jetty-launcher-1954-thread-1) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/.
   [junit4]   2> 3876667 INFO  
(SUITE-TestCloudSearcherWarming-seed#[F3F26008472333D7]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 3876668 INFO  
(SUITE-TestCloudSearcherWarming-seed#[F3F26008472333D7]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33602/solr ready
   [junit4]   2> 3876711 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F3F26008472333D7])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testRepFactor1LeaderStartup
   [junit4]   2> 3876713 INFO  (qtp1163828572-16937) [n:127.0.0.1:40523_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params 
name=testRepFactor1LeaderStartup&action=DELETE&wt=javabin&version=2 and 
sendToOCPQueue=true
   [junit4]   2> 3876725 INFO  
(OverseerThreadFactory-5402-thread-1-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.OverseerCollectionMessageHandler Executing 
Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true
   [junit4]   2> 3876725 ERROR 
(OverseerThreadFactory-5402-thread-1-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.OverseerCollectionMessageHandler 
Collection: testRepFactor1LeaderStartup operation: delete 
failed:org.apache.solr.common.SolrException: Could not find collection : 
testRepFactor1LeaderStartup
   [junit4]   2>        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:109)
   [junit4]   2>        at 
org.apache.solr.cloud.OverseerCollectionMessageHandler.collectionCmd(OverseerCollectionMessageHandler.java:795)
   [junit4]   2>        at 
org.apache.solr.cloud.DeleteCollectionCmd.call(DeleteCollectionCmd.java:88)
   [junit4]   2>        at 
org.apache.solr.cloud.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:227)
   [junit4]   2>        at 
org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:464)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 3876738 INFO  (qtp1163828572-16937) [n:127.0.0.1:40523_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={name=testRepFactor1LeaderStartup&action=DELETE&wt=javabin&version=2} 
status=400 QTime=24
   [junit4]   2> 3876738 INFO  (qtp1163828572-16938) [n:127.0.0.1:40523_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params 
name=testPeersyncFailureReplicationSuccess&action=DELETE&wt=javabin&version=2 
and sendToOCPQueue=true
   [junit4]   2> 3876763 INFO  
(OverseerCollectionConfigSetProcessor-98458410056548355-127.0.0.1:40523_solr-n_0000000000)
 [n:127.0.0.1:40523_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 3876764 INFO  
(OverseerThreadFactory-5402-thread-2-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.OverseerCollectionMessageHandler Executing 
Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true
   [junit4]   2> 3876764 ERROR 
(OverseerThreadFactory-5402-thread-2-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.OverseerCollectionMessageHandler 
Collection: testPeersyncFailureReplicationSuccess operation: delete 
failed:org.apache.solr.common.SolrException: Could not find collection : 
testPeersyncFailureReplicationSuccess
   [junit4]   2>        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:109)
   [junit4]   2>        at 
org.apache.solr.cloud.OverseerCollectionMessageHandler.collectionCmd(OverseerCollectionMessageHandler.java:795)
   [junit4]   2>        at 
org.apache.solr.cloud.DeleteCollectionCmd.call(DeleteCollectionCmd.java:88)
   [junit4]   2>        at 
org.apache.solr.cloud.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:227)
   [junit4]   2>        at 
org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:464)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 3876780 INFO  (qtp1163828572-16938) [n:127.0.0.1:40523_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={name=testPeersyncFailureReplicationSuccess&action=DELETE&wt=javabin&version=2}
 status=400 QTime=41
   [junit4]   2> 3876781 INFO  (qtp1163828572-16939) [n:127.0.0.1:40523_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
pullReplicas=0&replicationFactor=1&name=testRepFactor1LeaderStartup&nrtReplicas=1&action=CREATE&numShards=1&tlogReplicas=0&createNodeSet=127.0.0.1:40523_solr&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 3876794 INFO  
(OverseerCollectionConfigSetProcessor-98458410056548355-127.0.0.1:40523_solr-n_0000000000)
 [n:127.0.0.1:40523_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000002 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 3876795 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
testRepFactor1LeaderStartup
   [junit4]   2> 3876795 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.CreateCollectionCmd Only _default config 
set found, using it.
   [junit4]   2> 3876805 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/protwords.txt to 
/configs/testRepFactor1LeaderStartup/protwords.txt
   [junit4]   2> 3876832 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/managed-schema to 
/configs/testRepFactor1LeaderStartup/managed-schema
   [junit4]   2> 3876845 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/solrconfig.xml to 
/configs/testRepFactor1LeaderStartup/solrconfig.xml
   [junit4]   2> 3876847 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/synonyms.txt to 
/configs/testRepFactor1LeaderStartup/synonyms.txt
   [junit4]   2> 3876848 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/stopwords.txt to 
/configs/testRepFactor1LeaderStartup/stopwords.txt
   [junit4]   2> 3876849 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/params.json to 
/configs/testRepFactor1LeaderStartup/params.json
   [junit4]   2> 3876850 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_it.txt to 
/configs/testRepFactor1LeaderStartup/lang/contractions_it.txt
   [junit4]   2> 3876851 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_no.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_no.txt
   [junit4]   2> 3876852 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_hy.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_hy.txt
   [junit4]   2> 3876869 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stemdict_nl.txt to 
/configs/testRepFactor1LeaderStartup/lang/stemdict_nl.txt
   [junit4]   2> 3876870 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_ca.txt to 
/configs/testRepFactor1LeaderStartup/lang/contractions_ca.txt
   [junit4]   2> 3876871 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_id.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_id.txt
   [junit4]   2> 3876872 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ga.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_ga.txt
   [junit4]   2> 3876872 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_da.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_da.txt
   [junit4]   2> 3876886 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_hi.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_hi.txt
   [junit4]   2> 3876886 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ja.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_ja.txt
   [junit4]   2> 3876887 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_pt.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_pt.txt
   [junit4]   2> 3876888 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_hu.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_hu.txt
   [junit4]   2> 3876888 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_el.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_el.txt
   [junit4]   2> 3876902 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ru.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_ru.txt
   [junit4]   2> 3876905 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_tr.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_tr.txt
   [junit4]   2> 3876918 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ar.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_ar.txt
   [junit4]   2> 3876919 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/userdict_ja.txt to 
/configs/testRepFactor1LeaderStartup/lang/userdict_ja.txt
   [junit4]   2> 3876920 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_it.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_it.txt
   [junit4]   2> 3876931 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_eu.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_eu.txt
   [junit4]   2> 3876932 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_cz.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_cz.txt
   [junit4]   2> 3876933 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stoptags_ja.txt to 
/configs/testRepFactor1LeaderStartup/lang/stoptags_ja.txt
   [junit4]   2> 3876943 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_fr.txt to 
/configs/testRepFactor1LeaderStartup/lang/contractions_fr.txt
   [junit4]   2> 3876943 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_fa.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_fa.txt
   [junit4]   2> 3876944 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_de.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_de.txt
   [junit4]   2> 3876945 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_ga.txt to 
/configs/testRepFactor1LeaderStartup/lang/contractions_ga.txt
   [junit4]   2> 3876946 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ca.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_ca.txt
   [junit4]   2> 3876959 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_nl.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_nl.txt
   [junit4]   2> 3876960 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_bg.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_bg.txt
   [junit4]   2> 3876961 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_es.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_es.txt
   [junit4]   2> 3876975 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_en.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_en.txt
   [junit4]   2> 3876976 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_lv.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_lv.txt
   [junit4]   2> 3876977 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_th.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_th.txt
   [junit4]   2> 3876978 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ro.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_ro.txt
   [junit4]   2> 3876991 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_fr.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_fr.txt
   [junit4]   2> 3876992 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_sv.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_sv.txt
   [junit4]   2> 3876993 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_fi.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_fi.txt
   [junit4]   2> 3876994 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/hyphenations_ga.txt to 
/configs/testRepFactor1LeaderStartup/lang/hyphenations_ga.txt
   [junit4]   2> 3877011 INFO  
(OverseerThreadFactory-5402-thread-3-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_gl.txt to 
/configs/testRepFactor1LeaderStartup/lang/stopwords_gl.txt
   [junit4]   2> 3877158 INFO  
(OverseerStateUpdate-98458410056548355-127.0.0.1:40523_solr-n_0000000000) 
[n:127.0.0.1:40523_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testRepFactor1LeaderStartup",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testRepFactor1LeaderStartup_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:40523/solr";,
   [junit4]   2>   "type":"NRT"} 
   [junit4]   2> 3877390 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node2&collection.configName=testRepFactor1LeaderStartup&newCollection=true&name=testRepFactor1LeaderStartup_shard1_replica_n1&action=CREATE&numShards=1&collection=testRepFactor1LeaderStartup&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 3877390 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 3877511 INFO  
(zkCallback-1961-thread-2-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] 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> 3877511 INFO  
(zkCallback-1961-thread-1-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] 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> 3878528 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.c.RequestParams conf 
resource params.json loaded . version : 0 
   [junit4]   2> 3878528 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.c.RequestParams request 
params refreshed to version 0
   [junit4]   2> 3878529 WARN  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't 
add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../contrib/extraction/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../contrib/extraction/lib
   [junit4]   2> 3878529 WARN  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't 
add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../dist
 filtered by solr-cell-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../dist
   [junit4]   2> 3878529 WARN  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't 
add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../contrib/clustering/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../contrib/clustering/lib
   [junit4]   2> 3878529 WARN  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't 
add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../dist
 filtered by solr-clustering-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../dist
   [junit4]   2> 3878530 WARN  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't 
add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../contrib/langid/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../contrib/langid/lib
   [junit4]   2> 3878542 WARN  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't 
add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../dist
 filtered by solr-langid-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../dist
   [junit4]   2> 3878558 WARN  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't 
add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../contrib/velocity/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../contrib/velocity/lib
   [junit4]   2> 3878558 WARN  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't 
add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../dist
 filtered by solr-velocity-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../dist
   [junit4]   2> 3878577 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 8.0.0
   [junit4]   2> 3878845 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.s.IndexSchema 
[testRepFactor1LeaderStartup_shard1_replica_n1] Schema name=default-config
   [junit4]   2> 3879534 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_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> 3879634 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_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 collection testRepFactor1LeaderStartup, trusted=true
   [junit4]   2> 3879635 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 
'solr_40523.solr.core.testRepFactor1LeaderStartup.shard1.replica_n1' (registry 
'solr.core.testRepFactor1LeaderStartup.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@47d01e93
   [junit4]   2> 3879635 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 3879635 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_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-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/./testRepFactor1LeaderStartup_shard1_replica_n1/data/]
   [junit4]   2> 3879698 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.r.XSLTResponseWriter 
xsltCacheLifetimeSeconds=5
   [junit4]   2> 3879870 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_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> 3879870 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_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> 3879871 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.u.CommitTracker Hard 
AutoCommit: if uncommited for 15000ms; 
   [junit4]   2> 3879871 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 3879873 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@6043429a[testRepFactor1LeaderStartup_shard1_replica_n1] main]
   [junit4]   2> 3879883 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: 
/configs/testRepFactor1LeaderStartup
   [junit4]   2> 3879884 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_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
   [junit4]   2> 3879884 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_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/managed-schema
   [junit4]   2> 3879886 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_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> 3879886 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.c.SpellCheckComponent 
Initializing spell checkers
   [junit4]   2> 3879886 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_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,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
   [junit4]   2> 3879888 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 3879888 INFO  
(searcherExecutor-5405-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.c.QuerySenderListener 
QuerySenderListener sending requests to 
Searcher@6043429a[testRepFactor1LeaderStartup_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 3879888 INFO  
(searcherExecutor-5405-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.c.QuerySenderListener 
QuerySenderListener done.
   [junit4]   2> 3879888 INFO  
(searcherExecutor-5405-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_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> 3879889 INFO  
(searcherExecutor-5405-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_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 
Searcher@6043429a[testRepFactor1LeaderStartup_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 3879889 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_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 1575334565348638720
   [junit4]   2> 3879916 INFO  
(zkCallback-1961-thread-2-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] 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> 3879916 INFO  
(zkCallback-1961-thread-1-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] 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> 3879917 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_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> 3879917 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_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> 3879917 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.c.SyncStrategy Sync 
replicas to 
http://127.0.0.1:40523/solr/testRepFactor1LeaderStartup_shard1_replica_n1/
   [junit4]   2> 3879918 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_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> 3879918 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.c.SyncStrategy 
http://127.0.0.1:40523/solr/testRepFactor1LeaderStartup_shard1_replica_n1/ has 
no replicas
   [junit4]   2> 3879918 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 3879940 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:40523/solr/testRepFactor1LeaderStartup_shard1_replica_n1/ 
shard1
   [junit4]   2> 3880046 INFO  
(zkCallback-1961-thread-1-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] 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> 3880046 INFO  
(zkCallback-1961-thread-2-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] 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> 3880098 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_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> 3880101 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=testRepFactor1LeaderStartup&newCollection=true&name=testRepFactor1LeaderStartup_shard1_replica_n1&action=CREATE&numShards=1&collection=testRepFactor1LeaderStartup&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2711
   [junit4]   2> 3880116 INFO  (qtp1163828572-16939) [n:127.0.0.1:40523_solr    
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 3880221 INFO  
(zkCallback-1961-thread-1-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] 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> 3880222 INFO  
(zkCallback-1961-thread-2-processing-n:127.0.0.1:40523_solr) 
[n:127.0.0.1:40523_solr    ] 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> 3880818 INFO  
(OverseerCollectionConfigSetProcessor-98458410056548355-127.0.0.1:40523_solr-n_0000000000)
 [n:127.0.0.1:40523_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000004 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 3881122 INFO  (qtp1163828572-16939) [n:127.0.0.1:40523_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={pullReplicas=0&replicationFactor=1&name=testRepFactor1LeaderStartup&nrtReplicas=1&action=CREATE&numShards=1&tlogReplicas=0&createNodeSet=127.0.0.1:40523_solr&wt=javabin&version=2}
 status=0 QTime=4341
   [junit4]   2> java.lang.RuntimeException
   [junit4]   2>        at 
org.apache.solr.cloud.TestCloudSearcherWarming$SleepingSolrEventListener.init(TestCloudSearcherWarming.java:306)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.createInitInstance(SolrCore.java:826)
   [junit4]   2>        at 
org.apache.solr.handler.SolrConfigHandler$Command.verifyClass(SolrConfigHandler.java:562)
   [junit4]   2>        at 
org.apache.solr.handler.SolrConfigHandler$Command.updateNamedPlugin(SolrConfigHandler.java:533)
   [junit4]   2>        at 
org.apache.solr.handler.SolrConfigHandler$Command.handleCommands(SolrConfigHandler.java:482)
   [junit4]   2>        at 
org.apache.solr.handler.SolrConfigHandler$Command.handlePOST(SolrConfigHandler.java:346)
   [junit4]   2>        at 
org.apache.solr.handler.SolrConfigHandler$Command.access$100(SolrConfigHandler.java:159)
   [junit4]   2>        at 
org.apache.solr.handler.SolrConfigHandler.handleRequestBody(SolrConfigHandler.java:137)
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.execute(SolrCore.java:2482)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:720)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:526)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:378)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:322)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
   [junit4]   2>        at 
org.eclipse.jetty.server.Server.handle(Server.java:534)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
   [junit4]   2>        at 
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   1> {event=newSearcher}
   [junit4]   2> java.lang.RuntimeException
   [junit4]   2>        at 
org.apache.solr.cloud.TestCloudSearcherWarming$SleepingSolrEventListener.init(TestCloudSearcherWarming.java:306)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.createInitInstance(SolrCore.java:826)
   [junit4]   2>        at 
org.apache.solr.handler.SolrConfigHandler$Command.verifyClass(SolrConfigHandler.java:562)
   [junit4]   2>        at 
org.apache.solr.handler.SolrConfigHandler$Command.updateNamedPlugin(SolrConfigHandler.java:533)
   [junit4]   2>        at 
org.apache.solr.handler.SolrConfigHandler$Command.handleCommands(SolrConfigHandler.java:482)
   [junit4]   2>        at 
org.apache.solr.handler.SolrConfigHandler$Command.handlePOST(SolrConfigHandler.java:346)
   [junit4]   2>        at 
org.apache.solr.handler.SolrConfigHandler$Command.access$100(SolrConfigHandler.java:159)
   [junit4]   2>        at 
org.apache.solr.handler.SolrConfigHandler.handleRequestBody(SolrConfigHandler.java:137)
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.execute(SolrCore.java:2482)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:720)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:526)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:378)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:322)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
   [junit4]   2>        at 
org.eclipse.jetty.server.Server.handle(Server.java:534)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
   [junit4]   2>        at 
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   1> {event=firstSearcher}
   [junit4]   2> 3881253 INFO  (qtp1163828572-16940) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.SolrConfigHandler 
Executed config commands successfully and persisted to ZK [{"add-listener":{
   [junit4]   2>     "name":"newSearcherListener",
   [junit4]   2>     "event":"newSearcher",
   [junit4]   2>     
"class":"org.apache.solr.cloud.TestCloudSearcherWarming$SleepingSolrEventListener"}},
 {"add-listener":{
   [junit4]   2>     "name":"firstSearcherListener",
   [junit4]   2>     "event":"firstSearcher",
   [junit4]   2>     
"class":"org.apache.solr.cloud.TestCloudSearcherWarming$SleepingSolrEventListener"}}]
   [junit4]   2> 3881253 INFO  (qtp1163828572-16940) [n:127.0.0.1:40523_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> 3881253 INFO  (Thread-6895) [n:127.0.0.1:40523_solr    ] 
o.a.s.c.SolrCore config update listener called for core 
testRepFactor1LeaderStartup_shard1_replica_n1
   [junit4]   2> 3881254 INFO  (Thread-6895) [n:127.0.0.1:40523_solr    ] 
o.a.s.c.SolrCore core reload testRepFactor1LeaderStartup_shard1_replica_n1
   [junit4]   2> 3881276 INFO  
(solrHandlerExecutor-5410-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_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> 3881359 INFO  (Thread-6895) [n:127.0.0.1:40523_solr    ] 
o.a.s.c.RequestParams conf resource params.json loaded . version : 0 
   [junit4]   2> 3881359 INFO  (Thread-6895) [n:127.0.0.1:40523_solr    ] 
o.a.s.c.RequestParams request params refreshed to version 0
   [junit4]   2> 3881360 WARN  (Thread-6895) [n:127.0.0.1:40523_solr    ] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../contrib/extraction/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../contrib/extraction/lib
   [junit4]   2> 3881360 WARN  (Thread-6895) [n:127.0.0.1:40523_solr    ] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../dist
 filtered by solr-cell-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../dist
   [junit4]   2> 3881360 WARN  (Thread-6895) [n:127.0.0.1:40523_solr    ] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../contrib/clustering/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../contrib/clustering/lib
   [junit4]   2> 3881360 WARN  (Thread-6895) [n:127.0.0.1:40523_solr    ] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../dist
 filtered by solr-clustering-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../dist
   [junit4]   2> 3881361 WARN  (Thread-6895) [n:127.0.0.1:40523_solr    ] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../contrib/langid/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../contrib/langid/lib
   [junit4]   2> 3881361 WARN  (Thread-6895) [n:127.0.0.1:40523_solr    ] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../dist
 filtered by solr-langid-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../dist
   [junit4]   2> 3881361 WARN  (Thread-6895) [n:127.0.0.1:40523_solr    ] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../contrib/velocity/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../contrib/velocity/lib
   [junit4]   2> 3881361 WARN  (Thread-6895) [n:127.0.0.1:40523_solr    ] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../dist
 filtered by solr-velocity-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1/../../../../dist
   [junit4]   2> 3881403 INFO  (qtp1163828572-16934) [n:127.0.0.1:40523_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> 3881419 INFO  (qtp1163828572-16934) [n:127.0.0.1:40523_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=15
   [junit4]   2> 3881428 INFO  (Thread-6895) [n:127.0.0.1:40523_solr    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 3881439 INFO  
(solrHandlerExecutor-5410-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.SolrConfigHandler 
Could not get expectedVersion 0 from 
http://127.0.0.1:40523/solr/testRepFactor1LeaderStartup_shard1_replica_n1/ for 
prop overlay   after 1 attempts
   [junit4]   2> 3881439 INFO  
(solrHandlerExecutor-5410-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_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> 3881447 INFO  (SolrConfigHandler-refreshconf) 
[n:127.0.0.1:40523_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.SolrConfigHandler 
Another reload is in progress . Not doing anything
   [junit4]   2> 3881495 INFO  (Thread-6895) [n:127.0.0.1:40523_solr    ] 
o.a.s.s.IndexSchema [testRepFactor1LeaderStartup_shard1_replica_n1] Schema 
name=default-config
   [junit4]   2> 3881541 INFO  (qtp1163828572-16938) [n:127.0.0.1:40523_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> 3881541 INFO  (qtp1163828572-16938) [n:127.0.0.1:40523_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> 3881542 INFO  
(solrHandlerExecutor-5410-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.SolrConfigHandler 
Could not get expectedVersion 0 from 
http://127.0.0.1:40523/solr/testRepFactor1LeaderStartup_shard1_replica_n1/ for 
prop overlay   after 2 attempts
   [junit4]   2> 3881542 INFO  
(solrHandlerExecutor-5410-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_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> 3881542 INFO  (SolrConfigHandler-refreshconf) 
[n:127.0.0.1:40523_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.SolrConfigHandler 
Another reload is in progress . Not doing anything
   [junit4]   2> 3881679 INFO  (qtp1163828572-16941) [n:127.0.0.1:40523_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> 3881679 INFO  (qtp1163828572-16941) [n:127.0.0.1:40523_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> 3881683 INFO  
(solrHandlerExecutor-5410-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.SolrConfigHandler 
Could not get expectedVersion 0 from 
http://127.0.0.1:40523/solr/testRepFactor1LeaderStartup_shard1_replica_n1/ for 
prop overlay   after 3 attempts
   [junit4]   2> 3881683 INFO  
(solrHandlerExecutor-5410-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_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> 3881695 INFO  (SolrConfigHandler-refreshconf) 
[n:127.0.0.1:40523_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.SolrConfigHandler 
Another reload is in progress . Not doing anything
   [junit4]   2> 3881813 INFO  (qtp1163828572-16941) [n:127.0.0.1:40523_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> 3881829 INFO  (qtp1163828572-16941) [n:127.0.0.1:40523_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=15
   [junit4]   2> 3881862 INFO  (SolrConfigHandler-refreshconf) 
[n:127.0.0.1:40523_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.SolrConfigHandler 
Another reload is in progress . Not doing anything
   [junit4]   2> 3881862 INFO  
(solrHandlerExecutor-5410-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.SolrConfigHandler 
Could not get expectedVersion 0 from 
http://127.0.0.1:40523/solr/testRepFactor1LeaderStartup_shard1_replica_n1/ for 
prop overlay   after 4 attempts
   [junit4]   2> 3881863 INFO  
(solrHandlerExecutor-5410-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_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> 3881968 INFO  (qtp1163828572-16939) [n:127.0.0.1:40523_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> 3881968 INFO  (qtp1163828572-16939) [n:127.0.0.1:40523_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> 3881968 INFO  (SolrConfigHandler-refreshconf) 
[n:127.0.0.1:40523_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.SolrConfigHandler 
Another reload is in progress . Not doing anything
   [junit4]   2> 3881968 INFO  
(solrHandlerExecutor-5410-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.SolrConfigHandler 
Could not get expectedVersion 0 from 
http://127.0.0.1:40523/solr/testRepFactor1LeaderStartup_shard1_replica_n1/ for 
prop overlay   after 5 attempts
   [junit4]   2> 3881968 INFO  
(solrHandlerExecutor-5410-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_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> 3882048 INFO  (Thread-6895) [n:127.0.0.1:40523_solr    ] 
o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
   [junit4]   2> 3882102 INFO  (qtp1163828572-16934) [n:127.0.0.1:40523_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> 3882110 INFO  (qtp1163828572-16934) [n:127.0.0.1:40523_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=8
   [junit4]   2> 3882111 INFO  (SolrConfigHandler-refreshconf) 
[n:127.0.0.1:40523_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.SolrConfigHandler 
Another reload is in progress . Not doing anything
   [junit4]   2> 3882111 INFO  
(solrHandlerExecutor-5410-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.SolrConfigHandler 
Could not get expectedVersion 0 from 
http://127.0.0.1:40523/solr/testRepFactor1LeaderStartup_shard1_replica_n1/ for 
prop overlay   after 6 attempts
   [junit4]   2> 3882111 INFO  
(solrHandlerExecutor-5410-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_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> 3882128 INFO  (Thread-6895) [n:127.0.0.1:40523_solr    ] 
o.a.s.c.CoreContainer Reloading SolrCore 
'testRepFactor1LeaderStartup_shard1_replica_n1' using configuration from 
collection testRepFactor1LeaderStartup
   [junit4]   2> 3882166 INFO  (Thread-6895) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 
'solr_40523.solr.core.testRepFactor1LeaderStartup.shard1.replica_n1' (registry 
'solr.core.testRepFactor1LeaderStartup.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@47d01e93
   [junit4]   2> 3882166 INFO  (Thread-6895) [n:127.0.0.1:40523_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-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/testRepFactor1LeaderStartup_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001/tempDir-001/node1/./testRepFactor1LeaderStartup_shard1_replica_n1/data/]
   [junit4]   2> java.lang.RuntimeException
   [junit4]   2>        at 
org.apache.solr.cloud.TestCloudSearcherWarming$SleepingSolrEventListener.init(TestCloudSearcherWarming.java:306)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.createInitInstance(SolrCore.java:826)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.initListeners(SolrCore.java:573)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.<init>(SolrCore.java:926)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.reload(SolrCore.java:636)
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1235)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.lambda$getConfListener$20(SolrCore.java:2948)
   [junit4]   2>        at 
org.apache.solr.cloud.ZkController.lambda$fireEventListeners$4(ZkController.java:2434)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   1> {event=newSearcher}
   [junit4]   2> java.lang.RuntimeException
   [junit4]   2>        at 
org.apache.solr.cloud.TestCloudSearcherWarming$SleepingSolrEventListener.init(TestCloudSearcherWarming.java:306)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.createInitInstance(SolrCore.java:826)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.initListeners(SolrCore.java:569)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.<init>(SolrCore.java:926)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.reload(SolrCore.java:636)
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1235)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.lambda$getConfListener$20(SolrCore.java:2948)
   [junit4]   2>        at 
org.apache.solr.cloud.ZkController.lambda$fireEventListeners$4(ZkController.java:2434)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   1> {event=firstSearcher}
   [junit4]   2> 3882190 INFO  (Thread-6895) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.r.XSLTResponseWriter 
xsltCacheLifetimeSeconds=5
   [junit4]   2> 3882228 INFO  (qtp1163828572-16938) [n:127.0.0.1:40523_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> 3882228 INFO  (qtp1163828572-16938) [n:127.0.0.1:40523_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> 3882228 INFO  (SolrConfigHandler-refreshconf) 
[n:127.0.0.1:40523_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.SolrConfigHandler 
Another reload is in progress . Not doing anything
   [junit4]   2> 3882230 INFO  
(solrHandlerExecutor-5410-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.SolrConfigHandler 
Could not get expectedVersion 0 from 
http://127.0.0.1:40523/solr/testRepFactor1LeaderStartup_shard1_replica_n1/ for 
prop overlay   after 7 attempts
   [junit4]   2> 3882231 INFO  
(solrHandlerExecutor-5410-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_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> 3882349 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_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> 3882353 INFO  (qtp1163828572-16935) [n:127.0.0.1:40523_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=3
   [junit4]   2> 3882354 INFO  (SolrConfigHandler-refreshconf) 
[n:127.0.0.1:40523_solr c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.SolrConfigHandler 
Another reload is in progress . Not doing anything
   [junit4]   2> 3882362 INFO  
(solrHandlerExecutor-5410-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.SolrConfigHandler 
Could not get expectedVersion 0 from 
http://127.0.0.1:40523/solr/testRepFactor1LeaderStartup_shard1_replica_n1/ for 
prop overlay   after 8 attempts
   [junit4]   2> 3882362 INFO  
(solrHandlerExecutor-5410-thread-1-processing-n:127.0.0.1:40523_solr 
x:testRepFactor1LeaderStartup_shard1_replica_n1 s:shard1 
c:testRepFactor1LeaderStartup r:core_node2) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.h.SolrConfigHandler Time 
elapsed : 1 secs, maxWait 30
   [junit4]   2> 3882382 INFO  (Thread-6895) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.u.CommitTracker Hard 
AutoCommit: if uncommited for 15000ms; 
   [junit4]   2> 3882383 INFO  (Thread-6895) [n:127.0.0.1:40523_solr 
c:testRepFactor1LeaderStartup s:shard1 r:core_node2 
x:testRepFactor1LeaderStartup_shard1_replica_n1] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 3882384 INFO  (Thread-6895) [n:127.0.0.1:40523_solr 
c:testRepFactor1Leader

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

[    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 3972855 INFO  
(TEST-TestCloudSearcherWarming.testRepFactor1LeaderStartup-seed#[F3F26008472333D7])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testRepFactor1LeaderStartup
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestCloudSearcherWarming -Dtests.method=testRepFactor1LeaderStartup 
-Dtests.seed=F3F26008472333D7 -Dtests.multiplier=2 -Dtests.slow=true 
-Dtests.locale=es-VE -Dtests.timezone=Pacific/Samoa -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] FAILURE 96.2s J0 | 
TestCloudSearcherWarming.testRepFactor1LeaderStartup <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: 
   [junit4]    > null
   [junit4]    > Live Nodes: [127.0.0.1:40523_solr]
   [junit4]    > Last available state: 
DocCollection(testRepFactor1LeaderStartup//collections/testRepFactor1LeaderStartup/state.json/5)={
   [junit4]    >   "pullReplicas":"0",
   [junit4]    >   "replicationFactor":"1",
   [junit4]    >   "shards":{"shard1":{
   [junit4]    >       "range":"80000000-7fffffff",
   [junit4]    >       "state":"active",
   [junit4]    >       "replicas":{"core_node2":{
   [junit4]    >           
"core":"testRepFactor1LeaderStartup_shard1_replica_n1",
   [junit4]    >           "base_url":"http://127.0.0.1:40523/solr";,
   [junit4]    >           "node_name":"127.0.0.1:40523_solr",
   [junit4]    >           "state":"active",
   [junit4]    >           "type":"NRT",
   [junit4]    >           "leader":"true"}}}},
   [junit4]    >   "router":{"name":"compositeId"},
   [junit4]    >   "maxShardsPerNode":"1",
   [junit4]    >   "autoAddReplicas":"false",
   [junit4]    >   "nrtReplicas":"1",
   [junit4]    >   "tlogReplicas":"0"}
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([F3F26008472333D7:24DA2DD056C37A39]:0)
   [junit4]    >        at 
org.apache.solr.cloud.SolrCloudTestCase.waitForState(SolrCloudTestCase.java:269)
   [junit4]    >        at 
org.apache.solr.cloud.TestCloudSearcherWarming.testRepFactor1LeaderStartup(TestCloudSearcherWarming.java:126)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 3972859 INFO  
(TEST-TestCloudSearcherWarming.testPeersyncFailureReplicationSuccess-seed#[F3F26008472333D7])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testPeersyncFailureReplicationSuccess
   [junit4]   2> 3972860 INFO  
(TEST-TestCloudSearcherWarming.testPeersyncFailureReplicationSuccess-seed#[F3F26008472333D7])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testPeersyncFailureReplicationSuccess
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestCloudSearcherWarming 
-Dtests.method=testPeersyncFailureReplicationSuccess 
-Dtests.seed=F3F26008472333D7 -Dtests.multiplier=2 -Dtests.slow=true 
-Dtests.locale=es-VE -Dtests.timezone=Pacific/Samoa -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.00s J0 | 
TestCloudSearcherWarming.testPeersyncFailureReplicationSuccess <<<
   [junit4]    > Throwable #1: java.lang.ArrayIndexOutOfBoundsException: 0
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([F3F26008472333D7:27A30347969D04B4]:0)
   [junit4]    >        at 
java.util.concurrent.CopyOnWriteArrayList.get(CopyOnWriteArrayList.java:387)
   [junit4]    >        at 
java.util.concurrent.CopyOnWriteArrayList.get(CopyOnWriteArrayList.java:396)
   [junit4]    >        at 
org.apache.solr.cloud.MiniSolrCloudCluster.getJettySolrRunner(MiniSolrCloudCluster.java:367)
   [junit4]    >        at 
org.apache.solr.cloud.TestCloudSearcherWarming.testPeersyncFailureReplicationSuccess(TestCloudSearcherWarming.java:141)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 3972861 ERROR 
(SUITE-TestCloudSearcherWarming-seed#[F3F26008472333D7]-worker) [    ] 
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper 
server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 3972861 INFO  
(SUITE-TestCloudSearcherWarming-seed#[F3F26008472333D7]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:33602 33602
   [junit4]   2> 3972956 INFO  (Thread-6885) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:33602 33602
   [junit4]   2> 3972957 WARN  (Thread-6885) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        2       /solr/aliases.json
   [junit4]   2>        2       
/solr/configs/testRepFactor1LeaderStartup/managed-schema
   [junit4]   2>        2       /solr/clusterprops.json
   [junit4]   2>        2       /solr/configs/testRepFactor1LeaderStartup
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        8       
/solr/collections/testRepFactor1LeaderStartup/state.json
   [junit4]   2>        2       /solr/clusterstate.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        2       /solr/live_nodes
   [junit4]   2>        2       /solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestCloudSearcherWarming_F3F26008472333D7-001
   [junit4]   2> Aug 10, 2017 9:10:07 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 2 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=412, maxMBSortInHeap=6.776193436269714, 
sim=RandomSimilarity(queryNorm=false): {}, locale=es-VE, timezone=Pacific/Samoa
   [junit4]   2> NOTE: Linux 4.4.0-83-generic amd64/Oracle Corporation 
1.8.0_144 (64-bit)/cpus=4,threads=1,free=86175224,total=526385152
   [junit4]   2> NOTE: All tests run in this JVM: [HdfsThreadLeakTest, 
SolrMetricsIntegrationTest, TestDistribIDF, MBeansHandlerTest, 
TestHttpShardHandlerFactory, HttpSolrCallGetCoreTest, TestBinaryField, 
TestRandomFaceting, BaseCdcrDistributedZkTest, MissingSegmentRecoveryTest, 
DistributedFacetExistsSmallTest, PluginInfoTest, RAMDirectoryFactoryTest, 
SharedFSAutoReplicaFailoverUtilsTest, HdfsRecoveryZkTest, CoreSorterTest, 
TestCollapseQParserPlugin, TestSolr4Spatial, ForceLeaderTest, 
CollectionsAPISolrJTest, TestDocumentBuilder, TestMergePolicyConfig, 
UpdateParamsTest, TestRealTimeGet, TestDistributedSearch, 
TestLegacyNumericRangeQueryBuilder, RestartWhileUpdatingTest, 
SolrPluginUtilsTest, TestQuerySenderNoQuery, TestCustomSort, TestTlogReplica, 
HdfsCollectionsAPIDistributedZkTest, TestSolrCloudWithDelegationTokens, 
TestSubQueryTransformerCrossCore, TestRequestForwarding, 
TestNumericRangeQuery32, TestIBSimilarityFactory, TestFieldCache, 
TestFieldCacheSortRandom, HdfsDirectoryFactoryTest, 
TestImpersonationWithHadoopAuth, ConnectionManagerTest, 
TestUniqueKeyFieldResource, SynonymTokenizerTest, TestCloudDeleteByQuery, 
TestFieldCollectionResource, DistributedQueryComponentCustomSortTest, 
TestCopyFieldCollectionResource, TestMinMaxOnMultiValuedField, TestFaceting, 
IndexBasedSpellCheckerTest, PreAnalyzedFieldManagedSchemaCloudTest, 
OpenExchangeRatesOrgProviderTest, TestLazyCores, TestCSVResponseWriter, 
CursorMarkTest, SecurityConfHandlerTest, ShufflingReplicaListTransformerTest, 
DocExpirationUpdateProcessorFactoryTest, TestManagedSchemaAPI, TestDocSet, 
XmlUpdateRequestHandlerTest, TestRecoveryHdfs, OutputWriterTest, 
TestLRUStatsCache, SuggestComponentTest, CoreAdminCreateDiscoverTest, 
TestReqParamsAPI, TestIntervalFaceting, TestSolrDeletionPolicy1, 
TestLeaderInitiatedRecoveryThread, TestDistribDocBasedVersion, 
TlogReplayBufferedWhileIndexingTest, TestBulkSchemaConcurrent, 
DeleteInactiveReplicaTest, TestDynamicLoading, SolrJmxReporterTest, 
TestHdfsCloudBackupRestore, RuleEngineTest, SpellCheckCollatorWithCollapseTest, 
FieldAnalysisRequestHandlerTest, DistributedQueueTest, 
TestSlowCompositeReaderWrapper, TestSolrQueryResponse, RemoteQueryErrorTest, 
TestSchemaManager, TestSchemaSimilarityResource, AutoScalingHandlerTest, 
TestCSVLoader, DocValuesMissingTest, TestInitParams, TestComponentsName, 
DistanceUnitsTest, TestConfigSetsAPIZkFailure, TestRandomDVFaceting, 
CdcrUpdateLogTest, BinaryUpdateRequestHandlerTest, HdfsDirectoryTest, 
TestExtendedDismaxParser, TestMacros, TestEmbeddedSolrServerConstructors, 
TestStressUserVersions, TestPayloadCheckQParserPlugin, SparseHLLTest, 
TestPhraseSuggestions, TestLegacyNumericUtils, TestWordDelimiterFilterFactory, 
RequestHandlersTest, TestNestedDocsSort, CollectionStateFormat2Test, 
TestRTimerTree, TestFileDictionaryLookup, FieldMutatingUpdateProcessorTest, 
TestStressCloudBlindAtomicUpdates, HighlighterConfigTest, UpdateLogTest, 
TestCoreAdminApis, TestSegmentSorting, FullHLLTest, 
TermVectorComponentDistributedTest, TestStressVersions, HardAutoCommitTest, 
TestRangeQuery, TestFiltering, SignatureUpdateProcessorFactoryTest, 
SpellCheckCollatorTest, SolrRequestParserTest, SuggesterTest, PolyFieldTest, 
SolrCoreCheckLockOnStartupTest, TestUpdate, 
StatelessScriptUpdateProcessorFactoryTest, TestReversedWildcardFilterFactory, 
PrimitiveFieldTypeTest, TestValueSourceCache, TestSolrQueryParser, 
TestCollationField, TestPHPSerializedResponseWriter, TestQuerySenderListener, 
AlternateDirectoryTest, TestSolrIndexConfig, SolrIndexConfigTest, 
TestStressRecovery, TestSuggestSpellingConverter, SpellingQueryConverterTest, 
ZkNodePropsTest, CircularListTest, TestRTGBase, TestCrossCoreJoin, 
TestCursorMarkWithoutUniqueKey, TestDistributedMissingSort, ActionThrottleTest, 
AssignBackwardCompatibilityTest, CdcrReplicationHandlerTest, 
CdcrRequestHandlerTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest, 
DeleteReplicaTest, DocValuesNotIndexedTest, HttpPartitionTest, MoveReplicaTest, 
OverseerTaskQueueTest, SaslZkACLProviderTest, SharedFSAutoReplicaFailoverTest, 
SimpleCollectionCreateDeleteTest, SolrCloudExampleTest, 
TestCloudPseudoReturnFields, TestCloudSearcherWarming]
   [junit4] Completed [545/729 (1!)] on J0 in 97.68s, 2 tests, 1 failure, 1 
error <<< FAILURES!

[...truncated 43848 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to