Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/20851/
Java: 64bit/jdk-9.0.1 -XX:-UseCompressedOops -XX:+UseSerialGC

2 tests failed.
FAILED:  
junit.framework.TestSuite.org.apache.solr.client.solrj.impl.ConnectionReuseTest

Error Message:


Stack Trace:
java.util.concurrent.TimeoutException
        at __randomizedtesting.SeedInfo.seed([F3444E69BED2F4F]:0)
        at 
org.apache.solr.common.cloud.ZkStateReader.waitForState(ZkStateReader.java:1325)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.waitForState(CloudSolrClient.java:440)
        at 
org.apache.solr.client.solrj.impl.ConnectionReuseTest.setupCluster(ConnectionReuseTest.java:67)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:874)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
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.base/java.lang.Thread.run(Thread.java:844)


FAILED:  org.apache.solr.cloud.AssignBackwardCompatibilityTest.test

Error Message:
Expected 8 active replicas null Live Nodes: [127.0.0.1:33289_solr, 
127.0.0.1:37343_solr, 127.0.0.1:43803_solr, 127.0.0.1:44347_solr] Last 
available state: 
DocCollection(collection1//collections/collection1/state.json/55)={   
"pullReplicas":"0",   "replicationFactor":"4",   "shards":{"shard1":{       
"range":"80000000-7fffffff",       "state":"active",       "replicas":{         
"core_node5":{           "core":"collection1_shard1_replica_n2",           
"base_url":"https://127.0.0.1:44347/solr";,           
"node_name":"127.0.0.1:44347_solr",           "state":"active",           
"type":"NRT"},         "core_node7":{           
"core":"collection1_shard1_replica_n4",           
"base_url":"https://127.0.0.1:33289/solr";,           
"node_name":"127.0.0.1:33289_solr",           "state":"active",           
"type":"NRT",           "leader":"true"},         "core_node14":{           
"core":"collection1_shard1_replica_n13",           
"base_url":"https://127.0.0.1:43803/solr";,           
"node_name":"127.0.0.1:43803_solr",           "state":"active",           
"type":"NRT"},         "core_node16":{           
"core":"collection1_shard1_replica_n15",           
"base_url":"https://127.0.0.1:33289/solr";,           
"node_name":"127.0.0.1:33289_solr",           "state":"active",           
"type":"NRT"},         "core_node18":{           
"core":"collection1_shard1_replica_n17",           
"base_url":"https://127.0.0.1:44347/solr";,           
"node_name":"127.0.0.1:44347_solr",           "state":"active",           
"type":"NRT"},         "core_node146":{           
"core":"collection1_shard1_replica_n145",           
"base_url":"https://127.0.0.1:37343/solr";,           
"node_name":"127.0.0.1:37343_solr",           "state":"active",           
"type":"NRT"},         "core_node148":{           
"core":"collection1_shard1_replica_n147",           
"base_url":"https://127.0.0.1:37343/solr";,           
"node_name":"127.0.0.1:37343_solr",           "state":"active",           
"type":"NRT"},         "core_node150":{           
"core":"collection1_shard1_replica_n149",           
"base_url":"https://127.0.0.1:43803/solr";,           
"node_name":"127.0.0.1:43803_solr",           "state":"down",           
"type":"NRT"}}}},   "router":{"name":"compositeId"},   
"maxShardsPerNode":"1000",   "autoAddReplicas":"false",   "nrtReplicas":"4",   
"tlogReplicas":"0"}

Stack Trace:
java.lang.AssertionError: Expected 8 active replicas
null
Live Nodes: [127.0.0.1:33289_solr, 127.0.0.1:37343_solr, 127.0.0.1:43803_solr, 
127.0.0.1:44347_solr]
Last available state: 
DocCollection(collection1//collections/collection1/state.json/55)={
  "pullReplicas":"0",
  "replicationFactor":"4",
  "shards":{"shard1":{
      "range":"80000000-7fffffff",
      "state":"active",
      "replicas":{
        "core_node5":{
          "core":"collection1_shard1_replica_n2",
          "base_url":"https://127.0.0.1:44347/solr";,
          "node_name":"127.0.0.1:44347_solr",
          "state":"active",
          "type":"NRT"},
        "core_node7":{
          "core":"collection1_shard1_replica_n4",
          "base_url":"https://127.0.0.1:33289/solr";,
          "node_name":"127.0.0.1:33289_solr",
          "state":"active",
          "type":"NRT",
          "leader":"true"},
        "core_node14":{
          "core":"collection1_shard1_replica_n13",
          "base_url":"https://127.0.0.1:43803/solr";,
          "node_name":"127.0.0.1:43803_solr",
          "state":"active",
          "type":"NRT"},
        "core_node16":{
          "core":"collection1_shard1_replica_n15",
          "base_url":"https://127.0.0.1:33289/solr";,
          "node_name":"127.0.0.1:33289_solr",
          "state":"active",
          "type":"NRT"},
        "core_node18":{
          "core":"collection1_shard1_replica_n17",
          "base_url":"https://127.0.0.1:44347/solr";,
          "node_name":"127.0.0.1:44347_solr",
          "state":"active",
          "type":"NRT"},
        "core_node146":{
          "core":"collection1_shard1_replica_n145",
          "base_url":"https://127.0.0.1:37343/solr";,
          "node_name":"127.0.0.1:37343_solr",
          "state":"active",
          "type":"NRT"},
        "core_node148":{
          "core":"collection1_shard1_replica_n147",
          "base_url":"https://127.0.0.1:37343/solr";,
          "node_name":"127.0.0.1:37343_solr",
          "state":"active",
          "type":"NRT"},
        "core_node150":{
          "core":"collection1_shard1_replica_n149",
          "base_url":"https://127.0.0.1:43803/solr";,
          "node_name":"127.0.0.1:43803_solr",
          "state":"down",
          "type":"NRT"}}}},
  "router":{"name":"compositeId"},
  "maxShardsPerNode":"1000",
  "autoAddReplicas":"false",
  "nrtReplicas":"4",
  "tlogReplicas":"0"}
        at 
__randomizedtesting.SeedInfo.seed([F3444E69BED2F4F:87607B3C351142B7]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at 
org.apache.solr.cloud.SolrCloudTestCase.waitForState(SolrCloudTestCase.java:269)
        at 
org.apache.solr.cloud.AssignBackwardCompatibilityTest.test(AssignBackwardCompatibilityTest.java:92)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
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.base/java.lang.Thread.run(Thread.java:844)




Build Log:
[...truncated 13193 lines...]
   [junit4] Suite: org.apache.solr.client.solrj.impl.ConnectionReuseTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.client.solrj.impl.ConnectionReuseTest_F3444E69BED2F4F-001/init-core-data-001
   [junit4]   2> 1357803 WARN  
(SUITE-ConnectionReuseTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
   [junit4]   2> 1357803 INFO  
(SUITE-ConnectionReuseTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1357804 INFO  
(SUITE-ConnectionReuseTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl="None")
   [junit4]   2> 1357804 INFO  
(SUITE-ConnectionReuseTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1357804 INFO  
(SUITE-ConnectionReuseTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.client.solrj.impl.ConnectionReuseTest_F3444E69BED2F4F-001/tempDir-001
   [junit4]   2> 1357804 INFO  
(SUITE-ConnectionReuseTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1357804 INFO  (Thread-2504) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1357804 INFO  (Thread-2504) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1357806 ERROR (Thread-2504) [    ] 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> 1357904 INFO  
(SUITE-ConnectionReuseTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:39669
   [junit4]   2> 1357910 INFO  (jetty-launcher-3192-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1357913 INFO  (jetty-launcher-3192-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@658d3c0f{/solr,null,AVAILABLE}
   [junit4]   2> 1357913 INFO  (jetty-launcher-3192-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@20f2d65f{HTTP/1.1,[http/1.1]}{127.0.0.1:42459}
   [junit4]   2> 1357913 INFO  (jetty-launcher-3192-thread-1) [    ] 
o.e.j.s.Server Started @1359918ms
   [junit4]   2> 1357913 INFO  (jetty-launcher-3192-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=42459}
   [junit4]   2> 1357914 ERROR (jetty-launcher-3192-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1357914 INFO  (jetty-launcher-3192-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1357914 INFO  (jetty-launcher-3192-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1357914 INFO  (jetty-launcher-3192-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1357914 INFO  (jetty-launcher-3192-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-06T22:15:11.198386Z
   [junit4]   2> 1357916 INFO  (jetty-launcher-3192-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1357923 INFO  (jetty-launcher-3192-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39669/solr
   [junit4]   2> 1357975 INFO  (jetty-launcher-3192-thread-1) 
[n:127.0.0.1:42459_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1357976 INFO  (jetty-launcher-3192-thread-1) 
[n:127.0.0.1:42459_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:42459_solr
   [junit4]   2> 1357976 INFO  (jetty-launcher-3192-thread-1) 
[n:127.0.0.1:42459_solr    ] o.a.s.c.Overseer Overseer 
(id=98959786710728707-127.0.0.1:42459_solr-n_0000000000) starting
   [junit4]   2> 1357980 INFO  (jetty-launcher-3192-thread-1) 
[n:127.0.0.1:42459_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:42459_solr
   [junit4]   2> 1357981 INFO  
(zkCallback-3199-thread-1-processing-n:127.0.0.1:42459_solr) 
[n:127.0.0.1:42459_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1358060 INFO  (jetty-launcher-3192-thread-1) 
[n:127.0.0.1:42459_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42459.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f4b129a
   [junit4]   2> 1358064 INFO  (jetty-launcher-3192-thread-1) 
[n:127.0.0.1:42459_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42459.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f4b129a
   [junit4]   2> 1358064 INFO  (jetty-launcher-3192-thread-1) 
[n:127.0.0.1:42459_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42459.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f4b129a
   [junit4]   2> 1358065 INFO  (jetty-launcher-3192-thread-1) 
[n:127.0.0.1:42459_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.client.solrj.impl.ConnectionReuseTest_F3444E69BED2F4F-001/tempDir-001/node1/.
   [junit4]   2> 1358077 INFO  
(SUITE-ConnectionReuseTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1358077 INFO  
(SUITE-ConnectionReuseTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:39669/solr ready
   [junit4]   2> 1358081 INFO  (qtp1881495028-13582) [n:127.0.0.1:42459_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
async=8e4ee388-4f35-4fed-a570-c18a1ad7a00f&replicationFactor=1&collection.configName=config&name=collection1&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1358082 INFO  (qtp1881495028-13582) [n:127.0.0.1:42459_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={async=8e4ee388-4f35-4fed-a570-c18a1ad7a00f&replicationFactor=1&collection.configName=config&name=collection1&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1358082 INFO  (qtp1881495028-13583) [n:127.0.0.1:42459_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with 
params 
requestid=8e4ee388-4f35-4fed-a570-c18a1ad7a00f&action=REQUESTSTATUS&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1358083 INFO  (qtp1881495028-13583) [n:127.0.0.1:42459_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={requestid=8e4ee388-4f35-4fed-a570-c18a1ad7a00f&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1358083 INFO  
(OverseerThreadFactory-6178-thread-1-processing-n:127.0.0.1:42459_solr) 
[n:127.0.0.1:42459_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
collection1
   [junit4]   2> 1358186 INFO  
(OverseerStateUpdate-98959786710728707-127.0.0.1:42459_solr-n_0000000000) 
[n:127.0.0.1:42459_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"collection1_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:42459/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1358390 INFO  (qtp1881495028-13578) [n:127.0.0.1:42459_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=config&newCollection=true&collection=collection1&version=2&replicaType=NRT&async=8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217&coreNodeName=core_node2&name=collection1_shard1_replica_n1&action=CREATE&numShards=1&shard=shard1&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 1358390 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr    ] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=config&newCollection=true&collection=collection1&version=2&replicaType=NRT&async=8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217&coreNodeName=core_node2&name=collection1_shard1_replica_n1&action=CREATE&numShards=1&shard=shard1&wt=javabin
   [junit4]   2> 1358391 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1358393 INFO  (qtp1881495028-13582) [n:127.0.0.1:42459_solr    
] o.a.s.h.a.CoreAdminOperation Checking request status for : 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217
   [junit4]   2> 1358393 INFO  (qtp1881495028-13582) [n:127.0.0.1:42459_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&requestid=8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1358506 INFO  
(zkCallback-3199-thread-1-processing-n:127.0.0.1:42459_solr) 
[n:127.0.0.1:42459_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1358513 INFO  
(zkCallback-3199-thread-2-processing-n:127.0.0.1:42459_solr) 
[n:127.0.0.1:42459_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1359084 INFO  (qtp1881495028-13584) [n:127.0.0.1:42459_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with 
params 
requestid=8e4ee388-4f35-4fed-a570-c18a1ad7a00f&action=REQUESTSTATUS&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1359084 INFO  (qtp1881495028-13584) [n:127.0.0.1:42459_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={requestid=8e4ee388-4f35-4fed-a570-c18a1ad7a00f&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1359393 INFO  (qtp1881495028-13583) [n:127.0.0.1:42459_solr    
] o.a.s.h.a.CoreAdminOperation Checking request status for : 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217
   [junit4]   2> 1359393 INFO  (qtp1881495028-13583) [n:127.0.0.1:42459_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&requestid=8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1359410 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 
8.0.0
   [junit4]   2> 1359414 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.s.IndexSchema 
[collection1_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 1359415 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 
with uniqueid field id
   [junit4]   2> 1359415 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 
'collection1_shard1_replica_n1' using configuration from collection 
collection1, trusted=true
   [junit4]   2> 1359416 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42459.solr.core.collection1.shard1.replica_n1' (registry 
'solr.core.collection1.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5f4b129a
   [junit4]   2> 1359416 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1359416 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.c.SolrCore 
[[collection1_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.client.solrj.impl.ConnectionReuseTest_F3444E69BED2F4F-001/tempDir-001/node1/collection1_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.client.solrj.impl.ConnectionReuseTest_F3444E69BED2F4F-001/tempDir-001/node1/./collection1_shard1_replica_n1/data/]
   [junit4]   2> 1359448 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1359448 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: 
dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1359449 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1359449 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1359450 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@268a6b47[collection1_shard1_replica_n1] main]
   [junit4]   2> 1359451 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured 
ZooKeeperStorageIO with znodeBase: /configs/config
   [junit4]   2> 1359451 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at 
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/config
   [junit4]   2> 1359451 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be 
reserved for 10000ms.
   [junit4]   2> 1359451 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version 
in index or recent updates, using new clock 1583356589097615360
   [junit4]   2> 1359452 INFO  
(searcherExecutor-6181-thread-1-processing-x:collection1_shard1_replica_n1 
r:core_node2 8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE 
n:127.0.0.1:42459_solr s:shard1 c:collection1) [n:127.0.0.1:42459_solr 
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1] 
o.a.s.c.SolrCore [collection1_shard1_replica_n1] Registered new searcher 
Searcher@268a6b47[collection1_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1359454 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough 
replicas found to continue.
   [junit4]   2> 1359454 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be 
the new leader - try and sync
   [junit4]   2> 1359454 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:42459/solr/collection1_shard1_replica_n1/
   [junit4]   2> 1359454 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync 
replicas to me
   [junit4]   2> 1359454 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.c.SyncStrategy 
http://127.0.0.1:42459/solr/collection1_shard1_replica_n1/ has no replicas
   [junit4]   2> 1359455 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found all 
replicas participating in election, clear LIR
   [junit4]   2> 1359456 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the 
new leader: http://127.0.0.1:42459/solr/collection1_shard1_replica_n1/ shard1
   [junit4]   2> 1359556 INFO  
(zkCallback-3199-thread-1-processing-n:127.0.0.1:42459_solr) 
[n:127.0.0.1:42459_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1359556 INFO  
(zkCallback-3199-thread-2-processing-n:127.0.0.1:42459_solr) 
[n:127.0.0.1:42459_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1359606 INFO  
(parallelCoreAdminExecutor-6179-thread-1-processing-n:127.0.0.1:42459_solr 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217 CREATE) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no 
recovery necessary
   [junit4]   2> 1360085 INFO  (qtp1881495028-13577) [n:127.0.0.1:42459_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with 
params 
requestid=8e4ee388-4f35-4fed-a570-c18a1ad7a00f&action=REQUESTSTATUS&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1360086 INFO  (qtp1881495028-13577) [n:127.0.0.1:42459_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={requestid=8e4ee388-4f35-4fed-a570-c18a1ad7a00f&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=1
   [junit4]   2> 1360394 INFO  (qtp1881495028-13578) [n:127.0.0.1:42459_solr    
] o.a.s.h.a.CoreAdminOperation Checking request status for : 
8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217
   [junit4]   2> 1360394 INFO  (qtp1881495028-13578) [n:127.0.0.1:42459_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&requestid=8e4ee388-4f35-4fed-a570-c18a1ad7a00f731859640797217&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1360395 INFO  
(OverseerThreadFactory-6178-thread-1-processing-n:127.0.0.1:42459_solr) 
[n:127.0.0.1:42459_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> 1361086 INFO  (qtp1881495028-13582) [n:127.0.0.1:42459_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with 
params 
requestid=8e4ee388-4f35-4fed-a570-c18a1ad7a00f&action=REQUESTSTATUS&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1361088 INFO  (qtp1881495028-13582) [n:127.0.0.1:42459_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={requestid=8e4ee388-4f35-4fed-a570-c18a1ad7a00f&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=1
   [junit4]   2> 1361088 INFO  (qtp1881495028-13583) [n:127.0.0.1:42459_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :deletestatus with 
params 
requestid=8e4ee388-4f35-4fed-a570-c18a1ad7a00f&action=DELETESTATUS&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1361089 INFO  (qtp1881495028-13583) [n:127.0.0.1:42459_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={requestid=8e4ee388-4f35-4fed-a570-c18a1ad7a00f&action=DELETESTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1362085 INFO  
(OverseerCollectionConfigSetProcessor-98959786710728707-127.0.0.1:42459_solr-n_0000000000)
 [n:127.0.0.1:42459_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> 1451092 INFO  (jetty-closer-3193-thread-1) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@20f2d65f{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1451092 INFO  (jetty-closer-3193-thread-1) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=781472763
   [junit4]   2> 1451092 INFO  (jetty-closer-3193-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1451092 INFO  (jetty-closer-3193-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@13213ff7: rootName = 
solr_42459, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@1d6944a8
   [junit4]   2> 1451099 INFO  (jetty-closer-3193-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1451099 INFO  (jetty-closer-3193-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1e11368b: rootName = 
solr_42459, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@10668e00
   [junit4]   2> 1451104 INFO  (jetty-closer-3193-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1451104 INFO  (jetty-closer-3193-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@17ca45c3: rootName = 
solr_42459, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@7f86300e
   [junit4]   2> 1451106 INFO  (jetty-closer-3193-thread-1) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:42459_solr
   [junit4]   2> 1451106 INFO  (jetty-closer-3193-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 1451107 INFO  
(zkCallback-3199-thread-4-processing-n:127.0.0.1:42459_solr) 
[n:127.0.0.1:42459_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (0)
   [junit4]   2> 1451107 INFO  (coreCloseExecutor-6186-thread-1) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.c.SolrCore 
[collection1_shard1_replica_n1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@7ecf7da0
   [junit4]   2> 1451107 INFO  (coreCloseExecutor-6186-thread-1) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.core.collection1.shard1.replica_n1, tag=2127527328
   [junit4]   2> 1451107 INFO  (coreCloseExecutor-6186-thread-1) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@348b74a1: rootName = 
solr_42459, domain = solr.core.collection1.shard1.replica_n1, service url = 
null, agent id = null] for registry solr.core.collection1.shard1.replica_n1 / 
com.codahale.metrics.MetricRegistry@2e9c6b90
   [junit4]   2> 1451137 INFO  (coreCloseExecutor-6186-thread-1) 
[n:127.0.0.1:42459_solr c:collection1 s:shard1 r:core_node2 
x:collection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.collection1.shard1.leader, tag=2127527328
   [junit4]   2> 1451138 INFO  (jetty-closer-3193-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=98959786710728707-127.0.0.1:42459_solr-n_0000000000) closing
   [junit4]   2> 1451138 INFO  
(OverseerStateUpdate-98959786710728707-127.0.0.1:42459_solr-n_0000000000) 
[n:127.0.0.1:42459_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:42459_solr
   [junit4]   2> 1451138 WARN  
(OverseerAutoScalingTriggerThread-98959786710728707-127.0.0.1:42459_solr-n_0000000000)
 [n:127.0.0.1:42459_solr    ] o.a.s.c.a.OverseerTriggerThread 
OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 1451140 INFO  (jetty-closer-3193-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@658d3c0f{/solr,null,UNAVAILABLE}
   [junit4]   2> 1451140 ERROR 
(SUITE-ConnectionReuseTest-seed#[F3444E69BED2F4F]-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> 1451141 INFO  
(SUITE-ConnectionReuseTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:39669 39669
   [junit4]   2> 1451305 INFO  (Thread-2504) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:39669 39669
   [junit4]   2> 1451306 WARN  (Thread-2504) [    ] 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/clusterprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        5       /solr/collections/collection1/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> 1451306 INFO  
(SUITE-ConnectionReuseTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ------------------------------------------------------- 
Done waiting for tracked resources to be released
   [junit4]   2> Nov 06, 2017 10:16:44 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=762, maxMBSortInHeap=6.243718121457475, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@47bdd908),
 locale=teo-UG, timezone=SystemV/CST6
   [junit4]   2> NOTE: Linux 4.10.0-37-generic amd64/Oracle Corporation 9.0.1 
(64-bit)/cpus=8,threads=1,free=246702096,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: [RegexBoostProcessorTest, 
RestartWhileUpdatingTest, BadIndexSchemaTest, SmileWriterTest, 
CloudExitableDirectoryReaderTest, TestSolrFieldCacheBean, TestPolicyCloud, 
TestInfoStreamLogging, PrimUtilsTest, TestBackupRepositoryFactory, 
TestInPlaceUpdatesDistrib, ShowFileRequestHandlerTest, 
OpenExchangeRatesOrgProviderTest, SimpleCollectionCreateDeleteTest, 
MoreLikeThisHandlerTest, AddReplicaTest, TestStressLucene, TestNoOpRegenerator, 
PolyFieldTest, AtomicUpdatesTest, ZkFailoverTest, HighlighterMaxOffsetTest, 
TestExportWriter, QueryEqualityTest, TestBlobHandler, 
TestDistributedStatsComponentCardinality, TestShortCircuitedRequests, 
IgnoreCommitOptimizeUpdateProcessorFactoryTest, CollectionTooManyReplicasTest, 
TestAnalyzedSuggestions, OverseerModifyCollectionTest, TestCloudInspectUtil, 
TermVectorComponentDistributedTest, TestJavabinTupleStreamParser, 
PathHierarchyTokenizerFactoryTest, TestPullReplicaErrorHandling, TestTrieFacet, 
TolerantUpdateProcessorTest, BlockJoinFacetDistribTest, TestPerFieldSimilarity, 
TestNumericRangeQuery64, LeaderFailoverAfterPartitionTest, 
TestClusterStateMutator, TestFieldCacheVsDocValues, TestRestManager, 
EnumFieldTest, TestFieldResource, TlogReplayBufferedWhileIndexingTest, 
TestExactSharedStatsCache, AddBlockUpdateTest, TestDocumentBuilder, TestDocSet, 
TestSolrCloudWithHadoopAuthPlugin, DebugComponentTest, MetricsHandlerTest, 
HdfsBasicDistributedZk2Test, SynonymTokenizerTest, MBeansHandlerTest, 
TestDownShardTolerantSearch, OpenCloseCoreStressTest, TestLegacyField, 
TestCustomStream, TestMacroExpander, PingRequestHandlerTest, 
SortSpecParsingTest, TestJettySolrRunner, DistributedTermsComponentTest, 
TestManagedSchemaThreadSafety, UninvertDocValuesMergePolicyTest, 
ConcurrentDeleteAndCreateCollectionTest, CollectionsAPIDistributedZkTest, 
TestRequestStatusCollectionAPI, CdcrReplicationHandlerTest, 
ClassificationUpdateProcessorTest, TestSQLHandler, ResponseHeaderTest, 
DistributedFacetPivotLargeTest, TestAnalyzeInfixSuggestions, 
HdfsUnloadDistributedZkTest, TestRTimerTree, RequestHandlersTest, 
DistributedFacetPivotSmallTest, TestOnReconnectListenerSupport, 
ZkSolrClientTest, TestSurroundQueryParser, TestAtomicUpdateErrorCases, 
TestFastLRUCache, SaslZkACLProviderTest, CurrencyFieldTypeTest, TestWriterPerf, 
BadCopyFieldTest, SpellingQueryConverterTest, RemoteQueryErrorTest, 
TestSchemaVersionResource, ConvertedLegacyTest, TestDFISimilarityFactory, 
CircularListTest, TestFastWriter, HdfsSyncSliceTest, JvmMetricsTest, 
TestReloadDeadlock, SchemaVersionSpecificBehaviorTest, 
TestHalfAndHalfDocValues, DistributedDebugComponentTest, 
DeleteLastCustomShardedReplicaTest, CloudMLTQParserTest, TestSolrConfigHandler, 
TestLuceneMatchVersion, TestLocalFSCloudBackupRestore, ShardRoutingTest, 
V2StandaloneTest, SampleTest, PreAnalyzedFieldTest, 
ChaosMonkeySafeLeaderWithPullReplicasTest, SolrIndexSplitterTest, 
SolrMetricManagerTest, TestTlogReplica, SolrJmxReporterTest, OutputWriterTest, 
TestRandomDVFaceting, ZkCLITest, TestFaceting, TestRecovery, TestReload, 
TestRangeQuery, BasicFunctionalityTest, TestLazyCores, DirectUpdateHandlerTest, 
HighlighterTest, DistributedQueryElevationComponentTest, 
SignatureUpdateProcessorFactoryTest, SuggesterFSTTest, DocValuesTest, 
DocValuesMultiTest, SolrInfoBeanTest, IndexBasedSpellCheckerTest, 
DisMaxRequestHandlerTest, DocumentAnalysisRequestHandlerTest, 
PrimitiveFieldTypeTest, FileBasedSpellCheckerTest, 
FieldAnalysisRequestHandlerTest, SolrPluginUtilsTest, TestCollationField, 
UniqFieldsUpdateProcessorFactoryTest, BinaryUpdateRequestHandlerTest, 
TestPartialUpdateDeduplication, TestComponentsName, HighlighterConfigTest, 
SOLR749Test, UpdateParamsTest, AlternateDirectoryTest, TestQuerySenderNoQuery, 
CopyFieldTest, SolrIndexConfigTest, TestStressRecovery, TestMergePolicyConfig, 
TestSolrDeletionPolicy2, TestSearchPerf, NumericFieldsTest, 
TestElisionMultitermQuery, TestConfig, TestFuzzyAnalyzedSuggestions, 
TestSolrCoreProperties, NotRequiredUniqueKeyTest, TestPhraseSuggestions, 
SpellPossibilityIteratorTest, TestCodecSupport, TestXIncludeConfig, 
TestIBSimilarityFactory, TestBM25SimilarityFactory, URLClassifyProcessorTest, 
PluginInfoTest, TestSuggestSpellingConverter, DOMUtilTest, 
RAMDirectoryFactoryTest, TestSolrJ, TestUtils, SliceStateTest, FileUtilsTest, 
DistributedMLTComponentTest, TestRTGBase, DistributedIntervalFacetingTest, 
TestSimpleTrackingShardHandler, TestEmbeddedSolrServerAdminHandler, 
TestEmbeddedSolrServerConstructors, ConnectionReuseTest]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=ConnectionReuseTest 
-Dtests.seed=F3444E69BED2F4F -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=teo-UG -Dtests.timezone=SystemV/CST6 -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J1 | ConnectionReuseTest (suite) <<<
   [junit4]    > Throwable #1: java.util.concurrent.TimeoutException
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([F3444E69BED2F4F]:0)
   [junit4]    >        at 
org.apache.solr.common.cloud.ZkStateReader.waitForState(ZkStateReader.java:1325)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.waitForState(CloudSolrClient.java:440)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.ConnectionReuseTest.setupCluster(ConnectionReuseTest.java:67)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at 
java.base/java.lang.reflect.Method.invoke(Method.java:564)
   [junit4]    >        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4] Completed [496/749 (1!)] on J1 in 94.02s, 0 tests, 1 error <<< 
FAILURES!

[...truncated 4 lines...]
   [junit4] Suite: org.apache.solr.cloud.AssignBackwardCompatibilityTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.AssignBackwardCompatibilityTest_F3444E69BED2F4F-001/init-core-data-001
   [junit4]   2> 1358203 WARN  
(SUITE-AssignBackwardCompatibilityTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=12 numCloses=12
   [junit4]   2> 1358203 INFO  
(SUITE-AssignBackwardCompatibilityTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1358204 INFO  
(SUITE-AssignBackwardCompatibilityTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 1358204 INFO  
(SUITE-AssignBackwardCompatibilityTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1358204 INFO  
(SUITE-AssignBackwardCompatibilityTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.AssignBackwardCompatibilityTest_F3444E69BED2F4F-001/tempDir-001
   [junit4]   2> 1358204 INFO  
(SUITE-AssignBackwardCompatibilityTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1358205 INFO  (Thread-2846) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1358205 INFO  (Thread-2846) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1358208 ERROR (Thread-2846) [    ] 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> 1358305 INFO  
(SUITE-AssignBackwardCompatibilityTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:34465
   [junit4]   2> 1358312 INFO  (jetty-launcher-2017-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1358312 INFO  (jetty-launcher-2017-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1358313 INFO  (jetty-launcher-2017-thread-3) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1358314 INFO  (jetty-launcher-2017-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@38763505{/solr,null,AVAILABLE}
   [junit4]   2> 1358328 INFO  (jetty-launcher-2017-thread-4) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1358344 INFO  (jetty-launcher-2017-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@f3f4f1d{/solr,null,AVAILABLE}
   [junit4]   2> 1358357 INFO  (jetty-launcher-2017-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@6971c749{SSL,[ssl, 
http/1.1]}{127.0.0.1:37343}
   [junit4]   2> 1358357 INFO  (jetty-launcher-2017-thread-2) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@36b3907d{SSL,[ssl, 
http/1.1]}{127.0.0.1:44347}
   [junit4]   2> 1358357 INFO  (jetty-launcher-2017-thread-1) [    ] 
o.e.j.s.Server Started @1360545ms
   [junit4]   2> 1358357 INFO  (jetty-launcher-2017-thread-2) [    ] 
o.e.j.s.Server Started @1360545ms
   [junit4]   2> 1358357 INFO  (jetty-launcher-2017-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=37343}
   [junit4]   2> 1358357 INFO  (jetty-launcher-2017-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=44347}
   [junit4]   2> 1358357 INFO  (jetty-launcher-2017-thread-4) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@40f40db3{/solr,null,AVAILABLE}
   [junit4]   2> 1358357 ERROR (jetty-launcher-2017-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1358357 ERROR (jetty-launcher-2017-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1358357 INFO  (jetty-launcher-2017-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1358357 INFO  (jetty-launcher-2017-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1358357 INFO  (jetty-launcher-2017-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1358357 INFO  (jetty-launcher-2017-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1358357 INFO  (jetty-launcher-2017-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1358357 INFO  (jetty-launcher-2017-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1358357 INFO  (jetty-launcher-2017-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-06T22:15:11.827644Z
   [junit4]   2> 1358357 INFO  (jetty-launcher-2017-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-06T22:15:11.827671Z
   [junit4]   2> 1358359 INFO  (jetty-launcher-2017-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@7e7aabc1{/solr,null,AVAILABLE}
   [junit4]   2> 1358359 INFO  (jetty-launcher-2017-thread-4) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@549d6fe9{SSL,[ssl, 
http/1.1]}{127.0.0.1:33289}
   [junit4]   2> 1358359 INFO  (jetty-launcher-2017-thread-4) [    ] 
o.e.j.s.Server Started @1360548ms
   [junit4]   2> 1358360 INFO  (jetty-launcher-2017-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=33289}
   [junit4]   2> 1358360 ERROR (jetty-launcher-2017-thread-4) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1358360 INFO  (jetty-launcher-2017-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1358360 INFO  (jetty-launcher-2017-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1358360 INFO  (jetty-launcher-2017-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1358360 INFO  (jetty-launcher-2017-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-06T22:15:11.830394Z
   [junit4]   2> 1358362 INFO  (jetty-launcher-2017-thread-3) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@44bb8409{SSL,[ssl, 
http/1.1]}{127.0.0.1:43803}
   [junit4]   2> 1358362 INFO  (jetty-launcher-2017-thread-3) [    ] 
o.e.j.s.Server Started @1360550ms
   [junit4]   2> 1358362 INFO  (jetty-launcher-2017-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=43803}
   [junit4]   2> 1358362 ERROR (jetty-launcher-2017-thread-3) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1358363 INFO  (jetty-launcher-2017-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1358363 INFO  (jetty-launcher-2017-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1358363 INFO  (jetty-launcher-2017-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1358363 INFO  (jetty-launcher-2017-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-06T22:15:11.833209Z
   [junit4]   2> 1358364 INFO  (jetty-launcher-2017-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1358365 INFO  (jetty-launcher-2017-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1358365 INFO  (jetty-launcher-2017-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1358377 INFO  (jetty-launcher-2017-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1358378 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x15f9366d83b0001, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 1358379 INFO  (jetty-launcher-2017-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34465/solr
   [junit4]   2> 1358381 INFO  (jetty-launcher-2017-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34465/solr
   [junit4]   2> 1358383 INFO  (jetty-launcher-2017-thread-4) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34465/solr
   [junit4]   2> 1358400 INFO  (jetty-launcher-2017-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34465/solr
   [junit4]   2> 1358405 INFO  (jetty-launcher-2017-thread-4) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1358405 INFO  (jetty-launcher-2017-thread-2) 
[n:127.0.0.1:44347_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1358406 INFO  (jetty-launcher-2017-thread-4) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:33289_solr
   [junit4]   2> 1358406 INFO  (jetty-launcher-2017-thread-2) 
[n:127.0.0.1:44347_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:44347_solr
   [junit4]   2> 1358407 INFO  (jetty-launcher-2017-thread-4) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.Overseer Overseer 
(id=98959786749132810-127.0.0.1:33289_solr-n_0000000000) starting
   [junit4]   2> 1358412 INFO  
(zkCallback-2038-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1358419 INFO  
(zkCallback-2034-thread-1-processing-n:127.0.0.1:44347_solr) 
[n:127.0.0.1:44347_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1358427 INFO  (jetty-launcher-2017-thread-4) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:33289_solr
   [junit4]   2> 1358427 INFO  (jetty-launcher-2017-thread-3) 
[n:127.0.0.1:43803_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1358432 INFO  
(zkCallback-2033-thread-1-processing-n:127.0.0.1:43803_solr) 
[n:127.0.0.1:43803_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1358433 INFO  (jetty-launcher-2017-thread-3) 
[n:127.0.0.1:43803_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1358434 INFO  (jetty-launcher-2017-thread-1) 
[n:127.0.0.1:37343_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 1358434 INFO  (jetty-launcher-2017-thread-3) 
[n:127.0.0.1:43803_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:43803_solr
   [junit4]   2> 1358440 INFO  
(zkCallback-2034-thread-1-processing-n:127.0.0.1:44347_solr) 
[n:127.0.0.1:44347_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (3)
   [junit4]   2> 1358440 INFO  
(zkCallback-2038-thread-2-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (3)
   [junit4]   2> 1358440 INFO  (jetty-launcher-2017-thread-1) 
[n:127.0.0.1:37343_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1358441 INFO  (jetty-launcher-2017-thread-1) 
[n:127.0.0.1:37343_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:37343_solr
   [junit4]   2> 1358443 INFO  
(zkCallback-2034-thread-1-processing-n:127.0.0.1:44347_solr) 
[n:127.0.0.1:44347_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 1358448 INFO  
(zkCallback-2033-thread-1-processing-n:127.0.0.1:43803_solr) 
[n:127.0.0.1:43803_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (4)
   [junit4]   2> 1358456 INFO  
(zkCallback-2043-thread-1-processing-n:127.0.0.1:37343_solr) 
[n:127.0.0.1:37343_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (4)
   [junit4]   2> 1358456 INFO  
(zkCallback-2038-thread-2-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 1358476 INFO  (jetty-launcher-2017-thread-2) 
[n:127.0.0.1:44347_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44347.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6ec59196
   [junit4]   2> 1358479 INFO  (jetty-launcher-2017-thread-4) 
[n:127.0.0.1:33289_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_33289.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6ec59196
   [junit4]   2> 1358491 INFO  (jetty-launcher-2017-thread-2) 
[n:127.0.0.1:44347_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44347.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6ec59196
   [junit4]   2> 1358491 INFO  (jetty-launcher-2017-thread-2) 
[n:127.0.0.1:44347_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44347.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6ec59196
   [junit4]   2> 1358493 INFO  (jetty-launcher-2017-thread-2) 
[n:127.0.0.1:44347_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.AssignBackwardCompatibilityTest_F3444E69BED2F4F-001/tempDir-001/node2/.
   [junit4]   2> 1358496 INFO  (jetty-launcher-2017-thread-4) 
[n:127.0.0.1:33289_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_33289.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6ec59196
   [junit4]   2> 1358497 INFO  (jetty-launcher-2017-thread-4) 
[n:127.0.0.1:33289_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_33289.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6ec59196
   [junit4]   2> 1358498 INFO  (jetty-launcher-2017-thread-4) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.AssignBackwardCompatibilityTest_F3444E69BED2F4F-001/tempDir-001/node4/.
   [junit4]   2> 1358500 INFO  (jetty-launcher-2017-thread-1) 
[n:127.0.0.1:37343_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37343.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6ec59196
   [junit4]   2> 1358502 INFO  (jetty-launcher-2017-thread-3) 
[n:127.0.0.1:43803_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43803.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6ec59196
   [junit4]   2> 1358509 INFO  (jetty-launcher-2017-thread-3) 
[n:127.0.0.1:43803_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43803.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6ec59196
   [junit4]   2> 1358509 INFO  (jetty-launcher-2017-thread-3) 
[n:127.0.0.1:43803_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43803.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6ec59196
   [junit4]   2> 1358510 INFO  (jetty-launcher-2017-thread-3) 
[n:127.0.0.1:43803_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.AssignBackwardCompatibilityTest_F3444E69BED2F4F-001/tempDir-001/node3/.
   [junit4]   2> 1358515 INFO  (jetty-launcher-2017-thread-1) 
[n:127.0.0.1:37343_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37343.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6ec59196
   [junit4]   2> 1358515 INFO  (jetty-launcher-2017-thread-1) 
[n:127.0.0.1:37343_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37343.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6ec59196
   [junit4]   2> 1358515 INFO  (jetty-launcher-2017-thread-1) 
[n:127.0.0.1:37343_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.AssignBackwardCompatibilityTest_F3444E69BED2F4F-001/tempDir-001/node1/.
   [junit4]   2> 1358581 INFO  
(SUITE-AssignBackwardCompatibilityTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 1358581 INFO  
(SUITE-AssignBackwardCompatibilityTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34465/solr ready
   [junit4]   2> 1358591 INFO  (qtp1800903049-12137) [n:127.0.0.1:43803_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
pullReplicas=0&replicationFactor=4&maxShardsPerNode=1000&name=collection1&nrtReplicas=4&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1358595 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
collection1
   [junit4]   2> 1358595 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.CreateCollectionCmd Only _default config 
set found, using it.
   [junit4]   2> 1358596 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/protwords.txt to /configs/collection1/protwords.txt
   [junit4]   2> 1358597 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/managed-schema to /configs/collection1/managed-schema
   [junit4]   2> 1358611 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/solrconfig.xml to /configs/collection1/solrconfig.xml
   [junit4]   2> 1358612 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/synonyms.txt to /configs/collection1/synonyms.txt
   [junit4]   2> 1358612 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/stopwords.txt to /configs/collection1/stopwords.txt
   [junit4]   2> 1358613 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_it.txt to 
/configs/collection1/lang/contractions_it.txt
   [junit4]   2> 1358613 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stemdict_nl.txt to 
/configs/collection1/lang/stemdict_nl.txt
   [junit4]   2> 1358614 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_hy.txt to 
/configs/collection1/lang/stopwords_hy.txt
   [junit4]   2> 1358614 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_no.txt to 
/configs/collection1/lang/stopwords_no.txt
   [junit4]   2> 1358614 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_ca.txt to 
/configs/collection1/lang/contractions_ca.txt
   [junit4]   2> 1358615 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_id.txt to 
/configs/collection1/lang/stopwords_id.txt
   [junit4]   2> 1358615 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ga.txt to 
/configs/collection1/lang/stopwords_ga.txt
   [junit4]   2> 1358616 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_hi.txt to 
/configs/collection1/lang/stopwords_hi.txt
   [junit4]   2> 1358616 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_da.txt to 
/configs/collection1/lang/stopwords_da.txt
   [junit4]   2> 1358617 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ja.txt to 
/configs/collection1/lang/stopwords_ja.txt
   [junit4]   2> 1358617 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_pt.txt to 
/configs/collection1/lang/stopwords_pt.txt
   [junit4]   2> 1358618 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_hu.txt to 
/configs/collection1/lang/stopwords_hu.txt
   [junit4]   2> 1358618 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_el.txt to 
/configs/collection1/lang/stopwords_el.txt
   [junit4]   2> 1358618 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ru.txt to 
/configs/collection1/lang/stopwords_ru.txt
   [junit4]   2> 1358619 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_tr.txt to 
/configs/collection1/lang/stopwords_tr.txt
   [junit4]   2> 1358619 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ar.txt to 
/configs/collection1/lang/stopwords_ar.txt
   [junit4]   2> 1358620 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/userdict_ja.txt to 
/configs/collection1/lang/userdict_ja.txt
   [junit4]   2> 1358620 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_eu.txt to 
/configs/collection1/lang/stopwords_eu.txt
   [junit4]   2> 1358621 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_it.txt to 
/configs/collection1/lang/stopwords_it.txt
   [junit4]   2> 1358621 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_cz.txt to 
/configs/collection1/lang/stopwords_cz.txt
   [junit4]   2> 1358622 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stoptags_ja.txt to 
/configs/collection1/lang/stoptags_ja.txt
   [junit4]   2> 1358622 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_fr.txt to 
/configs/collection1/lang/contractions_fr.txt
   [junit4]   2> 1358623 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_de.txt to 
/configs/collection1/lang/stopwords_de.txt
   [junit4]   2> 1358623 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_fa.txt to 
/configs/collection1/lang/stopwords_fa.txt
   [junit4]   2> 1358624 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_ga.txt to 
/configs/collection1/lang/contractions_ga.txt
   [junit4]   2> 1358624 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ca.txt to 
/configs/collection1/lang/stopwords_ca.txt
   [junit4]   2> 1358624 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_nl.txt to 
/configs/collection1/lang/stopwords_nl.txt
   [junit4]   2> 1358625 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_bg.txt to 
/configs/collection1/lang/stopwords_bg.txt
   [junit4]   2> 1358625 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_lv.txt to 
/configs/collection1/lang/stopwords_lv.txt
   [junit4]   2> 1358626 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_en.txt to 
/configs/collection1/lang/stopwords_en.txt
   [junit4]   2> 1358626 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_es.txt to 
/configs/collection1/lang/stopwords_es.txt
   [junit4]   2> 1358627 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_th.txt to 
/configs/collection1/lang/stopwords_th.txt
   [junit4]   2> 1358627 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ro.txt to 
/configs/collection1/lang/stopwords_ro.txt
   [junit4]   2> 1358627 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_fr.txt to 
/configs/collection1/lang/stopwords_fr.txt
   [junit4]   2> 1358628 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_sv.txt to 
/configs/collection1/lang/stopwords_sv.txt
   [junit4]   2> 1358628 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_fi.txt to 
/configs/collection1/lang/stopwords_fi.txt
   [junit4]   2> 1358629 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/hyphenations_ga.txt to 
/configs/collection1/lang/hyphenations_ga.txt
   [junit4]   2> 1358629 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_gl.txt to 
/configs/collection1/lang/stopwords_gl.txt
   [junit4]   2> 1358630 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/params.json to /configs/collection1/params.json
   [junit4]   2> 1358734 INFO  
(OverseerStateUpdate-98959786749132810-127.0.0.1:33289_solr-n_0000000000) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"collection1_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:37343/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1358735 INFO  
(OverseerStateUpdate-98959786749132810-127.0.0.1:33289_solr-n_0000000000) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"collection1_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:44347/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1358736 INFO  
(OverseerStateUpdate-98959786749132810-127.0.0.1:33289_solr-n_0000000000) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"collection1_shard1_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:33289/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1358736 INFO  
(OverseerStateUpdate-98959786749132810-127.0.0.1:33289_solr-n_0000000000) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"collection1_shard1_replica_n6",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:43803/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1358945 INFO  (qtp1800903049-12139) [n:127.0.0.1:43803_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node8&collection.configName=collection1&newCollection=true&name=collection1_shard1_replica_n6&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1358946 INFO  (qtp1800903049-12139) [n:127.0.0.1:43803_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1358948 INFO  (qtp1308365515-12146) [n:127.0.0.1:33289_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node7&collection.configName=collection1&newCollection=true&name=collection1_shard1_replica_n4&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1358948 INFO  (qtp1308365515-12146) [n:127.0.0.1:33289_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1358949 INFO  (qtp1985650942-12134) [n:127.0.0.1:37343_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=collection1&newCollection=true&name=collection1_shard1_replica_n1&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1358949 INFO  (qtp1985650942-12134) [n:127.0.0.1:37343_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1358954 INFO  (qtp647704046-12119) [n:127.0.0.1:44347_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node5&collection.configName=collection1&newCollection=true&name=collection1_shard1_replica_n2&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1358954 INFO  (qtp647704046-12119) [n:127.0.0.1:44347_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1359065 INFO  
(zkCallback-2034-thread-1-processing-n:127.0.0.1:44347_solr) 
[n:127.0.0.1:44347_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 1359065 INFO  
(zkCallback-2033-thread-1-processing-n:127.0.0.1:43803_solr) 
[n:127.0.0.1:43803_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 1359065 INFO  
(zkCallback-2034-thread-2-processing-n:127.0.0.1:44347_solr) 
[n:127.0.0.1:44347_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 1359065 INFO  
(zkCallback-2033-thread-2-processing-n:127.0.0.1:43803_solr) 
[n:127.0.0.1:43803_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 1359065 INFO  
(zkCallback-2043-thread-1-processing-n:127.0.0.1:37343_solr) 
[n:127.0.0.1:37343_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 1359065 INFO  
(zkCallback-2038-thread-1-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 1359065 INFO  
(zkCallback-2038-thread-2-processing-n:127.0.0.1:33289_solr) 
[n:127.0.0.1:33289_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 1359065 INFO  
(zkCallback-2043-thread-2-processing-n:127.0.0.1:37343_solr) 
[n:127.0.0.1:37343_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 1359970 INFO  (qtp1308365515-12146) [n:127.0.0.1:33289_solr 
c:collection1 s:shard1 r:core_node7 x:collection1_shard1_replica_n4] 
o.a.s.c.RequestParams conf resource params.json loaded . version : 0 
   [junit4]   2> 1359971 INFO  (qtp1308365515-12146) [n:127.0.0.1:33289_solr 
c:collection1 s:shard1 r:core_node7 x:collection1_shard1_replica_n4] 
o.a.s.c.RequestParams request params refreshed to version 0
   [junit4]   2> 1359971 INFO  (qtp647704046-12119) [n:127.0.0.1:44347_solr 
c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2] 
o.a.s.c.RequestParams conf resource params.json loaded . version : 0 
   [junit4]   2> 1359971 INFO  (qtp1800903049-12139) [n:127.0.0.1:43803_solr 
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n6] 
o.a.s.c.RequestParams conf resource params.json loaded . version : 0 
   [junit4]   2> 1359971 INFO  (qtp647704046-12119) [n:127.0.0.1:44347_solr 
c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2] 
o.a.s.c.RequestParams request params refreshed to version 0
   [junit4]   2> 1359971 INFO  (qtp1800903049-12139) [n:127.0.0.1:43803_solr 
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n6] 
o.a.s.c.RequestParams request params refreshed to version 0
   [junit4]   2> 1359971 INFO  (qtp1985650942-12134) [n:127.0.0.1:37343_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.RequestParams conf resource params.json loaded . version : 0 
   [junit4]   2> 1359971 INFO  (qtp1985650942-12134) [n:127.0.0.1:37343_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.RequestParams request params refreshed to version 0
   [junit4]   2> 1359971 WARN  (qtp1308365515-12146) [n:127.0.0.1:33289_solr 
c:collection1 s:shard1 r:core_node7 x:collection1_shard1_replica_n4] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.AssignBackwardCompatibilityTest_F3444E69BED2F4F-001/tempDir-001/node4/collection1_shard1_replica_n4/../../../../contrib/extraction/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.AssignBackwardCompatibilityTest_F3444E69BED2F4F-001/tempDir-001/node4/collection1_shard1_replica_n4/../../../../contrib/extraction/lib
   [junit4]   2> 1359972 WARN  (qtp1308365515-12146) [n:127.0.0.1:33289_solr 
c:collection1 s:shard1 r:core_node7 x:collection1_shard1_replica_n4] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.AssignBackwardCompatibilityTest_F3444E69BED2F4F-001/tempDir-001/node4/collection1_shard1_replica_n4/../../../../dist
 filtered by solr-cell-\d.*\.jar to classpath: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.AssignBackwardCompatibilityTest_F3444E69BED2F4F-001/tempDir-001/node4/collection1_shard1_replica_n4/../../../../dist
   [junit4]   2> 1359972 WARN  (qtp1800903049-12139) [n:127.0.0.1:43803_solr 
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n6] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.AssignBackwardCompatibilityTest_F3444E69BED2F4F-001/tempDir-001/node3/collection1_shard1_replica_n6/../../../../contrib/extraction/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.AssignBackwardCompatibilityTest_F3444E69BED2F4F-001/tempDir-001/node3/collection1_shard1_replica_n6/../../../../contrib/extraction/lib
   [junit4]   2> 1359972 WARN  (qtp1985650942-12134) [n:127.0.0.1:37343_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.AssignBackwardCompatibilityTest_F3444E69BED2F4F-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../contrib/extraction/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.AssignBackwardCompatibilityTest_F3444E69BED2F4F-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../contrib/extraction/lib
   [junit4]   2> 1359972 WARN  (qtp1800903049-12139) [n:127.0.0.1:43803_solr 
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n6] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.AssignBackwardCompatibilityTest_F3444E69BED2F4F-001/tempDir-001/node3/collection1_shard1_replica_n6/../../../../dist
 filtered by solr-cell-\d.*\.jar to classpath: /home/jenkin

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

tContextHandler@40f40db3{/solr,null,UNAVAILABLE}
   [junit4]   2> 1477852 INFO  
(zkCallback-2033-thread-4-processing-n:127.0.0.1:43803_solr) 
[n:127.0.0.1:43803_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:43803_solr
   [junit4]   2> 1482802 INFO  
(recoveryExecutor-2028-thread-1-processing-n:127.0.0.1:43803_solr 
x:collection1_shard1_replica_n149 s:shard1 c:collection1 r:core_node150) 
[n:127.0.0.1:43803_solr c:collection1 s:shard1 r:core_node150 
x:collection1_shard1_replica_n149] o.a.s.c.RecoveryStrategy RecoveryStrategy 
has been closed
   [junit4]   2> 1482802 INFO  
(recoveryExecutor-2028-thread-1-processing-n:127.0.0.1:43803_solr 
x:collection1_shard1_replica_n149 s:shard1 c:collection1 r:core_node150) 
[n:127.0.0.1:43803_solr c:collection1 s:shard1 r:core_node150 
x:collection1_shard1_replica_n149] o.a.s.c.RecoveryStrategy Finished recovery 
process, successful=[false]
   [junit4]   2> 1482802 INFO  
(recoveryExecutor-2028-thread-1-processing-n:127.0.0.1:43803_solr 
x:collection1_shard1_replica_n149 s:shard1 c:collection1 r:core_node150) 
[n:127.0.0.1:43803_solr c:collection1 s:shard1 r:core_node150 
x:collection1_shard1_replica_n149] o.a.s.c.SolrCore 
[collection1_shard1_replica_n149]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@27987725
   [junit4]   2> 1482802 INFO  
(recoveryExecutor-2028-thread-1-processing-n:127.0.0.1:43803_solr 
x:collection1_shard1_replica_n149 s:shard1 c:collection1 r:core_node150) 
[n:127.0.0.1:43803_solr c:collection1 s:shard1 r:core_node150 
x:collection1_shard1_replica_n149] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.core.collection1.shard1.replica_n149, tag=664303397
   [junit4]   2> 1482802 INFO  
(recoveryExecutor-2028-thread-1-processing-n:127.0.0.1:43803_solr 
x:collection1_shard1_replica_n149 s:shard1 c:collection1 r:core_node150) 
[n:127.0.0.1:43803_solr c:collection1 s:shard1 r:core_node150 
x:collection1_shard1_replica_n149] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6fe3121d: rootName = 
solr_43803, domain = solr.core.collection1.shard1.replica_n149, service url = 
null, agent id = null] for registry solr.core.collection1.shard1.replica_n149 / 
com.codahale.metrics.MetricRegistry@7ad96867
   [junit4]   2> 1482809 INFO  
(recoveryExecutor-2028-thread-1-processing-n:127.0.0.1:43803_solr 
x:collection1_shard1_replica_n149 s:shard1 c:collection1 r:core_node150) 
[n:127.0.0.1:43803_solr c:collection1 s:shard1 r:core_node150 
x:collection1_shard1_replica_n149] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.collection1.shard1.leader, tag=664303397
   [junit4]   2> 1482809 WARN  
(recoveryExecutor-2028-thread-1-processing-n:127.0.0.1:43803_solr 
x:collection1_shard1_replica_n149 s:shard1 c:collection1 r:core_node150) 
[n:127.0.0.1:43803_solr c:collection1 s:shard1 r:core_node150 
x:collection1_shard1_replica_n149] o.a.s.c.RecoveryStrategy Stopping recovery 
for core=[collection1_shard1_replica_n149] coreNodeName=[core_node150]
   [junit4]   2> 1482810 INFO  (jetty-closer-2018-thread-4) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@7e7aabc1{/solr,null,UNAVAILABLE}
   [junit4]   2> 1482811 ERROR 
(SUITE-AssignBackwardCompatibilityTest-seed#[F3444E69BED2F4F]-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> 1482811 INFO  
(SUITE-AssignBackwardCompatibilityTest-seed#[F3444E69BED2F4F]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:34465 34465
   [junit4]   2> 1484459 INFO  (Thread-2846) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:34465 34465
   [junit4]   2> 1484459 WARN  (Thread-2846) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        15      /solr/configs/collection1/managed-schema
   [junit4]   2>        6       /solr/configs/collection1
   [junit4]   2>        5       /solr/aliases.json
   [junit4]   2>        4       /solr/security.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        227     /solr/collections/collection1/state.json
   [junit4]   2>        5       /solr/clusterprops.json
   [junit4]   2>        5       /solr/clusterstate.json
   [junit4]   2>        3       
/solr/collections/collection1/leader_elect/shard1/election/98959786749132810-core_node16-n_0000000007
   [junit4]   2>        3       
/solr/collections/collection1/leader_elect/shard1/election/98959786749132809-core_node18-n_0000000008
   [junit4]   2>        2       
/solr/collections/collection1/leader_elect/shard1/election/98959786749132810-core_node7-n_0000000002
   [junit4]   2>        2       
/solr/overseer_elect/election/98959786749132810-127.0.0.1:33289_solr-n_0000000000
   [junit4]   2>        2       
/solr/collections/collection1/leader_elect/shard1/election/98959786749132812-core_node3-n_0000000000
   [junit4]   2>        2       
/solr/collections/collection1/leader_elect/shard1/election/98959786749132808-core_node14-n_0000000006
   [junit4]   2>        2       
/solr/collections/collection1/leader_elect/shard1/election/98959786749132812-core_node142-n_0000000010
   [junit4]   2>        2       
/solr/collections/collection1/leader_elect/shard1/election/98959786749132809-core_node5-n_0000000003
   [junit4]   2>        2       
/solr/collections/collection1/leader_elect/shard1/election/98959786749132808-core_node10-n_0000000004
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        5       /solr/live_nodes
   [junit4]   2>        5       /solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.AssignBackwardCompatibilityTest_F3444E69BED2F4F-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=1364, maxMBSortInHeap=5.198604349829726, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@6d5c0b6c),
 locale=sr-Latn-BA, timezone=Asia/Phnom_Penh
   [junit4]   2> NOTE: Linux 4.10.0-37-generic amd64/Oracle Corporation 9.0.1 
(64-bit)/cpus=8,threads=1,free=157063440,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: [TestHashPartitioner, 
TestValueSourceCache, BadComponentTest, UnloadDistributedZkTest, 
AnalysisErrorHandlingTest, AutoAddReplicasIntegrationTest, 
TestExtendedDismaxParser, TestShardHandlerFactory, DistanceFunctionTest, 
MetricUtilsTest, TestBinaryResponseWriter, BlockJoinFacetRandomTest, 
ScriptEngineTest, RegexBytesRefFilterTest, 
OverriddenZkACLAndCredentialsProvidersTest, TestReplicaProperties, 
CdcrRequestHandlerTest, DeleteStatusTest, TestIndexSearcher, 
SolrGraphiteReporterTest, TestSystemIdResolver, TestJsonFacets, 
TestExclusionRuleCollectionAccess, TestDocTermOrds, TestSSLRandomization, 
TestPrepRecovery, TestSerializedLuceneMatchVersion, HdfsDirectoryFactoryTest, 
MoveReplicaHDFSFailoverTest, SortByFunctionTest, TestSystemCollAutoCreate, 
TestStressInPlaceUpdates, CloneFieldUpdateProcessorFactoryTest, 
TestDeleteCollectionOnDownNodes, LoggingHandlerTest, EchoParamsTest, 
HdfsBasicDistributedZkTest, QueryElevationComponentTest, 
ParsingFieldUpdateProcessorsTest, CoreMergeIndexesAdminHandlerTest, 
TestQuerySenderListener, XsltUpdateRequestHandlerTest, TestSchemaResource, 
TestMaxTokenLenTokenizer, RequiredFieldsTest, TestDynamicFieldResource, 
TestCloudJSONFacetJoinDomain, XmlUpdateRequestHandlerTest, 
TestDistributedGrouping, CustomCollectionTest, TestZkAclsWithHadoopAuth, 
SolrCoreCheckLockOnStartupTest, TestBulkSchemaAPI, 
DistributedFacetPivotWhiteBoxTest, ZkNodePropsTest, 
DistributedSpellCheckComponentTest, SolrTestCaseJ4Test, TestConfigsApi, 
UUIDFieldTest, LeaderFailureAfterFreshStartTest, 
ClassificationUpdateProcessorFactoryTest, ReturnFieldsTest, BitVectorTest, 
TestComplexPhraseQParserPlugin, BasicDistributedZk2Test, ClusterStateTest, 
HdfsWriteToMultipleCollectionsTest, WordBreakSolrSpellCheckerTest, 
TestCloudNestedDocsSort, TestNumericTerms64, DistributedExpandComponentTest, 
CoreAdminHandlerTest, ChaosMonkeyNothingIsSafeTest, StatsReloadRaceTest, 
SystemInfoHandlerTest, TestCSVResponseWriter, TestReRankQParserPlugin, 
TestPushWriter, StatsComponentTest, RecoveryZkTest, 
AsyncCallRequestStatusResponseTest, OverseerRolesTest, IndexSchemaTest, 
SuggesterTest, RollingRestartTest, TestCharFilters, 
AddSchemaFieldsUpdateProcessorFactoryTest, SuggesterWFSTTest, TestXmlQParser, 
TimeZoneUtilsTest, TestTolerantSearch, TriLevelCompositeIdRoutingTest, 
TestLMJelinekMercerSimilarityFactory, TestLRUCache, 
FullSolrCloudDistribCmdsTest, TestManagedSynonymFilterFactory, 
DirectSolrSpellCheckerTest, TestLMDirichletSimilarityFactory, TestZkChroot, 
BasicAuthStandaloneTest, TestCloudRecovery, TestRetrieveFieldsOptimizer, 
DateRangeFieldTest, AutoscalingHistoryHandlerTest, DirectSolrConnectionTest, 
TestConfigSets, MultiThreadedOCPTest, TestConfigReload, OverseerTest, 
DistribJoinFromCollectionTest, ConfigSetsAPITest, TestSolrXml, TestTrie, 
TestGroupingSearch, ZkStateReaderTest, AliasIntegrationTest, 
TestAddFieldRealTimeGet, TestCollectionAPI, TestSQLHandlerNonCloud, 
TestPointFields, SpellCheckComponentTest, TestFiltering, SimplePostToolTest, 
TestCoreDiscovery, SolrRequestParserTest, SuggesterTSTTest, TestCSVLoader, 
NoCacheHeaderTest, TestPseudoReturnFields, FieldMutatingUpdateProcessorTest, 
TestWordDelimiterFilterFactory, DefaultValueUpdateProcessorTest, 
TestRemoteStreaming, CacheHeaderTest, LukeRequestHandlerTest, TestQueryUtils, 
TestQueryTypes, TestOmitPositions, DocumentBuilderTest, 
TestIndexingPerformance, TestSolrQueryParser, TestJmxIntegration, 
QueryParsingTest, JsonLoaderTest, TestPHPSerializedResponseWriter, 
CSVRequestHandlerTest, TestLFUCache, TestCursorMarkWithoutUniqueKey, 
TestDistributedMissingSort, TestLuceneIndexBackCompat, 
AssignBackwardCompatibilityTest]
   [junit4] Completed [498/749 (2!)] on J2 in 126.27s, 1 test, 1 failure <<< 
FAILURES!

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

Reply via email to