Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-7.x/41/

4 tests failed.
FAILED:  org.apache.solr.cloud.HttpPartitionTest.test

Error Message:
Doc with id=894 not found in http://127.0.0.1:45166/c8n_1x2 due to: Path not 
found: /id; rsp={doc=null}

Stack Trace:
java.lang.AssertionError: Doc with id=894 not found in 
http://127.0.0.1:45166/c8n_1x2 due to: Path not found: /id; rsp={doc=null}
        at 
__randomizedtesting.SeedInfo.seed([EDB3304C08F978F6:65E70F96A605150E]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.cloud.HttpPartitionTest.assertDocExists(HttpPartitionTest.java:605)
        at 
org.apache.solr.cloud.HttpPartitionTest.assertDocsExistInAllReplicas(HttpPartitionTest.java:560)
        at 
org.apache.solr.cloud.HttpPartitionTest.testRf2(HttpPartitionTest.java:381)
        at 
org.apache.solr.cloud.HttpPartitionTest.test(HttpPartitionTest.java:132)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:993)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


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

Error Message:


Stack Trace:
java.lang.AssertionError
        at 
__randomizedtesting.SeedInfo.seed([EDB3304C08F978F6:65E70F96A605150E]:0)
        at org.junit.Assert.fail(Assert.java:92)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertTrue(Assert.java:54)
        at 
org.apache.solr.cloud.LeaderElectionContextKeyTest.test(LeaderElectionContextKeyTest.java:88)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  
org.apache.solr.core.HdfsDirectoryFactoryTest.testInitArgsOrSysPropConfig

Error Message:
The max direct memory is likely too low.  Either increase it (by adding 
-XX:MaxDirectMemorySize=<size>g -XX:+UseLargePages to your containers startup 
args) or disable direct allocation using 
solr.hdfs.blockcache.direct.memory.allocation=false in solrconfig.xml. If you 
are putting the block cache on the heap, your java heap size might not be large 
enough. Failed allocating ~134.217728 MB.

Stack Trace:
java.lang.RuntimeException: The max direct memory is likely too low.  Either 
increase it (by adding -XX:MaxDirectMemorySize=<size>g -XX:+UseLargePages to 
your containers startup args) or disable direct allocation using 
solr.hdfs.blockcache.direct.memory.allocation=false in solrconfig.xml. If you 
are putting the block cache on the heap, your java heap size might not be large 
enough. Failed allocating ~134.217728 MB.
        at 
__randomizedtesting.SeedInfo.seed([EDB3304C08F978F6:1A1CF967F57092DD]:0)
        at 
org.apache.solr.core.HdfsDirectoryFactory.createBlockCache(HdfsDirectoryFactory.java:311)
        at 
org.apache.solr.core.HdfsDirectoryFactory.getBlockDirectoryCache(HdfsDirectoryFactory.java:287)
        at 
org.apache.solr.core.HdfsDirectoryFactory.create(HdfsDirectoryFactory.java:227)
        at 
org.apache.solr.core.HdfsDirectoryFactoryTest.testInitArgsOrSysPropConfig(HdfsDirectoryFactoryTest.java:111)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)
Caused by: java.lang.OutOfMemoryError: Direct buffer memory
        at java.nio.Bits.reserveMemory(Bits.java:694)
        at java.nio.DirectByteBuffer.<init>(DirectByteBuffer.java:123)
        at java.nio.ByteBuffer.allocateDirect(ByteBuffer.java:311)
        at 
org.apache.solr.store.blockcache.BlockCache.<init>(BlockCache.java:71)
        at 
org.apache.solr.core.HdfsDirectoryFactory.createBlockCache(HdfsDirectoryFactory.java:309)
        ... 42 more


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

Error Message:
Timeout waiting for all live and active

Stack Trace:
java.lang.AssertionError: Timeout waiting for all live and active
        at 
__randomizedtesting.SeedInfo.seed([EDB3304C08F978F6:65E70F96A605150E]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.testBasics(SharedFSAutoReplicaFailoverTest.java:317)
        at 
org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.test(SharedFSAutoReplicaFailoverTest.java:136)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:993)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 13649 lines...]
   [junit4] Suite: org.apache.solr.cloud.LeaderElectionContextKeyTest
   [junit4]   2> 4481162 INFO  
(SUITE-LeaderElectionContextKeyTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_EDB3304C08F978F6-001/init-core-data-001
   [junit4]   2> 4481163 WARN  
(SUITE-LeaderElectionContextKeyTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=65 numCloses=65
   [junit4]   2> 4481163 INFO  
(SUITE-LeaderElectionContextKeyTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 4481172 INFO  
(SUITE-LeaderElectionContextKeyTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 4481172 INFO  
(SUITE-LeaderElectionContextKeyTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_EDB3304C08F978F6-001/tempDir-001
   [junit4]   2> 4481172 INFO  
(SUITE-LeaderElectionContextKeyTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 4481173 INFO  (Thread-73365) [    ] o.a.s.c.ZkTestServer 
client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 4481173 INFO  (Thread-73365) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 4481177 ERROR (Thread-73365) [    ] 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> 4481273 INFO  
(SUITE-LeaderElectionContextKeyTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:45185
   [junit4]   2> 4481291 INFO  (jetty-launcher-3991-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 4481292 INFO  (jetty-launcher-3991-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@c1675b2{/solr,null,AVAILABLE}
   [junit4]   2> 4481292 INFO  (jetty-launcher-3991-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@5c4f747d{HTTP/1.1,[http/1.1]}{127.0.0.1:55455}
   [junit4]   2> 4481292 INFO  (jetty-launcher-3991-thread-1) [    ] 
o.e.j.s.Server Started @4489760ms
   [junit4]   2> 4481292 INFO  (jetty-launcher-3991-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=55455}
   [junit4]   2> 4481293 ERROR (jetty-launcher-3991-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 4481293 INFO  (jetty-launcher-3991-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.1.0
   [junit4]   2> 4481293 INFO  (jetty-launcher-3991-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 4481293 INFO  (jetty-launcher-3991-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 4481293 INFO  (jetty-launcher-3991-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-09-08T20:09:31.497Z
   [junit4]   2> 4481301 INFO  (jetty-launcher-3991-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 4481308 INFO  (jetty-launcher-3991-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45185/solr
   [junit4]   2> 4481348 INFO  (jetty-launcher-3991-thread-1) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 4481348 INFO  (jetty-launcher-3991-thread-1) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:55455_solr
   [junit4]   2> 4481348 INFO  (jetty-launcher-3991-thread-1) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.Overseer Overseer 
(id=98625216274694147-127.0.0.1:55455_solr-n_0000000000) starting
   [junit4]   2> 4481360 INFO  (jetty-launcher-3991-thread-1) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:55455_solr
   [junit4]   2> 4481361 INFO  
(zkCallback-3998-thread-1-processing-n:127.0.0.1:55455_solr) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 4481415 INFO  (jetty-launcher-3991-thread-1) 
[n:127.0.0.1:55455_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_55455.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ba3315f
   [junit4]   2> 4481423 INFO  (jetty-launcher-3991-thread-1) 
[n:127.0.0.1:55455_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_55455.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ba3315f
   [junit4]   2> 4481423 INFO  (jetty-launcher-3991-thread-1) 
[n:127.0.0.1:55455_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_55455.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ba3315f
   [junit4]   2> 4481424 INFO  (jetty-launcher-3991-thread-1) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_EDB3304C08F978F6-001/tempDir-001/node1/.
   [junit4]   2> 4481453 INFO  
(SUITE-LeaderElectionContextKeyTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 4481453 INFO  
(SUITE-LeaderElectionContextKeyTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45185/solr ready
   [junit4]   2> 4481456 INFO  (qtp1092010652-89452) [n:127.0.0.1:55455_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&collection.configName=config&maxShardsPerNode=1000&name=testCollection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 4481465 INFO  
(OverseerThreadFactory-7932-thread-1-processing-n:127.0.0.1:55455_solr) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
testCollection1
   [junit4]   2> 4481578 INFO  
(OverseerStateUpdate-98625216274694147-127.0.0.1:55455_solr-n_0000000000) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testCollection1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testCollection1_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:55455/solr";,
   [junit4]   2>   "type":"NRT"} 
   [junit4]   2> 4481583 INFO  
(OverseerStateUpdate-98625216274694147-127.0.0.1:55455_solr-n_0000000000) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testCollection1",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"testCollection1_shard2_replica_n3",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:55455/solr";,
   [junit4]   2>   "type":"NRT"} 
   [junit4]   2> 4481690 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node2&collection.configName=config&newCollection=true&name=testCollection1_shard1_replica_n1&action=CREATE&numShards=2&collection=testCollection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 4481691 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node4&collection.configName=config&newCollection=true&name=testCollection1_shard2_replica_n3&action=CREATE&numShards=2&collection=testCollection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 4481691 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 4481797 INFO  
(zkCallback-3998-thread-1-processing-n:127.0.0.1:55455_solr) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCollection1/state.json] for collection [testCollection1] 
has occurred - updating... (live nodes size: [1])
   [junit4]   2> 4482756 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 4482761 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 4482768 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.s.IndexSchema [testCollection1_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 4482772 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.s.IndexSchema [testCollection1_shard2_replica_n3] Schema name=minimal
   [junit4]   2> 4482774 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 4482774 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.c.CoreContainer Creating SolrCore 'testCollection1_shard2_replica_n3' 
using configuration from collection testCollection1, trusted=true
   [junit4]   2> 4482777 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_55455.solr.core.testCollection1.shard2.replica_n3' (registry 
'solr.core.testCollection1.shard2.replica_n3') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ba3315f
   [junit4]   2> 4482777 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 4482777 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.c.SolrCore [[testCollection1_shard2_replica_n3] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_EDB3304C08F978F6-001/tempDir-001/node1/testCollection1_shard2_replica_n3],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_EDB3304C08F978F6-001/tempDir-001/node1/./testCollection1_shard2_replica_n3/data/]
   [junit4]   2> 4482780 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 4482780 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.c.CoreContainer Creating SolrCore 'testCollection1_shard1_replica_n1' 
using configuration from collection testCollection1, trusted=true
   [junit4]   2> 4482783 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_55455.solr.core.testCollection1.shard1.replica_n1' (registry 
'solr.core.testCollection1.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ba3315f
   [junit4]   2> 4482783 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 4482783 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.c.SolrCore [[testCollection1_shard1_replica_n1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_EDB3304C08F978F6-001/tempDir-001/node1/testCollection1_shard1_replica_n1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_EDB3304C08F978F6-001/tempDir-001/node1/./testCollection1_shard1_replica_n1/data/]
   [junit4]   2> 4482896 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 4482896 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 4482897 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 4482897 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 4482899 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@5ce1d73d[testCollection1_shard2_replica_n3] main]
   [junit4]   2> 4482900 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/config
   [junit4]   2> 4482900 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/config
   [junit4]   2> 4482901 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 4482901 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1578003462204948480
   [junit4]   2> 4482907 INFO  
(searcherExecutor-7935-thread-1-processing-n:127.0.0.1:55455_solr 
x:testCollection1_shard2_replica_n3 s:shard2 c:testCollection1 r:core_node4) 
[n:127.0.0.1:55455_solr c:testCollection1 s:shard2 r:core_node4 
x:testCollection1_shard2_replica_n3] o.a.s.c.SolrCore 
[testCollection1_shard2_replica_n3] Registered new searcher 
Searcher@5ce1d73d[testCollection1_shard2_replica_n3] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 4482907 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 4482907 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 4482907 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:55455/solr/testCollection1_shard2_replica_n3/
   [junit4]   2> 4482907 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 4482907 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.c.SyncStrategy 
http://127.0.0.1:55455/solr/testCollection1_shard2_replica_n3/ has no replicas
   [junit4]   2> 4482907 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 4482910 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:55455/solr/testCollection1_shard2_replica_n3/ shard2
   [junit4]   2> 4482916 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 4482916 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 4482917 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 4482917 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 4482918 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@21f33d09[testCollection1_shard1_replica_n1] main]
   [junit4]   2> 4482919 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/config
   [junit4]   2> 4482919 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/config
   [junit4]   2> 4482920 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 4482920 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1578003462224871424
   [junit4]   2> 4482923 INFO  
(searcherExecutor-7936-thread-1-processing-n:127.0.0.1:55455_solr 
x:testCollection1_shard1_replica_n1 s:shard1 c:testCollection1 r:core_node2) 
[n:127.0.0.1:55455_solr c:testCollection1 s:shard1 r:core_node2 
x:testCollection1_shard1_replica_n1] o.a.s.c.SolrCore 
[testCollection1_shard1_replica_n1] Registered new searcher 
Searcher@21f33d09[testCollection1_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 4482924 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 4482924 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 4482924 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:55455/solr/testCollection1_shard1_replica_n1/
   [junit4]   2> 4482924 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 4482924 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.c.SyncStrategy 
http://127.0.0.1:55455/solr/testCollection1_shard1_replica_n1/ has no replicas
   [junit4]   2> 4482924 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 4482926 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:55455/solr/testCollection1_shard1_replica_n1/ shard1
   [junit4]   2> 4483086 INFO  
(zkCallback-3998-thread-1-processing-n:127.0.0.1:55455_solr) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCollection1/state.json] for collection [testCollection1] 
has occurred - updating... (live nodes size: [1])
   [junit4]   2> 4483135 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 4483135 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 4483138 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard1 r:core_node2 x:testCollection1_shard1_replica_n1] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=config&newCollection=true&name=testCollection1_shard1_replica_n1&action=CREATE&numShards=2&collection=testCollection1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1448
   [junit4]   2> 4483139 INFO  (qtp1092010652-89454) [n:127.0.0.1:55455_solr 
c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n3] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=config&newCollection=true&name=testCollection1_shard2_replica_n3&action=CREATE&numShards=2&collection=testCollection1&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1448
   [junit4]   2> 4483143 INFO  (qtp1092010652-89452) [n:127.0.0.1:55455_solr    
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 4483244 INFO  
(zkCallback-3998-thread-2-processing-n:127.0.0.1:55455_solr) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCollection1/state.json] for collection [testCollection1] 
has occurred - updating... (live nodes size: [1])
   [junit4]   2> 4483465 INFO  
(OverseerCollectionConfigSetProcessor-98625216274694147-127.0.0.1:55455_solr-n_0000000000)
 [n:127.0.0.1:55455_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 4484144 INFO  (qtp1092010652-89452) [n:127.0.0.1:55455_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={replicationFactor=1&collection.configName=config&maxShardsPerNode=1000&name=testCollection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2}
 status=0 QTime=2687
   [junit4]   2> 4484144 INFO  (qtp1092010652-89453) [n:127.0.0.1:55455_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&collection.configName=config&maxShardsPerNode=1000&name=testCollection2&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 4484156 INFO  
(OverseerThreadFactory-7932-thread-2-processing-n:127.0.0.1:55455_solr) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
testCollection2
   [junit4]   2> 4484373 INFO  
(OverseerStateUpdate-98625216274694147-127.0.0.1:55455_solr-n_0000000000) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testCollection2",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testCollection2_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:55455/solr";,
   [junit4]   2>   "type":"NRT"} 
   [junit4]   2> 4484375 INFO  
(OverseerStateUpdate-98625216274694147-127.0.0.1:55455_solr-n_0000000000) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testCollection2",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"testCollection2_shard2_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:55455/solr";,
   [junit4]   2>   "type":"NRT"} 
   [junit4]   2> 4484677 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node4&collection.configName=config&newCollection=true&name=testCollection2_shard2_replica_n2&action=CREATE&numShards=2&collection=testCollection2&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 4484678 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=config&newCollection=true&name=testCollection2_shard1_replica_n1&action=CREATE&numShards=2&collection=testCollection2&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 4484787 INFO  
(zkCallback-3998-thread-2-processing-n:127.0.0.1:55455_solr) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCollection2/state.json] for collection [testCollection2] 
has occurred - updating... (live nodes size: [1])
   [junit4]   2> 4485704 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 4485709 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 4485754 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.s.IndexSchema [testCollection2_shard2_replica_n2] Schema name=minimal
   [junit4]   2> 4485757 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.s.IndexSchema [testCollection2_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 4485759 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 4485759 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.c.CoreContainer Creating SolrCore 'testCollection2_shard1_replica_n1' 
using configuration from collection testCollection2, trusted=true
   [junit4]   2> 4485759 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_55455.solr.core.testCollection2.shard1.replica_n1' (registry 
'solr.core.testCollection2.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ba3315f
   [junit4]   2> 4485760 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 4485760 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.c.SolrCore [[testCollection2_shard1_replica_n1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_EDB3304C08F978F6-001/tempDir-001/node1/testCollection2_shard1_replica_n1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_EDB3304C08F978F6-001/tempDir-001/node1/./testCollection2_shard1_replica_n1/data/]
   [junit4]   2> 4485762 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 4485762 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.c.CoreContainer Creating SolrCore 'testCollection2_shard2_replica_n2' 
using configuration from collection testCollection2, trusted=true
   [junit4]   2> 4485763 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_55455.solr.core.testCollection2.shard2.replica_n2' (registry 
'solr.core.testCollection2.shard2.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ba3315f
   [junit4]   2> 4485763 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 4485763 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.c.SolrCore [[testCollection2_shard2_replica_n2] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_EDB3304C08F978F6-001/tempDir-001/node1/testCollection2_shard2_replica_n2],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_EDB3304C08F978F6-001/tempDir-001/node1/./testCollection2_shard2_replica_n2/data/]
   [junit4]   2> 4485879 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 4485879 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 4485880 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 4485880 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 4485881 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@3bdab1e[testCollection2_shard2_replica_n2] main]
   [junit4]   2> 4485882 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/config
   [junit4]   2> 4485882 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/config
   [junit4]   2> 4485883 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 4485883 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1578003465331802112
   [junit4]   2> 4485901 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 4485901 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 4485901 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:55455/solr/testCollection2_shard2_replica_n2/
   [junit4]   2> 4485901 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 4485902 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.c.SyncStrategy 
http://127.0.0.1:55455/solr/testCollection2_shard2_replica_n2/ has no replicas
   [junit4]   2> 4485902 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 4485903 INFO  
(searcherExecutor-7946-thread-1-processing-n:127.0.0.1:55455_solr 
x:testCollection2_shard2_replica_n2 s:shard2 c:testCollection2 r:core_node4) 
[n:127.0.0.1:55455_solr c:testCollection2 s:shard2 r:core_node4 
x:testCollection2_shard2_replica_n2] o.a.s.c.SolrCore 
[testCollection2_shard2_replica_n2] Registered new searcher 
Searcher@3bdab1e[testCollection2_shard2_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 4485910 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:55455/solr/testCollection2_shard2_replica_n2/ shard2
   [junit4]   2> 4485925 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 4485925 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 4485926 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 4485926 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 4485927 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@59ad5686[testCollection2_shard1_replica_n1] main]
   [junit4]   2> 4485928 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/config
   [junit4]   2> 4485928 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/config
   [junit4]   2> 4485928 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 4485929 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1578003465380036608
   [junit4]   2> 4485952 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 4485952 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 4485952 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:55455/solr/testCollection2_shard1_replica_n1/
   [junit4]   2> 4485952 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 4485952 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.c.SyncStrategy 
http://127.0.0.1:55455/solr/testCollection2_shard1_replica_n1/ has no replicas
   [junit4]   2> 4485952 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 4485955 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:55455/solr/testCollection2_shard1_replica_n1/ shard1
   [junit4]   2> 4485960 INFO  
(searcherExecutor-7945-thread-1-processing-n:127.0.0.1:55455_solr 
x:testCollection2_shard1_replica_n1 s:shard1 c:testCollection2 r:core_node3) 
[n:127.0.0.1:55455_solr c:testCollection2 s:shard1 r:core_node3 
x:testCollection2_shard1_replica_n1] o.a.s.c.SolrCore 
[testCollection2_shard1_replica_n1] Registered new searcher 
Searcher@59ad5686[testCollection2_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 4486086 INFO  
(zkCallback-3998-thread-2-processing-n:127.0.0.1:55455_solr) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCollection2/state.json] for collection [testCollection2] 
has occurred - updating... (live nodes size: [1])
   [junit4]   2> 4486135 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 4486135 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 4486136 INFO  (qtp1092010652-89455) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard2 r:core_node4 x:testCollection2_shard2_replica_n2] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=config&newCollection=true&name=testCollection2_shard2_replica_n2&action=CREATE&numShards=2&collection=testCollection2&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1459
   [junit4]   2> 4486137 INFO  (qtp1092010652-89449) [n:127.0.0.1:55455_solr 
c:testCollection2 s:shard1 r:core_node3 x:testCollection2_shard1_replica_n1] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=config&newCollection=true&name=testCollection2_shard1_replica_n1&action=CREATE&numShards=2&collection=testCollection2&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1459
   [junit4]   2> 4486139 INFO  (qtp1092010652-89453) [n:127.0.0.1:55455_solr    
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 4486157 INFO  
(OverseerCollectionConfigSetProcessor-98625216274694147-127.0.0.1:55455_solr-n_0000000000)
 [n:127.0.0.1:55455_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000002 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 4486240 INFO  
(zkCallback-3998-thread-2-processing-n:127.0.0.1:55455_solr) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testCollection2/state.json] for collection [testCollection2] 
has occurred - updating... (live nodes size: [1])
   [junit4]   2> 4487139 INFO  (qtp1092010652-89453) [n:127.0.0.1:55455_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={replicationFactor=1&collection.configName=config&maxShardsPerNode=1000&name=testCollection2&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2}
 status=0 QTime=2994
   [junit4]   2> 4487139 INFO  
(SUITE-LeaderElectionContextKeyTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection: 
testCollection1 failOnTimeout:true timeout (sec):30
   [junit4]   2> 4487140 INFO  
(SUITE-LeaderElectionContextKeyTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: 
testCollection1
   [junit4]   2> 4487140 INFO  
(SUITE-LeaderElectionContextKeyTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection: 
testCollection2 failOnTimeout:true timeout (sec):30
   [junit4]   2> 4487140 INFO  
(SUITE-LeaderElectionContextKeyTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: 
testCollection2
   [junit4]   2> 4487210 INFO  
(TEST-LeaderElectionContextKeyTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 4487217 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.testCollection1.shard2.replica_n3, tag=null
   [junit4]   2> 4487217 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr    
] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6d2f972a: rootName = 
solr_55455, domain = solr.core.testCollection1.shard2.replica_n3, service url = 
null, agent id = null] for registry solr.core.testCollection1.shard2.replica_n3 
/ com.codahale.metrics.MetricRegistry@7f17bf50
   [junit4]   2> 4487233 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr    
] o.a.s.c.SolrCore [testCollection1_shard2_replica_n3]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@38d25fbf
   [junit4]   2> 4487233 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.testCollection1.shard2.replica_n3, tag=953311167
   [junit4]   2> 4487233 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.testCollection1.shard2.leader, tag=953311167
   [junit4]   2> 4487247 INFO  (qtp1092010652-89450) [n:127.0.0.1:55455_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={deleteInstanceDir=false&core=testCollection1_shard2_replica_n3&deleteDataDir=false&action=UNLOAD&indexInfo=true&wt=javabin&version=2&deleteIndex=false}
 status=0 QTime=30
   [junit4]   2> 4487248 INFO  
(TEST-LeaderElectionContextKeyTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending test
   [junit4]   2> NOTE: download the large Jenkins line-docs file by running 
'ant get-jenkins-line-docs' in the lucene directory.
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=LeaderElectionContextKeyTest -Dtests.method=test 
-Dtests.seed=EDB3304C08F978F6 -Dtests.multiplier=2 -Dtests.nightly=true 
-Dtests.slow=true 
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/test-data/enwiki.random.lines.txt
 -Dtests.locale=et -Dtests.timezone=BET -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] FAILURE 0.13s J0 | LeaderElectionContextKeyTest.test <<<
   [junit4]    > Throwable #1: java.lang.AssertionError
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([EDB3304C08F978F6:65E70F96A605150E]:0)
   [junit4]    >        at 
org.apache.solr.cloud.LeaderElectionContextKeyTest.test(LeaderElectionContextKeyTest.java:88)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 4487285 INFO  (jetty-closer-3992-thread-1) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@5c4f747d{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 4487287 INFO  (jetty-closer-3992-thread-1) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1316825863
   [junit4]   2> 4487287 INFO  (jetty-closer-3992-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 4487287 INFO  (jetty-closer-3992-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@557e84cb: rootName = 
solr_55455, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@ac016d3
   [junit4]   2> 4487292 INFO  (jetty-closer-3992-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 4487292 INFO  (jetty-closer-3992-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@60151eba: rootName = 
solr_55455, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@3e9674a7
   [junit4]   2> 4487298 INFO  (jetty-closer-3992-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 4487298 INFO  (jetty-closer-3992-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@78ac5634: rootName = 
solr_55455, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@75c6f35e
   [junit4]   2> 4487300 INFO  (jetty-closer-3992-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 4487320 INFO  (coreCloseExecutor-7955-thread-1) 
[n:127.0.0.1:55455_solr c:testCollection1 s:shard1 r:core_node2 
x:testCollection1_shard1_replica_n1] o.a.s.c.SolrCore 
[testCollection1_shard1_replica_n1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1b57f584
   [junit4]   2> 4487320 INFO  (coreCloseExecutor-7955-thread-1) 
[n:127.0.0.1:55455_solr c:testCollection1 s:shard1 r:core_node2 
x:testCollection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.core.testCollection1.shard1.replica_n1, 
tag=458749316
   [junit4]   2> 4487320 INFO  (coreCloseExecutor-7955-thread-1) 
[n:127.0.0.1:55455_solr c:testCollection1 s:shard1 r:core_node2 
x:testCollection1_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@17c004db: rootName = 
solr_55455, domain = solr.core.testCollection1.shard1.replica_n1, service url = 
null, agent id = null] for registry solr.core.testCollection1.shard1.replica_n1 
/ com.codahale.metrics.MetricRegistry@550e8a
   [junit4]   2> 4487326 INFO  (coreCloseExecutor-7955-thread-2) 
[n:127.0.0.1:55455_solr c:testCollection2 s:shard2 r:core_node4 
x:testCollection2_shard2_replica_n2] o.a.s.c.SolrCore 
[testCollection2_shard2_replica_n2]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@26b1a970
   [junit4]   2> 4487328 INFO  (coreCloseExecutor-7955-thread-2) 
[n:127.0.0.1:55455_solr c:testCollection2 s:shard2 r:core_node4 
x:testCollection2_shard2_replica_n2] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.core.testCollection2.shard2.replica_n2, 
tag=649177456
   [junit4]   2> 4487329 INFO  (coreCloseExecutor-7955-thread-2) 
[n:127.0.0.1:55455_solr c:testCollection2 s:shard2 r:core_node4 
x:testCollection2_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3df11ce8: rootName = 
solr_55455, domain = solr.core.testCollection2.shard2.replica_n2, service url = 
null, agent id = null] for registry solr.core.testCollection2.shard2.replica_n2 
/ com.codahale.metrics.MetricRegistry@27108e67
   [junit4]   2> 4487333 INFO  (coreCloseExecutor-7955-thread-3) 
[n:127.0.0.1:55455_solr c:testCollection2 s:shard1 r:core_node3 
x:testCollection2_shard1_replica_n1] o.a.s.c.SolrCore 
[testCollection2_shard1_replica_n1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@16c06e15
   [junit4]   2> 4487338 INFO  (coreCloseExecutor-7955-thread-1) 
[n:127.0.0.1:55455_solr c:testCollection1 s:shard1 r:core_node2 
x:testCollection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.testCollection1.shard1.leader, 
tag=458749316
   [junit4]   2> 4487338 INFO  (coreCloseExecutor-7955-thread-3) 
[n:127.0.0.1:55455_solr c:testCollection2 s:shard1 r:core_node3 
x:testCollection2_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.core.testCollection2.shard1.replica_n1, 
tag=381709845
   [junit4]   2> 4487338 INFO  (coreCloseExecutor-7955-thread-3) 
[n:127.0.0.1:55455_solr c:testCollection2 s:shard1 r:core_node3 
x:testCollection2_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@399c9e82: rootName = 
solr_55455, domain = solr.core.testCollection2.shard1.replica_n1, service url = 
null, agent id = null] for registry solr.core.testCollection2.shard1.replica_n1 
/ com.codahale.metrics.MetricRegistry@7a55564c
   [junit4]   2> 4487355 INFO  (coreCloseExecutor-7955-thread-3) 
[n:127.0.0.1:55455_solr c:testCollection2 s:shard1 r:core_node3 
x:testCollection2_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.testCollection2.shard1.leader, 
tag=381709845
   [junit4]   2> 4487364 INFO  (coreCloseExecutor-7955-thread-2) 
[n:127.0.0.1:55455_solr c:testCollection2 s:shard2 r:core_node4 
x:testCollection2_shard2_replica_n2] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.testCollection2.shard2.leader, 
tag=649177456
   [junit4]   2> 4487376 INFO  (jetty-closer-3992-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=98625216274694147-127.0.0.1:55455_solr-n_0000000000) closing
   [junit4]   2> 4487376 INFO  
(OverseerStateUpdate-98625216274694147-127.0.0.1:55455_solr-n_0000000000) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:55455_solr
   [junit4]   2> 4487387 WARN  
(zkCallback-3998-thread-2-processing-n:127.0.0.1:55455_solr) 
[n:127.0.0.1:55455_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, 
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 4487387 INFO  (jetty-closer-3992-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@c1675b2{/solr,null,UNAVAILABLE}
   [junit4]   2> 4487388 ERROR 
(SUITE-LeaderElectionContextKeyTest-seed#[EDB3304C08F978F6]-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> 4487389 INFO  
(SUITE-LeaderElectionContextKeyTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:45185 45185
   [junit4]   2> 4487478 INFO  (Thread-73365) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:45185 45185
   [junit4]   2> 4487480 WARN  (Thread-73365) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        2       /solr/aliases.json
   [junit4]   2>        2       /solr/clusterprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        2       /solr/clusterstate.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        2       /solr/live_nodes
   [junit4]   2>        2       /solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_EDB3304C08F978F6-001
   [junit4]   2> Sep 08, 2017 8:09:37 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 2 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=RandomSimilarity(queryNorm=true): {}, locale=et, timezone=BET
   [junit4]   2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 
1.8.0_144 (64-bit)/cpus=4,threads=1,free=250667432,total=521666560
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestManagedSchemaThreadSafety, TestHashQParserPlugin, TestSolrDeletionPolicy1, 
TestSolrConfigHandler, TestNumericTokenStream, JSONWriterTest, 
DataDrivenBlockJoinTest, TestComplexPhraseLeadingWildcard, UpdateParamsTest, 
TestConfigSetProperties, TestCloudSearcherWarming, 
TestEmbeddedSolrServerAdminHandler, TestReplicationHandlerBackup, 
TestIBSimilarityFactory, RemoteQueryErrorTest, TestRandomRequestDistribution, 
TestWordDelimiterFilterFactory, TestExpandComponent, HdfsLockFactoryTest, 
WordBreakSolrSpellCheckerTest, TestPayloadScoreQParserPlugin, BitVectorTest, 
ReplicaListTransformerTest, HdfsChaosMonkeySafeLeaderTest, 
HLLSerializationTest, V2StandaloneTest, TestClusterStateMutator, 
SynonymTokenizerTest, TestReloadAndDeleteDocs, TestInPlaceUpdatesDistrib, 
TestDistribDocBasedVersion, TestHighlightDedupGrouping, 
TestSchemaVersionResource, TestStressCloudBlindAtomicUpdates, 
CollectionReloadTest, TestJettySolrRunner, TestJsonFacetRefinement, 
TestLazyCores, TestConfigSetsAPIZkFailure, TestCustomStream, 
TestDistributedSearch, SyncSliceTest, TestIndexingPerformance, TestSQLHandler, 
TestCSVLoader, SharedFSAutoReplicaFailoverUtilsTest, SuggesterWFSTTest, 
EnumFieldTest, LargeFieldTest, BasicZkTest, MissingSegmentRecoveryTest, 
TestSubQueryTransformerDistrib, TestRemoteStreaming, 
TestLeaderInitiatedRecoveryThread, TestCSVResponseWriter, TestJoin, 
TestCloudPivotFacet, StatsReloadRaceTest, SolrMetricReporterTest, 
ConfigSetsAPITest, TestFaceting, TestNoOpRegenerator, 
DocumentAnalysisRequestHandlerTest, DocValuesNotIndexedTest, 
TestSolrCLIRunExample, TestSolrQueryParser, SolrGraphiteReporterTest, 
SuggestComponentContextFilterQueryTest, TestCrossCoreJoin, 
TestSolrCoreSnapshots, FieldMutatingUpdateProcessorTest, MetricsConfigTest, 
TestStreamBody, HdfsBasicDistributedZk2Test, IndexBasedSpellCheckerTest, 
HighlighterConfigTest, TestMiniSolrCloudClusterSSL, SaslZkACLProviderTest, 
VersionInfoTest, TestAnalyzeInfixSuggestions, TestNumericTerms32, 
TestSolr4Spatial, DeleteStatusTest, BlobRepositoryCloudTest, TestOmitPositions, 
BinaryUpdateRequestHandlerTest, ExternalFileFieldSortTest, TestTrieFacet, 
DistributedFacetPivotWhiteBoxTest, LeaderElectionIntegrationTest, 
TestSolrCloudWithHadoopAuthPlugin, AsyncCallRequestStatusResponseTest, 
CollectionsAPIAsyncDistributedZkTest, TestSolrCloudWithDelegationTokens, 
TestDocumentBuilder, EchoParamsTest, TestFieldCacheReopen, 
QueryElevationComponentTest, TestFieldCacheVsDocValues, CurrencyFieldTypeTest, 
DebugComponentTest, TestSchemaNameResource, TestExactSharedStatsCache, 
AnalyticsMergeStrategyTest, TestSha256AuthenticationProvider, TestBinaryField, 
SpellingQueryConverterTest, ImplicitSnitchTest, TestFreeTextSuggestions, 
TestGraphMLResponseWriter, DeleteNodeTest, TestCollationField, ZkNodePropsTest, 
SolrCloudExampleTest, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, 
OpenCloseCoreStressTest, TestReplicationHandler, SolrCoreTest, PeerSyncTest, 
ConvertedLegacyTest, TestFunctionQuery, TestBadConfig, HighlighterTest, 
SoftAutoCommitTest, DistributedQueryElevationComponentTest, 
SolrIndexSplitterTest, SimplePostToolTest, TestCoreDiscovery, 
AnalysisAfterCoreReloadTest, TestExtendedDismaxParser, SpellCheckCollatorTest, 
CoreAdminHandlerTest, SolrRequestParserTest, TestFoldingMultitermQuery, 
TestStressLucene, TestTrie, SpatialFilterTest, PolyFieldTest, 
NoCacheHeaderTest, TestPseudoReturnFields, TestUpdate, 
TestAtomicUpdateErrorCases, DefaultValueUpdateProcessorTest, 
StatelessScriptUpdateProcessorFactoryTest, SortByFunctionTest, 
DocValuesMultiTest, SolrInfoBeanTest, XsltUpdateRequestHandlerTest, 
TestSurroundQueryParser, LukeRequestHandlerTest, TestWriterPerf, 
TestReversedWildcardFilterFactory, TestQueryTypes, FileBasedSpellCheckerTest, 
XmlUpdateRequestHandlerTest, RequestHandlersTest, DocumentBuilderTest, 
FieldAnalysisRequestHandlerTest, LoggingHandlerTest, RegexBoostProcessorTest, 
SolrPluginUtilsTest, IndexSchemaTest, MBeansHandlerTest, 
UniqFieldsUpdateProcessorFactoryTest, TestPHPSerializedResponseWriter, 
PingRequestHandlerTest, TestComponentsName, TestLFUCache, PrimUtilsTest, 
TestSuggestSpellingConverter, DOMUtilTest, RAMDirectoryFactoryTest, 
ClusterStateTest, SystemInfoHandlerTest, UUIDFieldTest, FileUtilsTest, 
CircularListTest, CursorPagingTest, SolrTestCaseJ4Test, 
TestSimpleTrackingShardHandler, TestEmbeddedSolrServerConstructors, 
TestEmbeddedSolrServerSchemaAPI, ActionThrottleTest, AliasIntegrationTest, 
CdcrBootstrapTest, CdcrVersionReplicationTest, CollectionStateFormat2Test, 
ConcurrentDeleteAndCreateCollectionTest, DeleteLastCustomShardedReplicaTest, 
DeleteShardTest, DistribCursorPagingTest, LeaderElectionContextKeyTest]
   [junit4] Completed [504/731 (1!)] on J0 in 6.90s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 11 lines...]
   [junit4] Suite: org.apache.solr.cloud.HttpPartitionTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_EDB3304C08F978F6-001/init-core-data-001
   [junit4]   2> 4481658 WARN  
(SUITE-HttpPartitionTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=14 numCloses=14
   [junit4]   2> 4481659 INFO  
(SUITE-HttpPartitionTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 4481661 INFO  
(SUITE-HttpPartitionTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776)
   [junit4]   2> 4481661 INFO  
(SUITE-HttpPartitionTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 4481661 INFO  
(SUITE-HttpPartitionTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 4481664 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 4481664 INFO  (Thread-18313) [    ] o.a.s.c.ZkTestServer 
client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 4481664 INFO  (Thread-18313) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 4481666 ERROR (Thread-18313) [    ] 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> 4481764 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:58750
   [junit4]   2> 4481786 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 4481787 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 4481788 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 4481789 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 4481790 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 4481791 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 4481791 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 4481792 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 4481793 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 4481794 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 4481795 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 4481796 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase Will use TLOG replicas unless explicitly 
asked otherwise
   [junit4]   2> 4481953 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] o.e.j.s.Server 
jetty-9.3.20.v20170531
   [junit4]   2> 4481963 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@69fef054{/,null,AVAILABLE}
   [junit4]   2> 4481972 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@47623057{HTTP/1.1,[http/1.1]}{127.0.0.1:44562}
   [junit4]   2> 4481972 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] o.e.j.s.Server 
Started @4486951ms
   [junit4]   2> 4481972 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_EDB3304C08F978F6-001/tempDir-001/control/data,
 hostContext=/, hostPort=43986, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_EDB3304C08F978F6-001/control-001/cores}
   [junit4]   2> 4481972 ERROR 
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 4481972 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.1.0
   [junit4]   2> 4481972 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 4481972 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 4481972 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-09-08T20:09:28.703Z
   [junit4]   2> 4481998 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 4481998 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_EDB3304C08F978F6-001/control-001/solr.xml
   [junit4]   2> 4482005 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@29f1461d, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 4482029 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58750/solr
   [junit4]   2> 4482206 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [n:127.0.0.1:43986_    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 4482207 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [n:127.0.0.1:43986_    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:43986_
   [junit4]   2> 4482208 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [n:127.0.0.1:43986_    ] 
o.a.s.c.Overseer Overseer (id=98625216079200260-127.0.0.1:43986_-n_0000000000) 
starting
   [junit4]   2> 4482230 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [n:127.0.0.1:43986_    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:43986_
   [junit4]   2> 4482231 INFO  
(zkCallback-30745-thread-1-processing-n:127.0.0.1:43986_) [n:127.0.0.1:43986_   
 ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 4482663 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [n:127.0.0.1:43986_    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@29f1461d
   [junit4]   2> 4482701 INFO  
(TEST-HttpPartitionTest.test-seed#[EDB3304C08F978F6]) [n:127.0.0.1:43986_    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@29f1461d
   [junit4]   2> 4482701 INFO  (TEST-HttpPartitionTest.test-see

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

itArgsOrSysPropConfig -Dtests.seed=EDB3304C08F978F6 -Dtests.multiplier=2 
-Dtests.nightly=true -Dtests.slow=true 
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/test-data/enwiki.random.lines.txt
 -Dtests.locale=hu-HU -Dtests.timezone=Asia/Almaty -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   3.23s J1 | 
HdfsDirectoryFactoryTest.testInitArgsOrSysPropConfig <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: The max direct 
memory is likely too low.  Either increase it (by adding 
-XX:MaxDirectMemorySize=<size>g -XX:+UseLargePages to your containers startup 
args) or disable direct allocation using 
solr.hdfs.blockcache.direct.memory.allocation=false in solrconfig.xml. If you 
are putting the block cache on the heap, your java heap size might not be large 
enough. Failed allocating ~134.217728 MB.
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([EDB3304C08F978F6:1A1CF967F57092DD]:0)
   [junit4]    >        at 
org.apache.solr.core.HdfsDirectoryFactory.createBlockCache(HdfsDirectoryFactory.java:311)
   [junit4]    >        at 
org.apache.solr.core.HdfsDirectoryFactory.getBlockDirectoryCache(HdfsDirectoryFactory.java:287)
   [junit4]    >        at 
org.apache.solr.core.HdfsDirectoryFactory.create(HdfsDirectoryFactory.java:227)
   [junit4]    >        at 
org.apache.solr.core.HdfsDirectoryFactoryTest.testInitArgsOrSysPropConfig(HdfsDirectoryFactoryTest.java:111)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]    > Caused by: java.lang.OutOfMemoryError: Direct buffer memory
   [junit4]    >        at java.nio.Bits.reserveMemory(Bits.java:694)
   [junit4]    >        at 
java.nio.DirectByteBuffer.<init>(DirectByteBuffer.java:123)
   [junit4]    >        at 
java.nio.ByteBuffer.allocateDirect(ByteBuffer.java:311)
   [junit4]    >        at 
org.apache.solr.store.blockcache.BlockCache.<init>(BlockCache.java:71)
   [junit4]    >        at 
org.apache.solr.core.HdfsDirectoryFactory.createBlockCache(HdfsDirectoryFactory.java:309)
   [junit4]    >        ... 42 more
   [junit4]   2> 6019276 WARN  
(SUITE-HdfsDirectoryFactoryTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.h.h.s.d.DirectoryScanner DirectoryScanner: shutdown has been called
   [junit4]   2> 6019502 INFO  
(SUITE-HdfsDirectoryFactoryTest-seed#[EDB3304C08F978F6]-worker) [    ] o.m.log 
Stopped HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:0
   [junit4]   2> 6019603 WARN  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.core.HdfsDirectoryFactoryTest_EDB3304C08F978F6-001/tempDir-001/hdfsBaseDir/data/data3/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.core.HdfsDirectoryFactoryTest_EDB3304C08F978F6-001/tempDir-001/hdfsBaseDir/data/data4/]]
  heartbeating to localhost/127.0.0.1:55357) [    ] 
o.a.h.h.s.d.IncrementalBlockReportManager IncrementalBlockReportManager 
interrupted
   [junit4]   2> 6019603 WARN  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.core.HdfsDirectoryFactoryTest_EDB3304C08F978F6-001/tempDir-001/hdfsBaseDir/data/data3/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.core.HdfsDirectoryFactoryTest_EDB3304C08F978F6-001/tempDir-001/hdfsBaseDir/data/data4/]]
  heartbeating to localhost/127.0.0.1:55357) [    ] o.a.h.h.s.d.DataNode Ending 
block pool service for: Block pool BP-1217419194-10.41.0.5-1504902900480 
(Datanode Uuid bb35aa8e-3d9c-4d5e-864b-4c6e35193a54) service to 
localhost/127.0.0.1:55357
   [junit4]   2> 6019605 WARN  
(SUITE-HdfsDirectoryFactoryTest-seed#[EDB3304C08F978F6]-worker) [    ] 
o.a.h.h.s.d.DirectoryScanner DirectoryScanner: shutdown has been called
   [junit4]   2> 6019731 INFO  
(SUITE-HdfsDirectoryFactoryTest-seed#[EDB3304C08F978F6]-worker) [    ] o.m.log 
Stopped HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:0
   [junit4]   2> 6019920 WARN  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.core.HdfsDirectoryFactoryTest_EDB3304C08F978F6-001/tempDir-001/hdfsBaseDir/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.core.HdfsDirectoryFactoryTest_EDB3304C08F978F6-001/tempDir-001/hdfsBaseDir/data/data2/]]
  heartbeating to localhost/127.0.0.1:55357) [    ] 
o.a.h.h.s.d.IncrementalBlockReportManager IncrementalBlockReportManager 
interrupted
   [junit4]   2> 6019920 WARN  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.core.HdfsDirectoryFactoryTest_EDB3304C08F978F6-001/tempDir-001/hdfsBaseDir/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.core.HdfsDirectoryFactoryTest_EDB3304C08F978F6-001/tempDir-001/hdfsBaseDir/data/data2/]]
  heartbeating to localhost/127.0.0.1:55357) [    ] o.a.h.h.s.d.DataNode Ending 
block pool service for: Block pool BP-1217419194-10.41.0.5-1504902900480 
(Datanode Uuid 073bec27-470d-4d1b-97c9-0e56d98182ad) service to 
localhost/127.0.0.1:55357
   [junit4]   2> 6019945 INFO  
(SUITE-HdfsDirectoryFactoryTest-seed#[EDB3304C08F978F6]-worker) [    ] o.m.log 
Stopped HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:0
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.core.HdfsDirectoryFactoryTest_EDB3304C08F978F6-001
   [junit4]   2> Sep 08, 2017 8:35:07 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 34 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=RandomSimilarity(queryNorm=false): {}, locale=hu-HU, timezone=Asia/Almaty
   [junit4]   2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 
1.8.0_144 (64-bit)/cpus=4,threads=2,free=278032104,total=525860864
   [junit4]   2> NOTE: All tests run in this JVM: [TestAddFieldRealTimeGet, 
TestRTGBase, TestXIncludeConfig, TestSolrXml, SolrCoreMetricManagerTest, 
TestSubQueryTransformer, SolrCmdDistributorTest, TestLRUCache, 
CloneFieldUpdateProcessorFactoryTest, TestConfigSets, TestConfigSetsAPI, 
AssignBackwardCompatibilityTest, TestSystemCollAutoCreate, 
TestDefaultStatsCache, ShardRoutingTest, TestRebalanceLeaders, 
ConnectionReuseTest, TermVectorComponentTest, TestFieldCacheWithThreads, 
TestBlendedInfixSuggestions, TestSearcherReuse, 
BigEndianAscendingWordDeserializerTest, SpellCheckComponentTest, 
AutoScalingHandlerTest, ExplicitHLLTest, InfoHandlerTest, HdfsThreadLeakTest, 
TestUseDocValuesAsStored, TestSolrIndexConfig, 
AddSchemaFieldsUpdateProcessorFactoryTest, TestHashPartitioner, 
TestCursorMarkWithoutUniqueKey, TestSolrJ, IndexSchemaRuntimeFieldTest, 
TestStressInPlaceUpdates, ConnectionManagerTest, BaseCdcrDistributedZkTest, 
BlockJoinFacetRandomTest, TestDynamicLoading, TestDownShardTolerantSearch, 
TestCoreContainer, DistributedIntervalFacetingTest, CheckHdfsIndexTest, 
TestCloudInspectUtil, ClassificationUpdateProcessorFactoryTest, 
CoreAdminCreateDiscoverTest, TestPointFields, TestReqParamsAPI, SliceStateTest, 
TestFuzzyAnalyzedSuggestions, SpatialRPTFieldTypeTest, TestFiltering, 
CleanupOldIndexTest, OverseerRolesTest, TestManagedSynonymFilterFactory, 
TestExportWriter, TestLocalFSCloudBackupRestore, TestManagedResource, 
TestDistributedGrouping, TestClusterProperties, TestApiFramework, 
SolrJmxReporterCloudTest, CollectionsAPISolrJTest, DeleteReplicaTest, 
SmileWriterTest, TestSearchPerf, MoreLikeThisHandlerTest, 
LeaderInitiatedRecoveryOnShardRestartTest, TestSystemIdResolver, 
TestJsonFacets, SolrCloudReportersTest, SuggestComponentTest, 
DisMaxRequestHandlerTest, CSVRequestHandlerTest, 
TestPartialUpdateDeduplication, SolrMetricsIntegrationTest, 
TestJavabinTupleStreamParser, ZkSolrClientTest, DirectSolrSpellCheckerTest, 
JavabinLoaderTest, TestOnReconnectListenerSupport, 
SimpleCollectionCreateDeleteTest, ParsingFieldUpdateProcessorsTest, 
TestHighFrequencyDictionaryFactory, PeerSyncWithIndexFingerprintCachingTest, 
TestValueSourceCache, ForceLeaderTest, ZkStateReaderTest, 
TestComplexPhraseQParserPlugin, JsonLoaderTest, TestCloudSchemaless, 
DistanceFunctionTest, DistributedMLTComponentTest, 
UpdateRequestProcessorFactoryTest, MultiThreadedOCPTest, 
DirectSolrConnectionTest, BasicAuthStandaloneTest, 
ChaosMonkeyNothingIsSafeWithPullReplicasTest, DeleteInactiveReplicaTest, 
TestSolrCloudWithKerberosAlt, SampleTest, BasicFunctionalityTest, 
TestNumericTerms64, ShufflingReplicaListTransformerTest, 
AnalysisErrorHandlingTest, SchemaVersionSpecificBehaviorTest, BadComponentTest, 
DocValuesTest, TestPKIAuthenticationPlugin, TestFilteredDocIdSet, 
CacheHeaderTest, AnalyticsQueryTest, SuggesterTSTTest, 
HdfsWriteToMultipleCollectionsTest, BufferStoreTest, TestDynamicFieldResource, 
DistributedQueueTest, TestLegacyNumericUtils, QueryParsingTest, 
ZkControllerTest, SolrXmlInZkTest, BasicDistributedZkTest, 
LeaderFailureAfterFreshStartTest, LeaderInitiatedRecoveryOnCommitTest, 
OutOfBoxZkACLAndCredentialsProvidersTest, 
OverriddenZkACLAndCredentialsProvidersTest, OverseerModifyCollectionTest, 
OverseerTaskQueueTest, PeerSyncReplicationTest, ShardSplitTest, 
TestCloudRecovery, TestExclusionRuleCollectionAccess, 
TestLeaderElectionWithEmptyReplica, TestLeaderElectionZkExpiry, 
TestRequestForwarding, TestRequestStatusCollectionAPI, 
TestShortCircuitedRequests, TestTlogReplica, ZkFailoverTest, 
HdfsBasicDistributedZkTest, HdfsUnloadDistributedZkTest, 
ConfigureRecoveryStrategyTest, CoreSorterTest, DirectoryFactoryTest, 
HdfsDirectoryFactoryTest]
   [junit4] Completed [572/731 (4!)] on J1 in 16.81s, 3 tests, 1 error <<< 
FAILURES!

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

Reply via email to