You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2017/08/24 11:15:18 UTC
[JENKINS-EA] Lucene-Solr-6.6-Linux (64bit/jdk-9-ea+181) - Build #
88 - Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.6-Linux/88/
Java: 64bit/jdk-9-ea+181 -XX:+UseCompressedOops -XX:+UseG1GC --illegal-access=deny
1 tests failed.
FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI
Error Message:
Something is broken in the assert for no shards using the same indexDir - probably something was changed in the attributes published in the MBean of SolrCore : {}
Stack Trace:
java.lang.AssertionError: Something is broken in the assert for no shards using the same indexDir - probably something was changed in the attributes published in the MBean of SolrCore : {}
at __randomizedtesting.SeedInfo.seed([3F569E6B59793CF3:7723EADF5F4A1366]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.checkNoTwoShardsUseTheSameIndexDir(CollectionsAPIDistributedZkTest.java:646)
at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI(CollectionsAPIDistributedZkTest.java:524)
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:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at 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 12110 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/init-core-data-001
[junit4] 2> 1001076 WARN (SUITE-CollectionsAPIDistributedZkTest-seed#[3F569E6B59793CF3]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=16 numCloses=16
[junit4] 2> 1001076 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[3F569E6B59793CF3]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields
[junit4] 2> 1001077 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[3F569E6B59793CF3]-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> 1001078 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[3F569E6B59793CF3]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001
[junit4] 2> 1001078 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[3F569E6B59793CF3]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1001113 INFO (Thread-3423) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1001113 INFO (Thread-3423) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1001121 ERROR (Thread-3423) [ ] 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> 1001213 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[3F569E6B59793CF3]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:40089
[junit4] 2> 1001242 INFO (jetty-launcher-1109-thread-2) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1001243 INFO (jetty-launcher-1109-thread-3) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1001244 INFO (jetty-launcher-1109-thread-1) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1001246 INFO (jetty-launcher-1109-thread-4) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1001254 INFO (jetty-launcher-1109-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7d9f3fbd{/solr,null,AVAILABLE}
[junit4] 2> 1001256 INFO (jetty-launcher-1109-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@39cc70f6{SSL,[ssl, http/1.1]}{127.0.0.1:34853}
[junit4] 2> 1001256 INFO (jetty-launcher-1109-thread-4) [ ] o.e.j.s.Server Started @1003341ms
[junit4] 2> 1001256 INFO (jetty-launcher-1109-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34853}
[junit4] 2> 1001256 ERROR (jetty-launcher-1109-thread-4) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1001256 INFO (jetty-launcher-1109-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 6.6.1
[junit4] 2> 1001256 INFO (jetty-launcher-1109-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1001256 INFO (jetty-launcher-1109-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1001256 INFO (jetty-launcher-1109-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-08-24T10:47:39.459672Z
[junit4] 2> 1001272 INFO (jetty-launcher-1109-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1001272 INFO (jetty-launcher-1109-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@464af735{/solr,null,AVAILABLE}
[junit4] 2> 1001272 INFO (jetty-launcher-1109-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@555db601{/solr,null,AVAILABLE}
[junit4] 2> 1001273 INFO (jetty-launcher-1109-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2aec3cc9{/solr,null,AVAILABLE}
[junit4] 2> 1001273 INFO (jetty-launcher-1109-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4a9b022c{SSL,[ssl, http/1.1]}{127.0.0.1:40127}
[junit4] 2> 1001273 INFO (jetty-launcher-1109-thread-3) [ ] o.e.j.s.Server Started @1003358ms
[junit4] 2> 1001273 INFO (jetty-launcher-1109-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=40127}
[junit4] 2> 1001273 ERROR (jetty-launcher-1109-thread-3) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1001273 INFO (jetty-launcher-1109-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 6.6.1
[junit4] 2> 1001273 INFO (jetty-launcher-1109-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1001273 INFO (jetty-launcher-1109-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1001273 INFO (jetty-launcher-1109-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-08-24T10:47:39.476830Z
[junit4] 2> 1001274 INFO (jetty-launcher-1109-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@fc53422{SSL,[ssl, http/1.1]}{127.0.0.1:35635}
[junit4] 2> 1001274 INFO (jetty-launcher-1109-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5ee650ec{SSL,[ssl, http/1.1]}{127.0.0.1:38519}
[junit4] 2> 1001274 INFO (jetty-launcher-1109-thread-1) [ ] o.e.j.s.Server Started @1003360ms
[junit4] 2> 1001274 INFO (jetty-launcher-1109-thread-2) [ ] o.e.j.s.Server Started @1003360ms
[junit4] 2> 1001274 INFO (jetty-launcher-1109-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=35635}
[junit4] 2> 1001274 INFO (jetty-launcher-1109-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=38519}
[junit4] 2> 1001274 ERROR (jetty-launcher-1109-thread-1) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1001274 ERROR (jetty-launcher-1109-thread-2) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1001274 INFO (jetty-launcher-1109-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 6.6.1
[junit4] 2> 1001274 INFO (jetty-launcher-1109-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 6.6.1
[junit4] 2> 1001274 INFO (jetty-launcher-1109-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1001274 INFO (jetty-launcher-1109-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1001274 INFO (jetty-launcher-1109-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1001274 INFO (jetty-launcher-1109-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1001275 INFO (jetty-launcher-1109-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-08-24T10:47:39.477995Z
[junit4] 2> 1001275 INFO (jetty-launcher-1109-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-08-24T10:47:39.478015Z
[junit4] 2> 1001278 INFO (jetty-launcher-1109-thread-4) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1001278 INFO (jetty-launcher-1109-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1001278 INFO (jetty-launcher-1109-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40089/solr
[junit4] 2> 1001281 INFO (jetty-launcher-1109-thread-3) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1001282 INFO (jetty-launcher-1109-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1001282 INFO (jetty-launcher-1109-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40089/solr
[junit4] 2> 1001282 INFO (jetty-launcher-1109-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1001285 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 0x15e13daca3a0004, 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> 1001286 INFO (jetty-launcher-1109-thread-2) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1001286 INFO (jetty-launcher-1109-thread-1) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1001286 INFO (jetty-launcher-1109-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40089/solr
[junit4] 2> 1001287 INFO (jetty-launcher-1109-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40089/solr
[junit4] 2> 1001294 INFO (jetty-launcher-1109-thread-1) [ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1001294 INFO (jetty-launcher-1109-thread-3) [ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1001294 INFO (jetty-launcher-1109-thread-4) [ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1001294 INFO (jetty-launcher-1109-thread-2) [ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1001296 INFO (jetty-launcher-1109-thread-1) [ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:35635_solr
[junit4] 2> 1001296 INFO (jetty-launcher-1109-thread-4) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34853_solr
[junit4] 2> 1001296 INFO (jetty-launcher-1109-thread-2) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38519_solr
[junit4] 2> 1001296 INFO (jetty-launcher-1109-thread-3) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:40127_solr
[junit4] 2> 1001296 INFO (jetty-launcher-1109-thread-1) [ ] o.a.s.c.Overseer Overseer (id=98538072265326604-127.0.0.1:35635_solr-n_0000000000) starting
[junit4] 2> 1001297 INFO (zkCallback-1120-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1001297 INFO (zkCallback-1125-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1001297 INFO (zkCallback-1131-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1001298 INFO (zkCallback-1125-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1001298 INFO (zkCallback-1120-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1001301 INFO (zkCallback-1130-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 1001307 INFO (zkCallback-1131-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1001323 INFO (jetty-launcher-1109-thread-3) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node2/.
[junit4] 2> 1001327 INFO (jetty-launcher-1109-thread-4) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node4/.
[junit4] 2> 1001328 INFO (jetty-launcher-1109-thread-1) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:35635_solr
[junit4] 2> 1001329 INFO (zkCallback-1120-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1001329 INFO (zkCallback-1130-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1001329 INFO (zkCallback-1125-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1001340 INFO (zkCallback-1131-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1001347 INFO (jetty-launcher-1109-thread-2) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node1/.
[junit4] 2> 1001367 INFO (jetty-launcher-1109-thread-1) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node3/.
[junit4] 2> 1001372 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[3F569E6B59793CF3]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1001372 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[3F569E6B59793CF3]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:40089/solr ready
[junit4] 2> 1001385 INFO (TEST-CollectionsAPIDistributedZkTest.testCreateNodeSet-seed#[3F569E6B59793CF3]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCreateNodeSet
[junit4] 2> 1001386 INFO (TEST-CollectionsAPIDistributedZkTest.testCreateNodeSet-seed#[3F569E6B59793CF3]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1001443 INFO (qtp1054634721-8694) [ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=1&collection.configName=conf&name=nodeset_collection&action=CREATE&numShards=2&createNodeSet=https://127.0.0.1:38519/solr,https://127.0.0.1:38519/solr&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1001444 INFO (OverseerThreadFactory-2858-thread-1) [ ] o.a.s.c.CreateCollectionCmd Create collection nodeset_collection
[junit4] 2> 1001445 WARN (OverseerThreadFactory-2858-thread-1) [ ] o.a.s.c.CreateCollectionCmd It is unusual to create a collection (nodeset_collection) without cores.
[junit4] 2> 1001550 INFO (qtp1054634721-8694) [ ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 30 seconds. Check all shard replicas
[junit4] 2> 1001556 INFO (qtp1054634721-8694) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=1&collection.configName=conf&name=nodeset_collection&action=CREATE&numShards=2&createNodeSet=https://127.0.0.1:38519/solr,https://127.0.0.1:38519/solr&wt=javabin&version=2} status=0 QTime=112
[junit4] 2> 1001556 INFO (TEST-CollectionsAPIDistributedZkTest.testCreateNodeSet-seed#[3F569E6B59793CF3]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCreateNodeSet
[junit4] 2> 1001568 INFO (TEST-CollectionsAPIDistributedZkTest.testCollectionReload-seed#[3F569E6B59793CF3]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCollectionReload
[junit4] 2> 1001569 INFO (TEST-CollectionsAPIDistributedZkTest.testCollectionReload-seed#[3F569E6B59793CF3]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1001571 INFO (qtp1054634721-8699) [ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params name=nodeset_collection&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1001572 INFO (OverseerCollectionConfigSetProcessor-98538072265326604-127.0.0.1:35635_solr-n_0000000000) [ ] 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> 1001572 INFO (OverseerThreadFactory-2858-thread-2) [ ] o.a.s.c.OverseerCollectionMessageHandler Executing Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true
[junit4] 2> 1002274 INFO (qtp1054634721-8699) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=nodeset_collection&action=DELETE&wt=javabin&version=2} status=0 QTime=703
[junit4] 2> 1002276 INFO (qtp1054634721-8700) [ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=2&collection.configName=conf&name=reloaded_collection&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1002277 INFO (OverseerThreadFactory-2858-thread-3) [ ] o.a.s.c.CreateCollectionCmd Create collection reloaded_collection
[junit4] 2> 1002277 INFO (OverseerCollectionConfigSetProcessor-98538072265326604-127.0.0.1:35635_solr-n_0000000000) [ ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 1002489 INFO (qtp1054634721-8699) [ ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=reloaded_collection_shard1_replica1&action=CREATE&numShards=2&collection=reloaded_collection&shard=shard1&wt=javabin&version=2
[junit4] 2> 1002489 INFO (qtp1054634721-8699) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1002535 INFO (qtp704362555-8707) [ ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=reloaded_collection_shard2_replica1&action=CREATE&numShards=2&collection=reloaded_collection&shard=shard2&wt=javabin&version=2
[junit4] 2> 1002535 INFO (qtp2010056731-8706) [ ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=reloaded_collection_shard1_replica2&action=CREATE&numShards=2&collection=reloaded_collection&shard=shard1&wt=javabin&version=2
[junit4] 2> 1002535 INFO (qtp821382763-8704) [ ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=reloaded_collection_shard2_replica2&action=CREATE&numShards=2&collection=reloaded_collection&shard=shard2&wt=javabin&version=2
[junit4] 2> 1002535 INFO (qtp2010056731-8706) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1002535 INFO (qtp704362555-8707) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1002535 INFO (qtp821382763-8704) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1002637 INFO (zkCallback-1125-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1002638 INFO (zkCallback-1130-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1002638 INFO (zkCallback-1131-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1002637 INFO (zkCallback-1120-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1003495 INFO (qtp1054634721-8699) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.1
[junit4] 2> 1003498 INFO (qtp1054634721-8699) [ ] o.a.s.s.IndexSchema [reloaded_collection_shard1_replica1] Schema name=minimal
[junit4] 2> 1003499 INFO (qtp1054634721-8699) [ ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1003499 INFO (qtp1054634721-8699) [ ] o.a.s.c.CoreContainer Creating SolrCore 'reloaded_collection_shard1_replica1' using configuration from collection reloaded_collection, trusted=true
[junit4] 2> 1003499 INFO (qtp1054634721-8699) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1003499 INFO (qtp1054634721-8699) [ ] o.a.s.c.SolrCore [[reloaded_collection_shard1_replica1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node4/reloaded_collection_shard1_replica1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node4/./reloaded_collection_shard1_replica1/data/]
[junit4] 2> 1003530 INFO (qtp1054634721-8699) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1003530 INFO (qtp1054634721-8699) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1003531 INFO (qtp1054634721-8699) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1003531 INFO (qtp1054634721-8699) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1003531 INFO (qtp1054634721-8699) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@48838478[reloaded_collection_shard1_replica1] main]
[junit4] 2> 1003532 INFO (qtp1054634721-8699) [ ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 1003532 INFO (qtp1054634721-8699) [ ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1003532 INFO (qtp1054634721-8699) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1003533 INFO (searcherExecutor-2863-thread-1) [ ] o.a.s.c.SolrCore [reloaded_collection_shard1_replica1] Registered new searcher Searcher@48838478[reloaded_collection_shard1_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1003533 INFO (qtp1054634721-8699) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1576609158776487936
[junit4] 2> 1003536 INFO (qtp1054634721-8699) [ ] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard1: total=2 found=1 timeoutin=9999ms
[junit4] 2> 1003541 INFO (qtp2010056731-8706) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.1
[junit4] 2> 1003541 INFO (qtp704362555-8707) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.1
[junit4] 2> 1003547 INFO (qtp2010056731-8706) [ ] o.a.s.s.IndexSchema [reloaded_collection_shard1_replica2] Schema name=minimal
[junit4] 2> 1003548 INFO (qtp2010056731-8706) [ ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1003548 INFO (qtp2010056731-8706) [ ] o.a.s.c.CoreContainer Creating SolrCore 'reloaded_collection_shard1_replica2' using configuration from collection reloaded_collection, trusted=true
[junit4] 2> 1003548 INFO (qtp704362555-8707) [ ] o.a.s.s.IndexSchema [reloaded_collection_shard2_replica1] Schema name=minimal
[junit4] 2> 1003548 INFO (qtp2010056731-8706) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1003549 INFO (qtp2010056731-8706) [ ] o.a.s.c.SolrCore [[reloaded_collection_shard1_replica2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node2/reloaded_collection_shard1_replica2], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node2/./reloaded_collection_shard1_replica2/data/]
[junit4] 2> 1003550 INFO (qtp821382763-8704) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.1
[junit4] 2> 1003553 INFO (qtp704362555-8707) [ ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1003553 INFO (qtp704362555-8707) [ ] o.a.s.c.CoreContainer Creating SolrCore 'reloaded_collection_shard2_replica1' using configuration from collection reloaded_collection, trusted=true
[junit4] 2> 1003553 INFO (qtp704362555-8707) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1003553 INFO (qtp704362555-8707) [ ] o.a.s.c.SolrCore [[reloaded_collection_shard2_replica1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node1/reloaded_collection_shard2_replica1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node1/./reloaded_collection_shard2_replica1/data/]
[junit4] 2> 1003556 INFO (qtp821382763-8704) [ ] o.a.s.s.IndexSchema [reloaded_collection_shard2_replica2] Schema name=minimal
[junit4] 2> 1003557 INFO (qtp821382763-8704) [ ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1003557 INFO (qtp821382763-8704) [ ] o.a.s.c.CoreContainer Creating SolrCore 'reloaded_collection_shard2_replica2' using configuration from collection reloaded_collection, trusted=true
[junit4] 2> 1003557 INFO (qtp821382763-8704) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1003557 INFO (qtp821382763-8704) [ ] o.a.s.c.SolrCore [[reloaded_collection_shard2_replica2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node3/reloaded_collection_shard2_replica2], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node3/./reloaded_collection_shard2_replica2/data/]
[junit4] 2> 1003629 INFO (qtp821382763-8704) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1003629 INFO (qtp2010056731-8706) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1003629 INFO (qtp821382763-8704) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1003629 INFO (qtp2010056731-8706) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1003630 INFO (qtp821382763-8704) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1003630 INFO (qtp2010056731-8706) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1003630 INFO (qtp821382763-8704) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1003630 INFO (qtp2010056731-8706) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1003630 INFO (qtp821382763-8704) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@63c90b3e[reloaded_collection_shard2_replica2] main]
[junit4] 2> 1003630 INFO (qtp2010056731-8706) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@17d972[reloaded_collection_shard1_replica2] main]
[junit4] 2> 1003631 INFO (qtp821382763-8704) [ ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 1003631 INFO (qtp2010056731-8706) [ ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 1003631 INFO (qtp821382763-8704) [ ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1003631 INFO (qtp821382763-8704) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1003631 INFO (qtp2010056731-8706) [ ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1003631 INFO (qtp2010056731-8706) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1003631 INFO (qtp821382763-8704) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1576609158879248384
[junit4] 2> 1003632 INFO (qtp2010056731-8706) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1576609158880296960
[junit4] 2> 1003637 INFO (searcherExecutor-2870-thread-1) [ ] o.a.s.c.SolrCore [reloaded_collection_shard2_replica2] Registered new searcher Searcher@63c90b3e[reloaded_collection_shard2_replica2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1003638 INFO (searcherExecutor-2868-thread-1) [ ] o.a.s.c.SolrCore [reloaded_collection_shard1_replica2] Registered new searcher Searcher@17d972[reloaded_collection_shard1_replica2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1003640 INFO (qtp821382763-8704) [ ] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard2: total=2 found=1 timeoutin=9999ms
[junit4] 2> 1003648 INFO (qtp704362555-8707) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1003648 INFO (qtp704362555-8707) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1003649 INFO (qtp704362555-8707) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1003649 INFO (qtp704362555-8707) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1003650 INFO (qtp704362555-8707) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@183260e7[reloaded_collection_shard2_replica1] main]
[junit4] 2> 1003651 INFO (qtp704362555-8707) [ ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 1003651 INFO (qtp704362555-8707) [ ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1003651 INFO (qtp704362555-8707) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1003651 INFO (qtp704362555-8707) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1576609158900219904
[junit4] 2> 1003652 INFO (searcherExecutor-2869-thread-1) [ ] o.a.s.c.SolrCore [reloaded_collection_shard2_replica1] Registered new searcher Searcher@183260e7[reloaded_collection_shard2_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1003741 INFO (zkCallback-1120-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1003741 INFO (zkCallback-1131-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1003741 INFO (zkCallback-1130-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1003741 INFO (zkCallback-1125-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004036 INFO (qtp1054634721-8699) [ ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1004036 INFO (qtp1054634721-8699) [ ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1004036 INFO (qtp1054634721-8699) [ ] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:34853/solr/reloaded_collection_shard1_replica1/
[junit4] 2> 1004037 INFO (qtp1054634721-8699) [ ] o.a.s.u.PeerSync PeerSync: core=reloaded_collection_shard1_replica1 url=https://127.0.0.1:34853/solr START replicas=[https://127.0.0.1:40127/solr/reloaded_collection_shard1_replica2/] nUpdates=100
[junit4] 2> 1004037 INFO (qtp1054634721-8699) [ ] o.a.s.u.PeerSync PeerSync: core=reloaded_collection_shard1_replica1 url=https://127.0.0.1:34853/solr DONE. We have no versions. sync failed.
[junit4] 2> 1004041 INFO (qtp2010056731-8727) [ ] o.a.s.c.S.Request [reloaded_collection_shard1_replica2] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1004041 INFO (qtp1054634721-8699) [ ] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate
[junit4] 2> 1004041 INFO (qtp1054634721-8699) [ ] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 1004041 INFO (qtp1054634721-8699) [ ] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR
[junit4] 2> 1004042 INFO (qtp1054634721-8699) [ ] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:34853/solr/reloaded_collection_shard1_replica1/ shard1
[junit4] 2> 1004140 INFO (qtp821382763-8704) [ ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1004140 INFO (qtp821382763-8704) [ ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1004140 INFO (qtp821382763-8704) [ ] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:35635/solr/reloaded_collection_shard2_replica2/
[junit4] 2> 1004140 INFO (qtp821382763-8704) [ ] o.a.s.u.PeerSync PeerSync: core=reloaded_collection_shard2_replica2 url=https://127.0.0.1:35635/solr START replicas=[https://127.0.0.1:38519/solr/reloaded_collection_shard2_replica1/] nUpdates=100
[junit4] 2> 1004140 INFO (qtp821382763-8704) [ ] o.a.s.u.PeerSync PeerSync: core=reloaded_collection_shard2_replica2 url=https://127.0.0.1:35635/solr DONE. We have no versions. sync failed.
[junit4] 2> 1004143 INFO (qtp704362555-8730) [ ] o.a.s.c.S.Request [reloaded_collection_shard2_replica1] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1004143 INFO (qtp821382763-8704) [ ] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate
[junit4] 2> 1004143 INFO (qtp821382763-8704) [ ] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 1004143 INFO (qtp821382763-8704) [ ] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR
[junit4] 2> 1004143 INFO (zkCallback-1125-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004143 INFO (zkCallback-1130-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004143 INFO (zkCallback-1120-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004143 INFO (zkCallback-1131-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004145 INFO (qtp821382763-8704) [ ] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:35635/solr/reloaded_collection_shard2_replica2/ shard2
[junit4] 2> 1004193 INFO (qtp1054634721-8699) [ ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1004194 INFO (qtp1054634721-8699) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=reloaded_collection_shard1_replica1&action=CREATE&numShards=2&collection=reloaded_collection&shard=shard1&wt=javabin&version=2} status=0 QTime=1705
[junit4] 2> 1004296 INFO (zkCallback-1125-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004296 INFO (zkCallback-1130-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004296 INFO (zkCallback-1120-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004297 INFO (zkCallback-1131-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004345 INFO (qtp821382763-8704) [ ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1004346 INFO (qtp821382763-8704) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=reloaded_collection_shard2_replica2&action=CREATE&numShards=2&collection=reloaded_collection&shard=shard2&wt=javabin&version=2} status=0 QTime=1811
[junit4] 2> 1004447 INFO (zkCallback-1125-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004447 INFO (zkCallback-1130-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004447 INFO (zkCallback-1131-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004447 INFO (zkCallback-1120-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004640 INFO (qtp2010056731-8706) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=reloaded_collection_shard1_replica2&action=CREATE&numShards=2&collection=reloaded_collection&shard=shard1&wt=javabin&version=2} status=0 QTime=2105
[junit4] 2> 1004655 INFO (qtp704362555-8707) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=reloaded_collection_shard2_replica1&action=CREATE&numShards=2&collection=reloaded_collection&shard=shard2&wt=javabin&version=2} status=0 QTime=2120
[junit4] 2> 1004656 INFO (qtp1054634721-8700) [ ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 30 seconds. Check all shard replicas
[junit4] 2> 1004756 INFO (zkCallback-1131-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004756 INFO (zkCallback-1125-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004756 INFO (zkCallback-1120-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1004756 INFO (zkCallback-1130-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1005656 INFO (qtp1054634721-8700) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=2&collection.configName=conf&name=reloaded_collection&action=CREATE&numShards=2&wt=javabin&version=2} status=0 QTime=3380
[junit4] 2> 1005659 INFO (qtp1054634721-8696) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005662 INFO (qtp2010056731-8727) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005664 INFO (qtp704362555-8707) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005667 INFO (qtp821382763-8705) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005669 INFO (qtp1054634721-8701) [ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :reload with params async=25cfe03d-8533-4685-8977-edfa2c44690e&name=reloaded_collection&action=RELOAD&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1005669 INFO (qtp1054634721-8701) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={async=25cfe03d-8533-4685-8977-edfa2c44690e&name=reloaded_collection&action=RELOAD&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005670 INFO (OverseerThreadFactory-2858-thread-4) [ ] o.a.s.c.OverseerCollectionMessageHandler Executing Collection Cmd : action=RELOAD
[junit4] 2> 1005671 INFO (OverseerCollectionConfigSetProcessor-98538072265326604-127.0.0.1:35635_solr-n_0000000000) [ ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000004 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 1005672 INFO (qtp1054634721-8699) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005672 INFO (qtp2010056731-8725) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={core=reloaded_collection_shard1_replica2&async=25cfe03d-8533-4685-8977-edfa2c44690e2568586877649397&qt=/admin/cores&action=RELOAD&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005672 INFO (qtp704362555-8726) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={core=reloaded_collection_shard2_replica1&async=25cfe03d-8533-4685-8977-edfa2c44690e2568586877771128&qt=/admin/cores&action=RELOAD&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005673 INFO (qtp1054634721-8694) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={core=reloaded_collection_shard1_replica1&async=25cfe03d-8533-4685-8977-edfa2c44690e2568586877604134&qt=/admin/cores&action=RELOAD&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005678 INFO (qtp821382763-8717) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={core=reloaded_collection_shard2_replica2&async=25cfe03d-8533-4685-8977-edfa2c44690e2568586877791144&qt=/admin/cores&action=RELOAD&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005683 INFO (qtp2010056731-8706) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=5
[junit4] 2> 1005684 INFO (qtp704362555-8707) [ ] o.a.s.h.a.CoreAdminOperation Checking request status for : 25cfe03d-8533-4685-8977-edfa2c44690e2568586877771128
[junit4] 2> 1005684 INFO (qtp704362555-8707) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=25cfe03d-8533-4685-8977-edfa2c44690e2568586877771128&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005687 INFO (qtp704362555-8726) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005688 INFO (parallelCoreAdminExecutor-2854-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.1
[junit4] 2> 1005689 INFO (parallelCoreAdminExecutor-2859-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.1
[junit4] 2> 1005690 INFO (qtp821382763-8704) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005691 INFO (parallelCoreAdminExecutor-2861-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.1
[junit4] 2> 1005693 INFO (parallelCoreAdminExecutor-2855-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.1
[junit4] 2> 1005693 INFO (parallelCoreAdminExecutor-2854-thread-1) [ ] o.a.s.s.IndexSchema [reloaded_collection_shard1_replica2] Schema name=minimal
[junit4] 2> 1005694 INFO (parallelCoreAdminExecutor-2859-thread-1) [ ] o.a.s.s.IndexSchema [reloaded_collection_shard2_replica1] Schema name=minimal
[junit4] 2> 1005695 INFO (parallelCoreAdminExecutor-2854-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1005695 INFO (parallelCoreAdminExecutor-2854-thread-1) [ ] o.a.s.c.CoreContainer Reloading SolrCore 'reloaded_collection_shard1_replica2' using configuration from collection reloaded_collection
[junit4] 2> 1005706 INFO (parallelCoreAdminExecutor-2854-thread-1) [ ] o.a.s.c.SolrCore [[reloaded_collection_shard1_replica2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node2/reloaded_collection_shard1_replica2], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node2/./reloaded_collection_shard1_replica2/data/]
[junit4] 2> 1005707 INFO (parallelCoreAdminExecutor-2859-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1005707 INFO (parallelCoreAdminExecutor-2859-thread-1) [ ] o.a.s.c.CoreContainer Reloading SolrCore 'reloaded_collection_shard2_replica1' using configuration from collection reloaded_collection
[junit4] 2> 1005722 INFO (parallelCoreAdminExecutor-2861-thread-1) [ ] o.a.s.s.IndexSchema [reloaded_collection_shard2_replica2] Schema name=minimal
[junit4] 2> 1005722 INFO (parallelCoreAdminExecutor-2859-thread-1) [ ] o.a.s.c.SolrCore [[reloaded_collection_shard2_replica1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node1/reloaded_collection_shard2_replica1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node1/./reloaded_collection_shard2_replica1/data/]
[junit4] 2> 1005723 INFO (parallelCoreAdminExecutor-2855-thread-1) [ ] o.a.s.s.IndexSchema [reloaded_collection_shard1_replica1] Schema name=minimal
[junit4] 2> 1005724 INFO (parallelCoreAdminExecutor-2861-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1005724 INFO (parallelCoreAdminExecutor-2861-thread-1) [ ] o.a.s.c.CoreContainer Reloading SolrCore 'reloaded_collection_shard2_replica2' using configuration from collection reloaded_collection
[junit4] 2> 1005725 INFO (qtp1054634721-8701) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005728 INFO (parallelCoreAdminExecutor-2861-thread-1) [ ] o.a.s.c.SolrCore [[reloaded_collection_shard2_replica2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node3/reloaded_collection_shard2_replica2], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node3/./reloaded_collection_shard2_replica2/data/]
[junit4] 2> 1005729 INFO (parallelCoreAdminExecutor-2855-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1005729 INFO (parallelCoreAdminExecutor-2855-thread-1) [ ] o.a.s.c.CoreContainer Reloading SolrCore 'reloaded_collection_shard1_replica1' using configuration from collection reloaded_collection
[junit4] 2> 1005731 INFO (qtp2010056731-8706) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005733 INFO (parallelCoreAdminExecutor-2855-thread-1) [ ] o.a.s.c.SolrCore [[reloaded_collection_shard1_replica1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node4/reloaded_collection_shard1_replica1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001/tempDir-001/node4/./reloaded_collection_shard1_replica1/data/]
[junit4] 2> 1005745 INFO (qtp704362555-8733) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005748 INFO (qtp821382763-8709) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005752 INFO (qtp1054634721-8701) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005754 INFO (parallelCoreAdminExecutor-2854-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1005754 INFO (parallelCoreAdminExecutor-2854-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1005755 INFO (parallelCoreAdminExecutor-2854-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7b310e66[reloaded_collection_shard1_replica2] main]
[junit4] 2> 1005755 INFO (parallelCoreAdminExecutor-2854-thread-1) [ ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 1005756 INFO (parallelCoreAdminExecutor-2854-thread-1) [ ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1005756 INFO (parallelCoreAdminExecutor-2854-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1005756 INFO (searcherExecutor-2883-thread-1) [ ] o.a.s.c.SolrCore [reloaded_collection_shard1_replica2] Registered new searcher Searcher@7b310e66[reloaded_collection_shard1_replica2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1005756 INFO (parallelCoreAdminExecutor-2854-thread-1) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1576609161107472384
[junit4] 2> 1005758 INFO (parallelCoreAdminExecutor-2854-thread-1) [ ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1005758 INFO (parallelCoreAdminExecutor-2854-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2bf3e0b7[reloaded_collection_shard1_replica2] main]
[junit4] 2> 1005758 INFO (parallelCoreAdminExecutor-2854-thread-1) [ ] o.a.s.c.SolrCore [reloaded_collection_shard1_replica2] CLOSING SolrCore org.apache.solr.core.SolrCore@4867bfe
[junit4] 2> 1005758 INFO (searcherExecutor-2883-thread-1) [ ] o.a.s.c.SolrCore [reloaded_collection_shard1_replica2] Registered new searcher Searcher@2bf3e0b7[reloaded_collection_shard1_replica2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1005759 INFO (parallelCoreAdminExecutor-2854-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.reloaded_collection.shard1.replica2
[junit4] 2> 1005762 INFO (parallelCoreAdminExecutor-2859-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1005762 INFO (parallelCoreAdminExecutor-2859-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1005763 INFO (parallelCoreAdminExecutor-2859-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3e8aea45[reloaded_collection_shard2_replica1] main]
[junit4] 2> 1005763 INFO (qtp2010056731-8722) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005763 INFO (parallelCoreAdminExecutor-2859-thread-1) [ ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 1005763 INFO (parallelCoreAdminExecutor-2861-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1005763 INFO (parallelCoreAdminExecutor-2861-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1005764 INFO (parallelCoreAdminExecutor-2859-thread-1) [ ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1005764 INFO (parallelCoreAdminExecutor-2859-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1005764 INFO (searcherExecutor-2884-thread-1) [ ] o.a.s.c.SolrCore [reloaded_collection_shard2_replica1] Registered new searcher Searcher@3e8aea45[reloaded_collection_shard2_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1005766 INFO (parallelCoreAdminExecutor-2861-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2b1127df[reloaded_collection_shard2_replica2] main]
[junit4] 2> 1005766 INFO (parallelCoreAdminExecutor-2859-thread-1) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1576609161117958144
[junit4] 2> 1005766 INFO (parallelCoreAdminExecutor-2855-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1005766 INFO (parallelCoreAdminExecutor-2855-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1005766 INFO (parallelCoreAdminExecutor-2861-thread-1) [ ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 1005770 INFO (parallelCoreAdminExecutor-2855-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7e7147dd[reloaded_collection_shard1_replica1] main]
[junit4] 2> 1005770 INFO (parallelCoreAdminExecutor-2861-thread-1) [ ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1005770 INFO (parallelCoreAdminExecutor-2861-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1005770 INFO (parallelCoreAdminExecutor-2861-thread-1) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1576609161122152448
[junit4] 2> 1005770 INFO (searcherExecutor-2885-thread-1) [ ] o.a.s.c.SolrCore [reloaded_collection_shard2_replica2] Registered new searcher Searcher@2b1127df[reloaded_collection_shard2_replica2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1005771 INFO (parallelCoreAdminExecutor-2855-thread-1) [ ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 1005774 INFO (parallelCoreAdminExecutor-2859-thread-1) [ ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1005774 INFO (parallelCoreAdminExecutor-2859-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6ebaa40a[reloaded_collection_shard2_replica1] main]
[junit4] 2> 1005774 INFO (parallelCoreAdminExecutor-2855-thread-1) [ ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1005774 INFO (parallelCoreAdminExecutor-2859-thread-1) [ ] o.a.s.c.SolrCore [reloaded_collection_shard2_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@6153512a
[junit4] 2> 1005774 INFO (searcherExecutor-2884-thread-1) [ ] o.a.s.c.SolrCore [reloaded_collection_shard2_replica1] Registered new searcher Searcher@6ebaa40a[reloaded_collection_shard2_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1005775 INFO (parallelCoreAdminExecutor-2855-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1005775 INFO (parallelCoreAdminExecutor-2861-thread-1) [ ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1005775 INFO (qtp704362555-8726) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005775 INFO (parallelCoreAdminExecutor-2859-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.reloaded_collection.shard2.replica1
[junit4] 2> 1005775 INFO (parallelCoreAdminExecutor-2861-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7fa15e2f[reloaded_collection_shard2_replica2] main]
[junit4] 2> 1005775 INFO (parallelCoreAdminExecutor-2861-thread-1) [ ] o.a.s.c.SolrCore [reloaded_collection_shard2_replica2] CLOSING SolrCore org.apache.solr.core.SolrCore@51a32c0a
[junit4] 2> 1005776 INFO (parallelCoreAdminExecutor-2861-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.reloaded_collection.shard2.replica2
[junit4] 2> 1005776 INFO (searcherExecutor-2886-thread-1) [ ] o.a.s.c.SolrCore [reloaded_collection_shard1_replica1] Registered new searcher Searcher@7e7147dd[reloaded_collection_shard1_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1005776 INFO (searcherExecutor-2885-thread-1) [ ] o.a.s.c.SolrCore [reloaded_collection_shard2_replica2] Registered new searcher Searcher@7fa15e2f[reloaded_collection_shard2_replica2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1005776 INFO (parallelCoreAdminExecutor-2855-thread-1) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1576609161128443904
[junit4] 2> 1005778 INFO (parallelCoreAdminExecutor-2855-thread-1) [ ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1005779 INFO (parallelCoreAdminExecutor-2855-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3a6c7689[reloaded_collection_shard1_replica1] main]
[junit4] 2> 1005779 INFO (parallelCoreAdminExecutor-2855-thread-1) [ ] o.a.s.c.SolrCore [reloaded_collection_shard1_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@6898635b
[junit4] 2> 1005779 INFO (searcherExecutor-2886-thread-1) [ ] o.a.s.c.SolrCore [reloaded_collection_shard1_replica1] Registered new searcher Searcher@3a6c7689[reloaded_collection_shard1_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1005779 INFO (parallelCoreAdminExecutor-2855-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.reloaded_collection.shard1.replica1
[junit4] 2> 1005780 INFO (qtp821382763-8710) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005782 INFO (qtp1054634721-8700) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005785 INFO (qtp2010056731-8706) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005787 INFO (qtp704362555-8733) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005789 INFO (qtp821382763-8720) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1005790 INFO (TEST-CollectionsAPIDistributedZkTest.testCollectionReload-seed#[3F569E6B59793CF3]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCollectionReload
[junit4] 2> 1005808 INFO (TEST-CollectionsAPIDistributedZkTest.testTooManyReplicas-seed#[3F569E6B59793CF3]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testTooManyReplicas
[junit4] 2> 1005809 INFO (TEST-CollectionsAPIDistributedZkTest.testTooManyReplicas-seed#[3F569E6B59793CF3]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1005810 INFO (qtp1054634721-8696) [ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params name=reloaded_collection&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1006686 INFO (qtp704362555-8711) [ ] o.a.s.h.a.CoreAdminOperation Checking request status for : 25cfe03d-8533-4685-8977-edfa2c44690e2568586877771128
[junit4] 2> 1006686 INFO (qtp704362555-8711) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=25cfe03d-8533-4685-8977-edfa2c44690e2568586877771128&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1006688 INFO (qtp2010056731-8727) [ ] o.a.s.h.a.CoreAdminOperation Checking request status for : 25cfe03d-8533-4685-8977-edfa2c44690e2568586877649397
[junit4] 2> 1006688 INFO (qtp2010056731-8727) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=25cfe03d-8533-4685-8977-edfa2c44690e2568586877649397&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1006689 INFO (qtp1054634721-8701) [ ] o.a.s.h.a.CoreAdminOperation Checking request status for : 25cfe03d-8533-4685-8977-edfa2c44690e2568586877604134
[junit4] 2> 1006689 INFO (qtp1054634721-8701) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=25cfe03d-8533-4685-8977-edfa2c44690e2568586877604134&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1006691 INFO (qtp821382763-8705) [ ] o.a.s.h.a.CoreAdminOperation Checking request status for : 25cfe03d-8533-4685-8977-edfa2c44690e2568586877791144
[junit4] 2> 1006691 INFO (qtp821382763-8705) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=25cfe03d-8533-4685-8977-edfa2c44690e2568586877791144&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1006692 INFO (OverseerThreadFactory-2858-thread-4) [ ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000006 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 1007812 INFO (OverseerThreadFactory-2858-thread-5) [ ] o.a.s.c.OverseerCollectionMessageHandler Executing Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true
[junit4] 2> 1007812 INFO (OverseerCollectionConfigSetProcessor-98538072265326604-127.0.0.1:35635_solr-n_0000000000) [ ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000006 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 1007814 INFO (qtp2010056731-8706) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.reloaded_collection.shard1.replica2
[junit4] 2> 1007814 INFO (qtp1054634721-8694) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.reloaded_collection.shard1.replica1
[junit4] 2> 1007814 INFO (qtp2010056731-8706) [ ] o.a.s.c.SolrCore [reloaded_collection_shard1_replica2] CLOSING SolrCore org.apache.solr.core.SolrCore@24be7efa
[junit4] 2> 1007814 INFO (qtp1054634721-8694) [ ] o.a.s.c.SolrCore [reloaded_collection_shard1_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@795b8de7
[junit4] 2> 1007814 INFO (qtp821382763-8710) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.reloaded_collection.shard2.replica2
[junit4] 2> 1007814 INFO (qtp704362555-8730) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.reloaded_collection.shard2.replica1
[junit4] 2> 1007814 INFO (qtp821382763-8710) [ ] o.a.s.c.SolrCore [reloaded_collection_shard2_replica2] CLOSING SolrCore org.apache.solr.core.SolrCore@1c42c461
[junit4] 2> 1007814 INFO (qtp704362555-8730) [ ] o.a.s.c.SolrCore [reloaded_collection_shard2_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@7089b028
[junit4] 2> 1007816 INFO (qtp1054634721-8694) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.reloaded_collection.shard1.replica1
[junit4] 2> 1007816 INFO (qtp2010056731-8706) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.reloaded_collection.shard1.replica2
[junit4] 2> 1007816 INFO (qtp704362555-8730) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.reloaded_collection.shard2.replica1
[junit4] 2> 1007816 INFO (qtp821382763-8710) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.reloaded_collection.shard2.replica2
[junit4] 2> 1007817 INFO (qtp704362555-8730) [ ] o.a.s.c.ShardLeaderElectionContextBase No version found for ephemeral leader parent node, won't remove previous leader registration.
[junit4] 2> 1007817 INFO (qtp2010056731-8706) [ ] o.a.s.c.ShardLeaderElectionContextBase No version found for ephemeral leader parent node, won't remove previous leader registration.
[junit4] 2> 1007817 WARN (zkCallback-1130-thread-1) [ ] o.a.s.c.LeaderElector Our node is no longer in line to be leader
[junit4] 2> 1007818 INFO (qtp2010056731-8706) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={deleteInstanceDir=true&core=reloaded_collection_shard1_replica2&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2} status=0 QTime=3
[junit4] 2> 1007818 INFO (qtp704362555-8730) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={deleteInstanceDir=true&core=reloaded_collection_shard2_replica1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2} status=0 QTime=3
[junit4] 2> 1007821 WARN (zkCallback-1125-thread-1) [ ] o.a.s.c.LeaderElector Our node is no longer in line to be leader
[junit4] 2> 1007822 INFO (qtp821382763-8710) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={deleteInstanceDir=true&core=reloaded_collection_shard2_replica2&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2} status=0 QTime=8
[junit4] 2> 1007822 INFO (qtp1054634721-8694) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={deleteInstanceDir=true&core=reloaded_collection_shard1_replica1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2} status=0 QTime=8
[junit4] 2> 1008524 INFO (qtp1054634721-8696) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=reloaded_collection&action=DELETE&wt=javabin&version=2} status=0 QTime=2714
[junit4] 2> 1008527 INFO (qtp1054634721-8700) [ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=10&collection.configName=conf&name=collection&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1008528 INFO (OverseerThreadFactory-2858-thread-5) [ ] o.a.s.c.CreateCollectionCmd Create collection collection
[junit4] 2> 1008528 WARN (OverseerThreadFactory-2858-thread-5) [ ] o.a.s.c.CreateCollectionCmd Specified replicationFactor of 10 on collection collection is higher than or equal to the number of Solr instances currently live or live and part of your createNodeSet(4). It's unusual to run two replica of the same slice on the same Solr-instance.
[junit4] 2> 1008528 ERROR (OverseerThreadFactory-2858-thread-5) [ ] o.a.s.c.OverseerCollectionMessageHandler Collection: collection operation: create failed:org.apache.solr.common.SolrException: Cannot create collection collection. Value of maxShardsPerNode is 1, and the number of nodes currently live or live and part of your createNodeSet is 4. This allows a maximum of 4 to be created. Value of numShards is 2 and value of replicationFactor is 10. This requires 20 shards to be created (higher than the allowed number)
[junit4] 2> at org.apache.solr.cloud.CreateCollectionCmd.call(CreateCollectionCmd.java:155)
[junit4] 2> at org.apache.solr.cloud.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:226)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:464)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
[junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2>
[junit4] 2> 1008529 INFO (OverseerCollectionConfigSetProcessor-98538072265326604-127.0.0.1:35635_solr-n_0000000000) [ ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000007 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 1008531 INFO (qtp1054634721-8700) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=10&collection.configName=conf&name=collection&action=CREATE&numShards=2&wt=javabin&version=2} status=400 QTime=4
[junit4] 2> 1008531 INFO (TEST-CollectionsAPIDistributedZkTest.testTooManyReplicas-seed#[3F569E6B59793CF3]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testTooManyReplicas
[junit4] 2> 1008546 INFO (TEST-CollectionsAPIDistributedZkTest.testCollectionsAPI-seed#[3F569E6B59793CF3]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCollectionsAPI
[junit4] 2> 1008546 INFO (TEST-CollectionsAPIDistributedZkTest.testCollectionsAPI-seed#[3F569E6B59793CF3]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1008548 INFO (qtp1054634721-8701) [ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params async=5e3293e3-8c73-493a-a5fb-427ce32dda38&replicationFactor=4&collection.configName=conf2&maxShardsPerNode=5&name=awhollynewcollection_0&action=CREATE&numShards=4&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1008549 INFO (qtp1054634721-8701) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={async=5e3293e3-8c73-493a-a5fb-427ce32dda38&replicationFactor=4&collection.configName=conf2&maxShardsPerNode=5&name=awhollynewcollection_0&action=CREATE&numShards=4&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1008550 INFO (OverseerThreadFactory-2858-thread-5) [ ] o.a.s.c.CreateCollectionCmd Create collection awhollynewcollection_0
[junit4] 2> 1008550 INFO (OverseerCollectionConfigSetProcessor-98538072265326604-127.0.0.1:35635_solr-n_0000000000) [ ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000009 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 1008652 INFO (zkCallback-1139-thread-5) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/awhollynewcollection_0/state.json] for collection [awhollynewcollection_0] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1008783 INFO (qtp821382763-8717) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589959137884&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard3_replica1&action=CREATE&numShards=4&collection=awhollynewcollection_0&shard=shard3&wt=javabin&version=2} status=0 QTime=17
[junit4] 2> 1008783 INFO (parallelCoreAdminExecutor-2861-thread-3) [ ] o.a.s.h.a.CoreAdminOperation core create command async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589959137884&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard3_replica1&action=CREATE&numShards=4&collection=awhollynewcollection_0&shard=shard3&wt=javabin&version=2
[junit4] 2> 1008784 INFO (qtp704362555-8726) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589970771782&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard2_replica2&action=CREATE&numShards=4&collection=awhollynewcollection_0&shard=shard2&wt=javabin&version=2} status=0 QTime=18
[junit4] 2> 1008784 INFO (parallelCoreAdminExecutor-2859-thread-2) [ ] o.a.s.h.a.CoreAdminOperation core create command async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589970771782&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard2_replica2&action=CREATE&numShards=4&collection=awhollynewcollection_0&shard=shard2&wt=javabin&version=2
[junit4] 2> 1008784 INFO (qtp2010056731-8727) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589959093331&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard3_replica4&action=CREATE&numShards=4&collection=awhollynewcollection_0&shard=shard3&wt=javabin&version=2} status=0 QTime=20
[junit4] 2> 1008785 INFO (parallelCoreAdminExecutor-2854-thread-3) [ ] o.a.s.h.a.CoreAdminOperation core create command async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589959093331&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard3_replica4&action=CREATE&numShards=4&collection=awhollynewcollection_0&shard=shard3&wt=javabin&version=2
[junit4] 2> 1008785 INFO (qtp821382763-8704) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589958967369&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard4_replica1&action=CREATE&numShards=4&collection=awhollynewcollection_0&shard=shard4&wt=javabin&version=2} status=0 QTime=30
[junit4] 2> 1008785 INFO (parallelCoreAdminExecutor-2861-thread-2) [ ] o.a.s.h.a.CoreAdminOperation core create command async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589958967369&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard4_replica1&action=CREATE&numShards=4&collection=awhollynewcollection_0&shard=shard4&wt=javabin&version=2
[junit4] 2> 1008789 INFO (qtp1054634721-8699) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589959113027&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard2_replica3&action=CREATE&numShards=4&collection=awhollynewcollection_0&shard=shard2&wt=javabin&version=2} status=0 QTime=33
[junit4] 2> 1008789 INFO (qtp2010056731-8716) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589959068404&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard4_replica4&action=CREATE&numShards=4&collection=awhollynewcollection_0&shard=shard4&wt=javabin&version=2} status=0 QTime=35
[junit4] 2> 1008789 INFO (parallelCoreAdminExecutor-2855-thread-2) [ ] o.a.s.h.a.CoreAdminOperation core create command async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589959113027&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard2_replica3&action=CREATE&numShards=4&collection=awhollynewcollection_0&shard=shard2&wt=javabin&version=2
[junit4] 2> 1008789 INFO (parallelCoreAdminExecutor-2854-thread-2) [ ] o.a.s.h.a.CoreAdminOperation core create command async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589959068404&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard4_replica4&action=CREATE&numShards=4&collection=awhollynewcollection_0&shard=shard4&wt=javabin&version=2
[junit4] 2> 1008791 INFO (qtp1054634721-8695) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589959037752&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard4_replica3&action=CREATE&numShards=4&collection=awhollynewcollection_0&shard=shard4&wt=javabin&version=2} status=0 QTime=37
[junit4] 2> 1008791 INFO (parallelCoreAdminExecutor-2855-thread-3) [ ] o.a.s.h.a.CoreAdminOperation core create command async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589959037752&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard4_replica3&action=CREATE&numShards=4&collection=awhollynewcollection_0&shard=shard4&wt=javabin&version=2
[junit4] 2> 1008794 INFO (qtp2010056731-8722) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589970918448&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard2_replica4&action=CREATE&numShards=4&collection=awhollynewcollection_0&shard=shard2&wt=javabin&version=2} status=0 QTime=13
[junit4] 2> 1008794 INFO (parallelCoreAdminExecutor-2854-thread-4) [ ] o.a.s.h.a.CoreAdminOperation core create command async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589970918448&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard2_replica4&action=CREATE&numShards=4&collection=awhollynewcollection_0&shard=shard2&wt=javabin&version=2
[junit4] 2> 1008801 INFO (qtp821382763-8709) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589980300964&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard1_replica1&action=CREATE&numShards=4&collection=awhollynewcollection_0&shard=shard1&wt=javabin&version=2} status=0 QTime=24
[junit4] 2> 1008845 INFO (qtp704362555-8718) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589980118132&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard3_replica2&action=CREATE&numShards=4&collection=awhollynewcollection_0&shard=shard3&wt=javabin&version=2} status=0 QTime=69
[junit4] 2> 1008845 INFO (qtp704362555-8707) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589961951573&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard1_replica2&action=CREATE&numShards=4&collection=awhollynewcollection_0&shard=shard1&wt=javabin&version=2} status=0 QTime=69
[junit4] 2> 1008857 INFO (parallelCoreAdminExecutor-2859-thread-4) [ ] o.a.s.h.a.CoreAdminOperation core create command async=5e3293e3-8c73-493a-a5fb-427ce32dda382568589961951573&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard1_replica2&action=CREAT
[...truncated too long message...]
rs for: solr.node
[junit4] 2> 1090918 INFO (jetty-closer-1110-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.jvm
[junit4] 2> 1090918 INFO (jetty-closer-1110-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.jvm
[junit4] 2> 1090918 INFO (jetty-closer-1110-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.jetty
[junit4] 2> 1090918 INFO (jetty-closer-1110-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.jetty
[junit4] 2> 1090917 INFO (jetty-closer-1110-thread-4) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1459004340
[junit4] 2> 1090918 INFO (jetty-closer-1110-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 1090918 INFO (jetty-closer-1110-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.jvm
[junit4] 2> 1090918 INFO (jetty-closer-1110-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.jetty
[junit4] 2> 1090920 WARN (zkCallback-1125-thread-4) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 1090920 INFO (zkCallback-1131-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1090920 INFO (jetty-closer-1110-thread-4) [ ] o.a.s.c.Overseer Overseer (id=98538072265326604-127.0.0.1:35635_solr-n_0000000000) closing
[junit4] 2> 1090920 INFO (zkCallback-1130-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1090921 INFO (zkCallback-1148-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1090921 INFO (OverseerStateUpdate-98538072265326604-127.0.0.1:35635_solr-n_0000000000) [ ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:35635_solr
[junit4] 2> 1090921 INFO (jetty-closer-1110-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2aec3cc9{/solr,null,UNAVAILABLE}
[junit4] 2> 1090921 WARN (zkCallback-1130-thread-1) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 1090921 INFO (jetty-closer-1110-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@555db601{/solr,null,UNAVAILABLE}
[junit4] 2> 1090921 INFO (zkCallback-1131-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
[junit4] 2> 1090921 WARN (zkCallback-1131-thread-1) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 1090921 INFO (jetty-closer-1110-thread-4) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@464af735{/solr,null,UNAVAILABLE}
[junit4] 2> 1090923 WARN (zkCallback-1148-thread-3) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 1090923 INFO (jetty-closer-1110-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4d9ce2be{/solr,null,UNAVAILABLE}
[junit4] 2> 1090923 ERROR (SUITE-CollectionsAPIDistributedZkTest-seed#[3F569E6B59793CF3]-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> 1090923 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[3F569E6B59793CF3]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:40089 40089
[junit4] 2> 1090978 INFO (Thread-3423) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:40089 40089
[junit4] 2> 1090979 WARN (Thread-3423) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 26 /solr/aliases.json
[junit4] 2> 23 /solr/configs/conf
[junit4] 2> 6 /solr/configs/conf2
[junit4] 2> 5 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 323 /solr/clusterstate.json
[junit4] 2> 26 /solr/clusterprops.json
[junit4] 2> 5 /solr/collections/awhollynewcollection_0/state.json
[junit4] 2> 4 /solr/collections/nodes_used_collection/state.json
[junit4] 2> 4 /solr/collections/addReplicaColl/state.json
[junit4] 2> 4 /solr/collections/reloaded_collection/state.json
[junit4] 2> 3 /solr/collections/acollectionafterbaddelete/state.json
[junit4] 2> 3 /solr/collections/awhollynewcollection_0/leader_elect/shard2/election/98538072265326603-core_node2-n_0000000000
[junit4] 2> 2 /solr/collections/awhollynewcollection_0/leader_elect/shard1/election/98538072265326604-core_node11-n_0000000001
[junit4] 2> 2 /solr/collections/onlyinzk/state.json
[junit4] 2> 2 /solr/collections/awhollynewcollection_0/leader_elect/shard3/election/98538072265326603-core_node10-n_0000000001
[junit4] 2> 2 /solr/collections/addReplicaColl/leader_elect/shard1/election/98538072265326609-core_node2-n_0000000001
[junit4] 2> 2 /solr/collections/awhollynewcollection_0/leader_elect/shard4/election/98538072265326604-core_node3-n_0000000001
[junit4] 2> 2 /solr/collections/addReplicaColl/leader_elect/shard2/election/98538072265326603-core_node3-n_0000000000
[junit4] 2> 2 /solr/overseer_elect/election/98538072265326601-127.0.0.1:40127_solr-n_0000000002
[junit4] 2> 2 /solr/collections/awhollynewcollection_0/leader_elect/shard2/election/98538072265326601-core_node8-n_0000000002
[junit4] 2> 2 /solr/collections/awhollynewcollection_0/leader_elect/shard4/election/98538072265326603-core_node16-n_0000000002
[junit4] 2> 2 /solr/overseer_elect/election/98538072265326603-127.0.0.1:38519_solr-n_0000000001
[junit4] 2> 2 /solr/collections/halfdeletedcollection/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 476 /solr/collections
[junit4] 2> 33 /solr/live_nodes
[junit4] 2>
[junit4] 2> 1090979 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[3F569E6B59793CF3]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_3F569E6B59793CF3-001
[junit4] 2> Aug 24, 2017 10:49:09 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 6 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=CheapBastard, sim=RandomSimilarity(queryNorm=false,coord=no): {}, locale=brx-IN, timezone=Pacific/Midway
[junit4] 2> NOTE: Linux 4.10.0-27-generic amd64/Oracle Corporation 9 (64-bit)/cpus=8,threads=1,free=298064256,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [PKIAuthenticationIntegrationTest, SparseHLLTest, TestClusterProperties, TestSolrDynamicMBean, TestSystemCollAutoCreate, TestMiniSolrCloudClusterSSL, TestSuggestSpellingConverter, SpellingQueryConverterTest, ZkSolrClientTest, DistributedQueueTest, CloneFieldUpdateProcessorFactoryTest, TestStressCloudBlindAtomicUpdates, TestRawResponseWriter, TestMaxScoreQueryParser, TestLMDirichletSimilarityFactory, SpatialFilterTest, ZkControllerTest, TestPayloadScoreQParserPlugin, RemoteQueryErrorTest, SolrMetricsIntegrationTest, TestFiltering, TestFieldCacheWithThreads, TestNoOpRegenerator, FullHLLTest, SpellCheckCollatorWithCollapseTest, TestDistribIDF, TestCSVResponseWriter, OverseerTaskQueueTest, TestLeaderElectionZkExpiry, WordBreakSolrSpellCheckerTest, TestLRUCache, DistributedDebugComponentTest, JSONWriterTest, TestCustomDocTransformer, TestCursorMarkWithoutUniqueKey, TestDistributedStatsComponentCardinality, TestFieldCollectionResource, ConnectionManagerTest, GraphQueryTest, HdfsCollectionsAPIDistributedZkTest, TestIntervalFaceting, DistributedQueryComponentOptimizationTest, DocumentBuilderTest, EchoParamsTest, SolrJmxReporterCloudTest, TestUnifiedSolrHighlighter, HdfsWriteToMultipleCollectionsTest, ForceLeaderTest, UpdateRequestProcessorFactoryTest, TestCloudPivotFacet, TestElisionMultitermQuery, TestLuceneMatchVersion, TestDeleteCollectionOnDownNodes, TestShardHandlerFactory, TestRestManager, RAMDirectoryFactoryTest, TestPerFieldSimilarityWithDefaultOverride, TestFuzzyAnalyzedSuggestions, TestSearchPerf, TestQueryTypes, MoveReplicaTest, TestSolrFieldCacheMBean, LoggingHandlerTest, TestInPlaceUpdatesStandalone, SimplePostToolTest, TestRTGBase, MetricsHandlerTest, TestDFISimilarityFactory, TestQuerySenderListener, SolrIndexSplitterTest, ParsingFieldUpdateProcessorsTest, FileUtilsTest, TestChildDocTransformer, TestFileDictionaryLookup, TestSQLHandlerNonCloud, TestInitParams, BooleanFieldTest, SampleTest, TestSmileRequest, DocValuesMissingTest, InfixSuggestersTest, RuleEngineTest, TemplateUpdateProcessorTest, TestUpdate, TestManagedStopFilterFactory, CheckHdfsIndexTest, TestConfigSets, ShardRoutingTest, MultiTermTest, RestartWhileUpdatingTest, TestSweetSpotSimilarityFactory, TestSolrIndexConfig, TestRequestForwarding, TestFieldCacheSort, TestScoreJoinQPNoScore, TestCloudManagedSchema, MoreLikeThisHandlerTest, TestLRUStatsCache, IndexBasedSpellCheckerTest, OverseerModifyCollectionTest, OpenCloseCoreStressTest, DistributedIntervalFacetingTest, TestSchemaManager, TestCollapseQParserPlugin, TestTrie, SearchHandlerTest, TriLevelCompositeIdRoutingTest, CollectionsAPIDistributedZkTest]
[junit4] Completed [351/713 (1!)] on J1 in 90.92s, 20 tests, 1 failure <<< FAILURES!
[...truncated 37546 lines...]