Build: https://builds.apache.org/job/Lucene-Solr-Tests-7.x/498/

7 tests failed.
FAILED:  org.apache.solr.cloud.BasicDistributedZkTest.test

Error Message:
Test abandoned because suite timeout was reached.

Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
        at __randomizedtesting.SeedInfo.seed([9AE3B2F8A0EB66C1]:0)


FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.BasicDistributedZkTest

Error Message:
Suite timeout exceeded (>= 7200000 msec).

Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
        at __randomizedtesting.SeedInfo.seed([9AE3B2F8A0EB66C1]:0)


FAILED:  
junit.framework.TestSuite.org.apache.solr.cloud.TestLeaderElectionZkExpiry

Error Message:
ObjectTracker found 1 object(s) that were not released!!! [Overseer] 
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: 
org.apache.solr.cloud.Overseer  at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
  at org.apache.solr.cloud.Overseer.start(Overseer.java:545)  at 
org.apache.solr.cloud.OverseerElectionContext.runLeaderProcess(ElectionContext.java:850)
  at 
org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:170) 
 at 
org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:135)  
at org.apache.solr.cloud.LeaderElector.joinElection(LeaderElector.java:307)  at 
org.apache.solr.cloud.LeaderElector.retryElection(LeaderElector.java:393)  at 
org.apache.solr.cloud.ZkController.rejoinOverseerElection(ZkController.java:2055)
  at 
org.apache.solr.cloud.Overseer$ClusterStateUpdater.checkIfIamStillLeader(Overseer.java:331)
  at java.lang.Thread.run(Thread.java:748)  

Stack Trace:
java.lang.AssertionError: ObjectTracker found 1 object(s) that were not 
released!!! [Overseer]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: 
org.apache.solr.cloud.Overseer
        at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
        at org.apache.solr.cloud.Overseer.start(Overseer.java:545)
        at 
org.apache.solr.cloud.OverseerElectionContext.runLeaderProcess(ElectionContext.java:850)
        at 
org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:170)
        at 
org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:135)
        at 
org.apache.solr.cloud.LeaderElector.joinElection(LeaderElector.java:307)
        at 
org.apache.solr.cloud.LeaderElector.retryElection(LeaderElector.java:393)
        at 
org.apache.solr.cloud.ZkController.rejoinOverseerElection(ZkController.java:2055)
        at 
org.apache.solr.cloud.Overseer$ClusterStateUpdater.checkIfIamStillLeader(Overseer.java:331)
        at java.lang.Thread.run(Thread.java:748)


        at __randomizedtesting.SeedInfo.seed([9AE3B2F8A0EB66C1]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNull(Assert.java:551)
        at 
org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:301)
        at sun.reflect.GeneratedMethodAccessor65.invoke(Unknown Source)
        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$7.evaluate(RandomizedRunner.java:897)
        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:  
junit.framework.TestSuite.org.apache.solr.cloud.TestLeaderElectionZkExpiry

Error Message:
1 thread leaked from SUITE scope at 
org.apache.solr.cloud.TestLeaderElectionZkExpiry:     1) Thread[id=16681, 
name=OverseerAutoScalingTriggerThread-72269253585862666-dummy.host.com:8984_solr-n_0000000007,
 state=RUNNABLE, group=Overseer autoscaling triggers]         at 
org.apache.lucene.util.TestRuleLimitSysouts$DelegateStream.write(TestRuleLimitSysouts.java:128)
         at java.io.PrintStream.write(PrintStream.java:480)         at 
sun.nio.cs.StreamEncoder.writeBytes(StreamEncoder.java:221)         at 
sun.nio.cs.StreamEncoder.implFlushBuffer(StreamEncoder.java:291)         at 
sun.nio.cs.StreamEncoder.implFlush(StreamEncoder.java:295)         at 
sun.nio.cs.StreamEncoder.flush(StreamEncoder.java:141)         at 
java.io.OutputStreamWriter.flush(OutputStreamWriter.java:229)         at 
org.apache.log4j.helpers.QuietWriter.flush(QuietWriter.java:59)         at 
org.apache.log4j.WriterAppender.subAppend(WriterAppender.java:324)         at 
org.apache.log4j.WriterAppender.append(WriterAppender.java:162)         at 
org.apache.log4j.AppenderSkeleton.doAppend(AppenderSkeleton.java:251)         
at 
org.apache.log4j.helpers.AppenderAttachableImpl.appendLoopOnAppenders(AppenderAttachableImpl.java:66)
         at org.apache.log4j.Category.callAppenders(Category.java:206)         
at org.apache.log4j.Category.forcedLog(Category.java:391)         at 
org.apache.log4j.Category.log(Category.java:856)         at 
org.slf4j.impl.Log4jLoggerAdapter.error(Log4jLoggerAdapter.java:576)         at 
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:140)
         at java.lang.Thread.run(Thread.java:748)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.cloud.TestLeaderElectionZkExpiry: 
   1) Thread[id=16681, 
name=OverseerAutoScalingTriggerThread-72269253585862666-dummy.host.com:8984_solr-n_0000000007,
 state=RUNNABLE, group=Overseer autoscaling triggers]
        at 
org.apache.lucene.util.TestRuleLimitSysouts$DelegateStream.write(TestRuleLimitSysouts.java:128)
        at java.io.PrintStream.write(PrintStream.java:480)
        at sun.nio.cs.StreamEncoder.writeBytes(StreamEncoder.java:221)
        at sun.nio.cs.StreamEncoder.implFlushBuffer(StreamEncoder.java:291)
        at sun.nio.cs.StreamEncoder.implFlush(StreamEncoder.java:295)
        at sun.nio.cs.StreamEncoder.flush(StreamEncoder.java:141)
        at java.io.OutputStreamWriter.flush(OutputStreamWriter.java:229)
        at org.apache.log4j.helpers.QuietWriter.flush(QuietWriter.java:59)
        at org.apache.log4j.WriterAppender.subAppend(WriterAppender.java:324)
        at org.apache.log4j.WriterAppender.append(WriterAppender.java:162)
        at org.apache.log4j.AppenderSkeleton.doAppend(AppenderSkeleton.java:251)
        at 
org.apache.log4j.helpers.AppenderAttachableImpl.appendLoopOnAppenders(AppenderAttachableImpl.java:66)
        at org.apache.log4j.Category.callAppenders(Category.java:206)
        at org.apache.log4j.Category.forcedLog(Category.java:391)
        at org.apache.log4j.Category.log(Category.java:856)
        at org.slf4j.impl.Log4jLoggerAdapter.error(Log4jLoggerAdapter.java:576)
        at 
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:140)
        at java.lang.Thread.run(Thread.java:748)
        at __randomizedtesting.SeedInfo.seed([9AE3B2F8A0EB66C1]:0)


FAILED:  
junit.framework.TestSuite.org.apache.solr.cloud.TestLeaderElectionZkExpiry

Error Message:
There are still zombie threads that couldn't be terminated:    1) 
Thread[id=16681, 
name=OverseerAutoScalingTriggerThread-72269253585862666-dummy.host.com:8984_solr-n_0000000007,
 state=RUNNABLE, group=Overseer autoscaling triggers]         at 
org.apache.lucene.util.TestRuleLimitSysouts$DelegateStream.write(TestRuleLimitSysouts.java:128)
         at java.io.PrintStream.write(PrintStream.java:480)         at 
sun.nio.cs.StreamEncoder.writeBytes(StreamEncoder.java:221)         at 
sun.nio.cs.StreamEncoder.implFlushBuffer(StreamEncoder.java:291)         at 
sun.nio.cs.StreamEncoder.implFlush(StreamEncoder.java:295)         at 
sun.nio.cs.StreamEncoder.flush(StreamEncoder.java:141)         at 
java.io.OutputStreamWriter.flush(OutputStreamWriter.java:229)         at 
org.apache.log4j.helpers.QuietWriter.flush(QuietWriter.java:59)         at 
org.apache.log4j.WriterAppender.subAppend(WriterAppender.java:324)         at 
org.apache.log4j.WriterAppender.append(WriterAppender.java:162)         at 
org.apache.log4j.AppenderSkeleton.doAppend(AppenderSkeleton.java:251)         
at 
org.apache.log4j.helpers.AppenderAttachableImpl.appendLoopOnAppenders(AppenderAttachableImpl.java:66)
         at org.apache.log4j.Category.callAppenders(Category.java:206)         
at org.apache.log4j.Category.forcedLog(Category.java:391)         at 
org.apache.log4j.Category.log(Category.java:856)         at 
org.slf4j.impl.Log4jLoggerAdapter.error(Log4jLoggerAdapter.java:576)         at 
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:140)
         at java.lang.Thread.run(Thread.java:748)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   1) Thread[id=16681, 
name=OverseerAutoScalingTriggerThread-72269253585862666-dummy.host.com:8984_solr-n_0000000007,
 state=RUNNABLE, group=Overseer autoscaling triggers]
        at 
org.apache.lucene.util.TestRuleLimitSysouts$DelegateStream.write(TestRuleLimitSysouts.java:128)
        at java.io.PrintStream.write(PrintStream.java:480)
        at sun.nio.cs.StreamEncoder.writeBytes(StreamEncoder.java:221)
        at sun.nio.cs.StreamEncoder.implFlushBuffer(StreamEncoder.java:291)
        at sun.nio.cs.StreamEncoder.implFlush(StreamEncoder.java:295)
        at sun.nio.cs.StreamEncoder.flush(StreamEncoder.java:141)
        at java.io.OutputStreamWriter.flush(OutputStreamWriter.java:229)
        at org.apache.log4j.helpers.QuietWriter.flush(QuietWriter.java:59)
        at org.apache.log4j.WriterAppender.subAppend(WriterAppender.java:324)
        at org.apache.log4j.WriterAppender.append(WriterAppender.java:162)
        at org.apache.log4j.AppenderSkeleton.doAppend(AppenderSkeleton.java:251)
        at 
org.apache.log4j.helpers.AppenderAttachableImpl.appendLoopOnAppenders(AppenderAttachableImpl.java:66)
        at org.apache.log4j.Category.callAppenders(Category.java:206)
        at org.apache.log4j.Category.forcedLog(Category.java:391)
        at org.apache.log4j.Category.log(Category.java:856)
        at org.slf4j.impl.Log4jLoggerAdapter.error(Log4jLoggerAdapter.java:576)
        at 
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:140)
        at java.lang.Thread.run(Thread.java:748)
        at __randomizedtesting.SeedInfo.seed([9AE3B2F8A0EB66C1]:0)


FAILED:  org.apache.solr.cloud.TestRandomFlRTGCloud.testRandomizedUpdatesAndRTGs

Error Message:
Could not load collection from ZK: 
org.apache.solr.cloud.TestRandomFlRTGCloud_collection

Stack Trace:
org.apache.solr.common.SolrException: Could not load collection from ZK: 
org.apache.solr.cloud.TestRandomFlRTGCloud_collection
        at 
__randomizedtesting.SeedInfo.seed([9AE3B2F8A0EB66C1:243F7A04674CEEED]:0)
        at 
org.apache.solr.common.cloud.ZkStateReader.getCollectionLive(ZkStateReader.java:1231)
        at 
org.apache.solr.common.cloud.ZkStateReader$LazyCollectionRef.get(ZkStateReader.java:669)
        at 
org.apache.solr.common.cloud.ClusterState$CollectionRef.get(ClusterState.java:386)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.getDocCollection(CloudSolrClient.java:1207)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:850)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:818)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
        at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:942)
        at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:957)
        at 
org.apache.solr.cloud.TestRandomFlRTGCloud.assertRTG(TestRandomFlRTGCloud.java:396)
        at 
org.apache.solr.cloud.TestRandomFlRTGCloud.assertOneIter(TestRandomFlRTGCloud.java:266)
        at 
org.apache.solr.cloud.TestRandomFlRTGCloud.testRandomizedUpdatesAndRTGs(TestRandomFlRTGCloud.java:223)
        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: org.apache.zookeeper.KeeperException$SessionExpiredException: 
KeeperErrorCode = Session expired for 
/collections/org.apache.solr.cloud.TestRandomFlRTGCloud_collection/state.json
        at org.apache.zookeeper.KeeperException.create(KeeperException.java:130)
        at org.apache.zookeeper.KeeperException.create(KeeperException.java:54)
        at org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1215)
        at 
org.apache.solr.common.cloud.SolrZkClient.lambda$getData$5(SolrZkClient.java:340)
        at 
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
        at 
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:340)
        at 
org.apache.solr.common.cloud.ZkStateReader.fetchCollectionState(ZkStateReader.java:1243)
        at 
org.apache.solr.common.cloud.ZkStateReader.getCollectionLive(ZkStateReader.java:1229)
        ... 50 more


FAILED:  org.apache.solr.logging.TestLogWatcher.testLog4jWatcher

Error Message:
expected:<50> but was:<1>

Stack Trace:
java.lang.AssertionError: expected:<50> but was:<1>
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:472)
        at org.junit.Assert.assertEquals(Assert.java:456)
        at 
org.apache.solr.logging.TestLogWatcher.testLog4jWatcher(TestLogWatcher.java:52)
        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 
org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
        at 
org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
        at 
org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
        at 
org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
        at 
org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
        at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
        at 
org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
        at 
org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
        at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
        at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
        at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
        at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
        at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
        at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
        at 
com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:251)
        at 
com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:368)
        at 
com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:13)




Build Log:
[...truncated 12556 lines...]
   [junit4] Suite: org.apache.solr.cloud.TestRandomFlRTGCloud
   [junit4]   2> 669010 INFO  
(SUITE-TestRandomFlRTGCloud-seed#[9AE3B2F8A0EB66C1]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.TestRandomFlRTGCloud_9AE3B2F8A0EB66C1-001/init-core-data-001
   [junit4]   2> 669011 INFO  
(SUITE-TestRandomFlRTGCloud-seed#[9AE3B2F8A0EB66C1]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 669012 INFO  
(SUITE-TestRandomFlRTGCloud-seed#[9AE3B2F8A0EB66C1]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=client auth uses too much RAM, 
value=NaN, ssl=NaN, clientAuth=0.0)
   [junit4]   2> 669012 INFO  
(SUITE-TestRandomFlRTGCloud-seed#[9AE3B2F8A0EB66C1]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 3 servers in 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.TestRandomFlRTGCloud_9AE3B2F8A0EB66C1-001/tempDir-001
   [junit4]   2> 669013 INFO  
(SUITE-TestRandomFlRTGCloud-seed#[9AE3B2F8A0EB66C1]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 669013 INFO  (Thread-543) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 669013 INFO  (Thread-543) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 669015 ERROR (Thread-543) [    ] 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> 669120 INFO  
(SUITE-TestRandomFlRTGCloud-seed#[9AE3B2F8A0EB66C1]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:35647
   [junit4]   2> 669160 INFO  (zkConnectionManagerCallback-798-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 669163 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x100c061ae7b0000, likely client has closed socket
   [junit4]   2> 669194 INFO  (jetty-launcher-795-thread-2) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 669198 INFO  (jetty-launcher-795-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 669216 INFO  (jetty-launcher-795-thread-3) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 669295 INFO  (jetty-launcher-795-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 669295 INFO  (jetty-launcher-795-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 669295 INFO  (jetty-launcher-795-thread-1) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 669295 INFO  (jetty-launcher-795-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2d8c4109{/solr,null,AVAILABLE}
   [junit4]   2> 669297 INFO  (jetty-launcher-795-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@2563214d{SSL,[ssl, 
http/1.1]}{127.0.0.1:42811}
   [junit4]   2> 669297 INFO  (jetty-launcher-795-thread-1) [    ] 
o.e.j.s.Server Started @679685ms
   [junit4]   2> 669297 INFO  (jetty-launcher-795-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=42811}
   [junit4]   2> 669297 ERROR (jetty-launcher-795-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 669297 INFO  (jetty-launcher-795-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.4.0
   [junit4]   2> 669297 INFO  (jetty-launcher-795-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 669297 INFO  (jetty-launcher-795-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 669297 INFO  (jetty-launcher-795-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-12T21:30:26.477Z
   [junit4]   2> 669360 INFO  (jetty-launcher-795-thread-3) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 669361 INFO  (jetty-launcher-795-thread-3) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 669361 INFO  (jetty-launcher-795-thread-3) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 669361 INFO  (jetty-launcher-795-thread-2) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 669361 INFO  (jetty-launcher-795-thread-2) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 669361 INFO  (jetty-launcher-795-thread-2) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 669362 INFO  (jetty-launcher-795-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@4a7da037{/solr,null,AVAILABLE}
   [junit4]   2> 669362 INFO  (jetty-launcher-795-thread-2) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@684fb881{SSL,[ssl, 
http/1.1]}{127.0.0.1:36970}
   [junit4]   2> 669362 INFO  (jetty-launcher-795-thread-2) [    ] 
o.e.j.s.Server Started @679750ms
   [junit4]   2> 669362 INFO  (jetty-launcher-795-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=36970}
   [junit4]   2> 669363 INFO  (jetty-launcher-795-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2a671b35{/solr,null,AVAILABLE}
   [junit4]   2> 669363 INFO  (jetty-launcher-795-thread-3) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@56bc0897{SSL,[ssl, 
http/1.1]}{127.0.0.1:37581}
   [junit4]   2> 669363 INFO  (jetty-launcher-795-thread-3) [    ] 
o.e.j.s.Server Started @679751ms
   [junit4]   2> 669363 INFO  (jetty-launcher-795-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=37581}
   [junit4]   2> 669363 ERROR (jetty-launcher-795-thread-3) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 669363 INFO  (jetty-launcher-795-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.4.0
   [junit4]   2> 669363 INFO  (jetty-launcher-795-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 669363 INFO  (jetty-launcher-795-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 669364 INFO  (jetty-launcher-795-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-12T21:30:26.544Z
   [junit4]   2> 669364 ERROR (jetty-launcher-795-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 669364 INFO  (jetty-launcher-795-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.4.0
   [junit4]   2> 669364 INFO  (jetty-launcher-795-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 669364 INFO  (jetty-launcher-795-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 669364 INFO  (jetty-launcher-795-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-12T21:30:26.544Z
   [junit4]   2> 669388 INFO  (zkConnectionManagerCallback-800-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 669404 INFO  (jetty-launcher-795-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 669404 INFO  (zkConnectionManagerCallback-802-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 669417 INFO  (jetty-launcher-795-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 669422 INFO  (zkConnectionManagerCallback-804-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 669427 INFO  (jetty-launcher-795-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 669601 INFO  (jetty-launcher-795-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35647/solr
   [junit4]   2> 669620 INFO  (zkConnectionManagerCallback-808-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 669681 INFO  (jetty-launcher-795-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35647/solr
   [junit4]   2> 669705 INFO  (jetty-launcher-795-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35647/solr
   [junit4]   2> 669710 INFO  (zkConnectionManagerCallback-816-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 669710 INFO  (zkConnectionManagerCallback-814-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 669711 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x100c061ae7b0004, likely client has closed socket
   [junit4]   2> 669712 INFO  
(zkConnectionManagerCallback-818-thread-1-processing-n:127.0.0.1:37581_solr) 
[n:127.0.0.1:37581_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 669843 INFO  
(zkConnectionManagerCallback-820-thread-1-processing-n:127.0.0.1:36970_solr) 
[n:127.0.0.1:36970_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 669953 INFO  
(zkConnectionManagerCallback-822-thread-1-processing-n:127.0.0.1:42811_solr) 
[n:127.0.0.1:42811_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 670336 INFO  (jetty-launcher-795-thread-2) 
[n:127.0.0.1:36970_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 670337 INFO  (jetty-launcher-795-thread-2) 
[n:127.0.0.1:36970_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:36970_solr
   [junit4]   2> 670338 INFO  (jetty-launcher-795-thread-2) 
[n:127.0.0.1:36970_solr    ] o.a.s.c.Overseer Overseer 
(id=72269119809585160-127.0.0.1:36970_solr-n_0000000000) starting
   [junit4]   2> 670355 INFO  (jetty-launcher-795-thread-1) 
[n:127.0.0.1:42811_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 670384 INFO  (jetty-launcher-795-thread-1) 
[n:127.0.0.1:42811_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:42811_solr
   [junit4]   2> 670434 INFO  
(zkCallback-821-thread-1-processing-n:127.0.0.1:42811_solr) 
[n:127.0.0.1:42811_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 670435 INFO  (jetty-launcher-795-thread-3) 
[n:127.0.0.1:37581_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 670449 INFO  (jetty-launcher-795-thread-3) 
[n:127.0.0.1:37581_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 670450 INFO  (jetty-launcher-795-thread-3) 
[n:127.0.0.1:37581_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:37581_solr
   [junit4]   2> 670465 INFO  
(zkCallback-821-thread-1-processing-n:127.0.0.1:42811_solr) 
[n:127.0.0.1:42811_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 670575 INFO  
(zkCallback-817-thread-1-processing-n:127.0.0.1:37581_solr) 
[n:127.0.0.1:37581_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 670582 INFO  
(zkCallback-819-thread-1-processing-n:127.0.0.1:36970_solr) 
[n:127.0.0.1:36970_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 670594 INFO  
(zkConnectionManagerCallback-829-thread-1-processing-n:127.0.0.1:36970_solr) 
[n:127.0.0.1:36970_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 670651 INFO  (jetty-launcher-795-thread-2) 
[n:127.0.0.1:36970_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 670716 INFO  (jetty-launcher-795-thread-2) 
[n:127.0.0.1:36970_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:35647/solr ready
   [junit4]   2> 670732 INFO  (jetty-launcher-795-thread-1) 
[n:127.0.0.1:42811_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42811.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7a5dbe0b
   [junit4]   2> 670756 INFO  (jetty-launcher-795-thread-1) 
[n:127.0.0.1:42811_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42811.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7a5dbe0b
   [junit4]   2> 670757 INFO  (jetty-launcher-795-thread-1) 
[n:127.0.0.1:42811_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42811.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7a5dbe0b
   [junit4]   2> 670774 INFO  (jetty-launcher-795-thread-1) 
[n:127.0.0.1:42811_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.TestRandomFlRTGCloud_9AE3B2F8A0EB66C1-001/tempDir-001/node1/.
   [junit4]   2> 670819 INFO  (jetty-launcher-795-thread-2) 
[n:127.0.0.1:36970_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:36970_solr
   [junit4]   2> 670819 INFO  (jetty-launcher-795-thread-3) 
[n:127.0.0.1:37581_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37581.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7a5dbe0b
   [junit4]   2> 670838 INFO  
(zkCallback-821-thread-1-processing-n:127.0.0.1:42811_solr) 
[n:127.0.0.1:42811_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 670855 INFO  
(zkCallback-817-thread-1-processing-n:127.0.0.1:37581_solr) 
[n:127.0.0.1:37581_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 670867 INFO  
(zkCallback-819-thread-1-processing-n:127.0.0.1:36970_solr) 
[n:127.0.0.1:36970_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 670876 INFO  (jetty-launcher-795-thread-3) 
[n:127.0.0.1:37581_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37581.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7a5dbe0b
   [junit4]   2> 670876 INFO  
(zkConnectionManagerCallback-833-thread-1-processing-n:127.0.0.1:42811_solr) 
[n:127.0.0.1:42811_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 670876 INFO  (jetty-launcher-795-thread-3) 
[n:127.0.0.1:37581_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37581.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7a5dbe0b
   [junit4]   2> 670877 INFO  (jetty-launcher-795-thread-3) 
[n:127.0.0.1:37581_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.TestRandomFlRTGCloud_9AE3B2F8A0EB66C1-001/tempDir-001/node3/.
   [junit4]   2> 670932 INFO  
(zkCallback-828-thread-1-processing-n:127.0.0.1:36970_solr) 
[n:127.0.0.1:36970_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 670936 INFO  (jetty-launcher-795-thread-1) 
[n:127.0.0.1:42811_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 670939 INFO  (jetty-launcher-795-thread-1) 
[n:127.0.0.1:42811_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:35647/solr ready
   [junit4]   2> 670976 INFO  
(zkConnectionManagerCallback-837-thread-1-processing-n:127.0.0.1:37581_solr) 
[n:127.0.0.1:37581_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 670997 INFO  (jetty-launcher-795-thread-3) 
[n:127.0.0.1:37581_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 670998 INFO  (jetty-launcher-795-thread-3) 
[n:127.0.0.1:37581_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:35647/solr ready
   [junit4]   2> 671071 INFO  (jetty-launcher-795-thread-2) 
[n:127.0.0.1:36970_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_36970.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7a5dbe0b
   [junit4]   2> 671107 INFO  (jetty-launcher-795-thread-2) 
[n:127.0.0.1:36970_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_36970.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7a5dbe0b
   [junit4]   2> 671107 INFO  (jetty-launcher-795-thread-2) 
[n:127.0.0.1:36970_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_36970.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7a5dbe0b
   [junit4]   2> 671108 INFO  (jetty-launcher-795-thread-2) 
[n:127.0.0.1:36970_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.TestRandomFlRTGCloud_9AE3B2F8A0EB66C1-001/tempDir-001/node2/.
   [junit4]   2> 671312 INFO  (zkConnectionManagerCallback-839-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 671338 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x100c061ae7b000d, likely client has closed socket
   [junit4]   2> 671339 INFO  (zkConnectionManagerCallback-843-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 671340 INFO  
(SUITE-TestRandomFlRTGCloud-seed#[9AE3B2F8A0EB66C1]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 671340 INFO  
(SUITE-TestRandomFlRTGCloud-seed#[9AE3B2F8A0EB66C1]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:35647/solr ready
   [junit4]   2> 672854 INFO  (qtp1930049981-2805) [n:127.0.0.1:36970_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&property.config=solrconfig-tlog.xml&property.schema=schema-psuedo-fields.xml&collection.configName=org.apache.solr.cloud.TestRandomFlRTGCloud_config-set&name=org.apache.solr.cloud.TestRandomFlRTGCloud_collection&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 672872 INFO  
(OverseerThreadFactory-1039-thread-1-processing-n:127.0.0.1:36970_solr) 
[n:127.0.0.1:36970_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
org.apache.solr.cloud.TestRandomFlRTGCloud_collection
   [junit4]   2> 673030 INFO  
(OverseerStateUpdate-72269119809585160-127.0.0.1:36970_solr-n_0000000000) 
[n:127.0.0.1:36970_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   
"collection":"org.apache.solr.cloud.TestRandomFlRTGCloud_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   
"core":"org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:37581/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 673043 INFO  
(OverseerStateUpdate-72269119809585160-127.0.0.1:36970_solr-n_0000000000) 
[n:127.0.0.1:36970_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   
"collection":"org.apache.solr.cloud.TestRandomFlRTGCloud_collection",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   
"core":"org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:42811/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 673447 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=org.apache.solr.cloud.TestRandomFlRTGCloud_config-set&newCollection=true&collection=org.apache.solr.cloud.TestRandomFlRTGCloud_collection&version=2&replicaType=NRT&property.config=solrconfig-tlog.xml&property.schema=schema-psuedo-fields.xml&coreNodeName=core_node3&name=org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1&action=CREATE&numShards=2&shard=shard1&wt=javabin
   [junit4]   2> 673448 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 673487 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=org.apache.solr.cloud.TestRandomFlRTGCloud_config-set&newCollection=true&collection=org.apache.solr.cloud.TestRandomFlRTGCloud_collection&version=2&replicaType=NRT&property.config=solrconfig-tlog.xml&property.schema=schema-psuedo-fields.xml&coreNodeName=core_node4&name=org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2&action=CREATE&numShards=2&shard=shard2&wt=javabin
   [junit4]   2> 673488 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 673625 INFO  
(zkCallback-817-thread-1-processing-n:127.0.0.1:37581_solr) 
[n:127.0.0.1:37581_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/org.apache.solr.cloud.TestRandomFlRTGCloud_collection/state.json]
 for collection [org.apache.solr.cloud.TestRandomFlRTGCloud_collection] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 673625 INFO  
(zkCallback-821-thread-1-processing-n:127.0.0.1:42811_solr) 
[n:127.0.0.1:42811_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/org.apache.solr.cloud.TestRandomFlRTGCloud_collection/state.json]
 for collection [org.apache.solr.cloud.TestRandomFlRTGCloud_collection] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 673625 INFO  
(zkCallback-821-thread-2-processing-n:127.0.0.1:42811_solr) 
[n:127.0.0.1:42811_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/org.apache.solr.cloud.TestRandomFlRTGCloud_collection/state.json]
 for collection [org.apache.solr.cloud.TestRandomFlRTGCloud_collection] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 673625 INFO  
(zkCallback-817-thread-2-processing-n:127.0.0.1:37581_solr) 
[n:127.0.0.1:37581_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/org.apache.solr.cloud.TestRandomFlRTGCloud_collection/state.json]
 for collection [org.apache.solr.cloud.TestRandomFlRTGCloud_collection] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 674554 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
   [junit4]   2> 674554 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
   [junit4]   2> 674593 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.s.IndexSchema 
[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
Schema name=test
   [junit4]   2> 674600 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.s.IndexSchema 
[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
Schema name=test
   [junit4]   2> 674610 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.s.IndexSchema Loaded schema test/1.4 with uniqueid field id
   [junit4]   2> 674617 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.s.IndexSchema Loaded schema test/1.4 with uniqueid field id
   [junit4]   2> 674632 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.c.CoreContainer Creating SolrCore 
'org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2' using 
configuration from collection 
org.apache.solr.cloud.TestRandomFlRTGCloud_collection, trusted=true
   [junit4]   2> 674632 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42811.solr.core.org.apache.solr.cloud.TestRandomFlRTGCloud_collection.shard2.replica_n2'
 (registry 
'solr.core.org.apache.solr.cloud.TestRandomFlRTGCloud_collection.shard2.replica_n2')
 enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7a5dbe0b
   [junit4]   2> 674633 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 674633 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.c.SolrCore 
[[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] ] 
Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.TestRandomFlRTGCloud_9AE3B2F8A0EB66C1-001/tempDir-001/node1/org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.TestRandomFlRTGCloud_9AE3B2F8A0EB66C1-001/tempDir-001/node1/./org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2/data/]
   [junit4]   2> 674652 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=39, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=19.76953125, 
floorSegmentMB=0.822265625, forceMergeDeletesPctAllowed=2.163578947914677, 
segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5617353461081368
   [junit4]   2> 674655 WARN  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 674670 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.c.CoreContainer Creating SolrCore 
'org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1' using 
configuration from collection 
org.apache.solr.cloud.TestRandomFlRTGCloud_collection, trusted=true
   [junit4]   2> 674670 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37581.solr.core.org.apache.solr.cloud.TestRandomFlRTGCloud_collection.shard1.replica_n1'
 (registry 
'solr.core.org.apache.solr.cloud.TestRandomFlRTGCloud_collection.shard1.replica_n1')
 enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7a5dbe0b
   [junit4]   2> 674671 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 674671 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.c.SolrCore 
[[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] ] 
Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.TestRandomFlRTGCloud_9AE3B2F8A0EB66C1-001/tempDir-001/node3/org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.TestRandomFlRTGCloud_9AE3B2F8A0EB66C1-001/tempDir-001/node3/./org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1/data/]
   [junit4]   2> 674686 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=39, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=19.76953125, 
floorSegmentMB=0.822265625, forceMergeDeletesPctAllowed=2.163578947914677, 
segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5617353461081368
   [junit4]   2> 674725 WARN  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 674928 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 674928 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 674929 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 674929 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 674931 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=29, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.18956422125226277]
   [junit4]   2> 675035 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@559deea2[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2]
 main]
   [junit4]   2> 675036 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 675036 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 675050 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 675050 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 675051 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=29, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.18956422125226277]
   [junit4]   2> 675051 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2926fdf9[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1]
 main]
   [junit4]   2> 675062 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/org.apache.solr.cloud.TestRandomFlRTGCloud_config-set
   [junit4]   2> 675063 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/org.apache.solr.cloud.TestRandomFlRTGCloud_config-set
   [junit4]   2> 675064 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 675137 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/org.apache.solr.cloud.TestRandomFlRTGCloud_config-set
   [junit4]   2> 675138 INFO  
(searcherExecutor-1045-thread-1-processing-n:127.0.0.1:37581_solr 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1 
s:shard1 c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection r:core_node3) 
[n:127.0.0.1:37581_solr c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection 
s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.c.SolrCore 
[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
Registered new searcher 
Searcher@2926fdf9[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1]
 main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 675138 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/org.apache.solr.cloud.TestRandomFlRTGCloud_config-set
   [junit4]   2> 675151 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1594768996256710656
   [junit4]   2> 675153 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 675153 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1594768996258807808
   [junit4]   2> 675158 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.c.ZkShardTerms Successful update terms at 
/collections/org.apache.solr.cloud.TestRandomFlRTGCloud_collection/terms/shard1 
to Terms{values={core_node3=0}, version=0}
   [junit4]   2> 675248 INFO  
(searcherExecutor-1044-thread-1-processing-n:127.0.0.1:42811_solr 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2 
s:shard2 c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection r:core_node4) 
[n:127.0.0.1:42811_solr c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection 
s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.c.SolrCore 
[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
Registered new searcher 
Searcher@559deea2[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2]
 main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 675250 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 675250 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 675250 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:37581/solr/org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1/
   [junit4]   2> 675250 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 675250 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.c.SyncStrategy 
https://127.0.0.1:37581/solr/org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1/
 has no replicas
   [junit4]   2> 675251 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 675252 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.c.ZkShardTerms Successful update terms at 
/collections/org.apache.solr.cloud.TestRandomFlRTGCloud_collection/terms/shard2 
to Terms{values={core_node4=0}, version=0}
   [junit4]   2> 675267 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 675267 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 675267 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:42811/solr/org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2/
   [junit4]   2> 675267 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 675267 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:37581/solr/org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1/
 shard1
   [junit4]   2> 675267 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.c.SyncStrategy 
https://127.0.0.1:42811/solr/org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2/
 has no replicas
   [junit4]   2> 675267 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 675300 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:42811/solr/org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2/
 shard2
   [junit4]   2> 675428 INFO  
(zkCallback-821-thread-2-processing-n:127.0.0.1:42811_solr) 
[n:127.0.0.1:42811_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/org.apache.solr.cloud.TestRandomFlRTGCloud_collection/state.json]
 for collection [org.apache.solr.cloud.TestRandomFlRTGCloud_collection] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 675428 INFO  
(zkCallback-817-thread-2-processing-n:127.0.0.1:37581_solr) 
[n:127.0.0.1:37581_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/org.apache.solr.cloud.TestRandomFlRTGCloud_collection/state.json]
 for collection [org.apache.solr.cloud.TestRandomFlRTGCloud_collection] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 675428 INFO  
(zkCallback-821-thread-1-processing-n:127.0.0.1:42811_solr) 
[n:127.0.0.1:42811_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/org.apache.solr.cloud.TestRandomFlRTGCloud_collection/state.json]
 for collection [org.apache.solr.cloud.TestRandomFlRTGCloud_collection] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 675428 INFO  
(zkCallback-817-thread-1-processing-n:127.0.0.1:37581_solr) 
[n:127.0.0.1:37581_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/org.apache.solr.cloud.TestRandomFlRTGCloud_collection/state.json]
 for collection [org.apache.solr.cloud.TestRandomFlRTGCloud_collection] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 675447 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 675449 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=org.apache.solr.cloud.TestRandomFlRTGCloud_config-set&newCollection=true&collection=org.apache.solr.cloud.TestRandomFlRTGCloud_collection&version=2&replicaType=NRT&property.config=solrconfig-tlog.xml&property.schema=schema-psuedo-fields.xml&coreNodeName=core_node3&name=org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1&action=CREATE&numShards=2&shard=shard1&wt=javabin}
 status=0 QTime=2002
   [junit4]   2> 675460 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 675466 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=org.apache.solr.cloud.TestRandomFlRTGCloud_config-set&newCollection=true&collection=org.apache.solr.cloud.TestRandomFlRTGCloud_collection&version=2&replicaType=NRT&property.config=solrconfig-tlog.xml&property.schema=schema-psuedo-fields.xml&coreNodeName=core_node4&name=org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2&action=CREATE&numShards=2&shard=shard2&wt=javabin}
 status=0 QTime=1978
   [junit4]   2> 675491 INFO  (qtp1930049981-2805) [n:127.0.0.1:36970_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> 675567 INFO  
(zkCallback-821-thread-1-processing-n:127.0.0.1:42811_solr) 
[n:127.0.0.1:42811_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/org.apache.solr.cloud.TestRandomFlRTGCloud_collection/state.json]
 for collection [org.apache.solr.cloud.TestRandomFlRTGCloud_collection] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 675567 INFO  
(zkCallback-821-thread-2-processing-n:127.0.0.1:42811_solr) 
[n:127.0.0.1:42811_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/org.apache.solr.cloud.TestRandomFlRTGCloud_collection/state.json]
 for collection [org.apache.solr.cloud.TestRandomFlRTGCloud_collection] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 675568 INFO  
(zkCallback-817-thread-2-processing-n:127.0.0.1:37581_solr) 
[n:127.0.0.1:37581_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/org.apache.solr.cloud.TestRandomFlRTGCloud_collection/state.json]
 for collection [org.apache.solr.cloud.TestRandomFlRTGCloud_collection] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 675568 INFO  
(zkCallback-817-thread-1-processing-n:127.0.0.1:37581_solr) 
[n:127.0.0.1:37581_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/org.apache.solr.cloud.TestRandomFlRTGCloud_collection/state.json]
 for collection [org.apache.solr.cloud.TestRandomFlRTGCloud_collection] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 676505 INFO  (qtp1930049981-2805) [n:127.0.0.1:36970_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={replicationFactor=1&property.config=solrconfig-tlog.xml&property.schema=schema-psuedo-fields.xml&collection.configName=org.apache.solr.cloud.TestRandomFlRTGCloud_config-set&name=org.apache.solr.cloud.TestRandomFlRTGCloud_collection&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2}
 status=0 QTime=3651
   [junit4]   2> 676511 INFO  
(SUITE-TestRandomFlRTGCloud-seed#[9AE3B2F8A0EB66C1]-worker) [    ] 
o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection: 
org.apache.solr.cloud.TestRandomFlRTGCloud_collection failOnTimeout:true 
timeout (sec):330
   [junit4]   1> -
   [junit4]   1> replica:core_node3 rstate:active live:true
   [junit4]   1> replica:core_node4 rstate:active live:true
   [junit4]   1> no one is recoverying
   [junit4]   2> 676512 INFO  
(SUITE-TestRandomFlRTGCloud-seed#[9AE3B2F8A0EB66C1]-worker) [    ] 
o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: 
org.apache.solr.cloud.TestRandomFlRTGCloud_collection
   [junit4]   2> 676712 INFO  
(TEST-TestRandomFlRTGCloud.testRandomizedUpdatesAndRTGs-seed#[9AE3B2F8A0EB66C1])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testRandomizedUpdatesAndRTGs
   [junit4]   2> 676712 INFO  
(TEST-TestRandomFlRTGCloud.testRandomizedUpdatesAndRTGs-seed#[9AE3B2F8A0EB66C1])
 [    ] o.a.s.c.TestRandomFlRTGCloud Starting 6226 iters by seeding 2 of 219 
max docs
   [junit4]   2> 676713 INFO  
(TEST-TestRandomFlRTGCloud.testRandomizedUpdatesAndRTGs-seed#[9AE3B2F8A0EB66C1])
 [    ] o.a.s.c.TestRandomFlRTGCloud ADD: 0 = SolrInputDocument(fields: [id=0, 
aaa_i=1661438809, bbb_i=1265477494, ccc_s=lxnhtavslk, ddd_s=vzvufmzbnp, 
eee_s=skrtnvh, fff_s=qd, ggg_s=muzkztp, hhh_s=, geo_1_srpt=POINT( 42 -42 ), 
geo_2_srpt=POINT( 42 -3 ), next_2_ids_ss=[1, 2], axx_i=-1330185601, 
ayy_i=-529977292, azz_s=jts])
   [junit4]   2> 676859 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.s.AbstractSpatialPrefixTreeFieldType 
location_rpt{class=org.apache.solr.schema.SpatialRecursivePrefixTreeFieldType,analyzer=org.apache.solr.schema.FieldType$DefaultAnalyzer,args={geo=true,
 maxDistErr=0.001, distErrPct=0.025, distanceUnits=kilometers, 
class=solr.SpatialRecursivePrefixTreeFieldType}} strat: 
RecursivePrefixTreeStrategy(SPG:(GeohashPrefixTree(maxLevels:11,ctx:SpatialContext{geo=true,
 calculator=Haversine, 
worldBounds=Rect(minX=-180.0,maxX=180.0,minY=-90.0,maxY=90.0)})),pruneLeafyBranches)
 maxLevels: 11
   [junit4]   2> 676900 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.s.AbstractSpatialPrefixTreeFieldType 
location_rpt{class=org.apache.solr.schema.SpatialRecursivePrefixTreeFieldType,analyzer=org.apache.solr.schema.FieldType$DefaultAnalyzer,args={geo=true,
 maxDistErr=0.001, distErrPct=0.025, distanceUnits=kilometers, 
class=solr.SpatialRecursivePrefixTreeFieldType}} strat: 
RecursivePrefixTreeStrategy(SPG:(GeohashPrefixTree(maxLevels:11,ctx:SpatialContext{geo=true,
 calculator=Haversine, 
worldBounds=Rect(minX=-180.0,maxX=180.0,minY=-90.0,maxY=90.0)})),pruneLeafyBranches)
 maxLevels: 11
   [junit4]   2> 676916 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.c.ZkShardTerms Successful update terms at 
/collections/org.apache.solr.cloud.TestRandomFlRTGCloud_collection/terms/shard1 
to Terms{values={core_node3=1}, version=1}
   [junit4]   2> 676916 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[0 
(1594768997940723712)]} 0 160
   [junit4]   2> 676917 INFO  
(TEST-TestRandomFlRTGCloud.testRandomizedUpdatesAndRTGs-seed#[9AE3B2F8A0EB66C1])
 [    ] o.a.s.c.TestRandomFlRTGCloud ADD: 1 = SolrInputDocument(fields: [id=1, 
aaa_i=-756431253, bbb_i=1684587044, ccc_s=ilmsuct, ddd_s=rjg, eee_s=krmfkx, 
fff_s=ejdmmcq, ggg_s=duwkei, hhh_s=nxuzm, geo_1_srpt=POINT( 42 23 ), 
geo_2_srpt=POINT( 42 -29 ), next_2_ids_ss=[2, 3], axx_i=-998328056, 
ayy_i=-968909338, azz_s=njkf])
   [junit4]   2> 676920 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1 
(1594768998109544448)]} 0 2
   [junit4]   2> 676929 INFO  
(TEST-TestRandomFlRTGCloud.testRandomizedUpdatesAndRTGs-seed#[9AE3B2F8A0EB66C1])
 [    ] o.a.s.c.TestRandomFlRTGCloud UPD: numDocsThisIter=4 
numDocsThisIterThatExist=0, docIds=[95, 64, 212, 19]
   [junit4]   2> 676929 INFO  
(TEST-TestRandomFlRTGCloud.testRandomizedUpdatesAndRTGs-seed#[9AE3B2F8A0EB66C1])
 [    ] o.a.s.c.TestRandomFlRTGCloud ADD: 95 = SolrInputDocument(fields: 
[id=95, aaa_i=-2143930877, bbb_i=600248589, ccc_s=mlav, ddd_s=isms, 
eee_s=syuchubla, fff_s=zuwdtzl, ggg_s=oycbyimodf, hhh_s=, geo_1_srpt=POINT( 42 
62 ), geo_2_srpt=POINT( 42 -42 ), next_2_ids_ss=[96, 97], axx_i=1750598581, 
ayy_i=114059447, azz_s=f])
   [junit4]   2> 676973 INFO  
(OverseerCollectionConfigSetProcessor-72269119809585160-127.0.0.1:36970_solr-n_0000000000)
 [n:127.0.0.1:36970_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> 677092 INFO  (qtp943035213-2788) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.s.AbstractSpatialPrefixTreeFieldType 
location_rpt{class=org.apache.solr.schema.SpatialRecursivePrefixTreeFieldType,analyzer=org.apache.solr.schema.FieldType$DefaultAnalyzer,args={geo=true,
 maxDistErr=0.001, distErrPct=0.025, distanceUnits=kilometers, 
class=solr.SpatialRecursivePrefixTreeFieldType}} strat: 
RecursivePrefixTreeStrategy(SPG:(GeohashPrefixTree(maxLevels:11,ctx:SpatialContext{geo=true,
 calculator=Haversine, 
worldBounds=Rect(minX=-180.0,maxX=180.0,minY=-90.0,maxY=90.0)})),pruneLeafyBranches)
 maxLevels: 11
   [junit4]   2> 677092 INFO  (qtp943035213-2788) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.s.AbstractSpatialPrefixTreeFieldType 
location_rpt{class=org.apache.solr.schema.SpatialRecursivePrefixTreeFieldType,analyzer=org.apache.solr.schema.FieldType$DefaultAnalyzer,args={geo=true,
 maxDistErr=0.001, distErrPct=0.025, distanceUnits=kilometers, 
class=solr.SpatialRecursivePrefixTreeFieldType}} strat: 
RecursivePrefixTreeStrategy(SPG:(GeohashPrefixTree(maxLevels:11,ctx:SpatialContext{geo=true,
 calculator=Haversine, 
worldBounds=Rect(minX=-180.0,maxX=180.0,minY=-90.0,maxY=90.0)})),pruneLeafyBranches)
 maxLevels: 11
   [junit4]   2> 677161 INFO  (qtp943035213-2788) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.c.ZkShardTerms Successful update terms at 
/collections/org.apache.solr.cloud.TestRandomFlRTGCloud_collection/terms/shard2 
to Terms{values={core_node4=1}, version=1}
   [junit4]   2> 677161 INFO  (qtp943035213-2788) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.u.p.LogUpdateProcessorFactory 
[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[95 
(1594768998290948096)]} 0 78
   [junit4]   2> 677162 INFO  
(TEST-TestRandomFlRTGCloud.testRandomizedUpdatesAndRTGs-seed#[9AE3B2F8A0EB66C1])
 [    ] o.a.s.c.TestRandomFlRTGCloud ADD: 64 = SolrInputDocument(fields: 
[id=64, aaa_i=-1062660679, bbb_i=919161933, ccc_s=dnhwxjxtzz, ddd_s=, 
eee_s=nualjieb, fff_s=vgrxwg, ggg_s=t, hhh_s=nammqendw, geo_1_srpt=POINT( 42 10 
), geo_2_srpt=POINT( 42 -42 ), next_2_ids_ss=[65, 66], axx_i=-798631806, 
ayy_i=929574855, azz_s=qeztshbbu])
   [junit4]   2> 677241 INFO  (qtp1685831004-2803) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[64 
(1594768998380077056)]} 0 77
   [junit4]   2> 677242 INFO  
(TEST-TestRandomFlRTGCloud.testRandomizedUpdatesAndRTGs-seed#[9AE3B2F8A0EB66C1])
 [    ] o.a.s.c.TestRandomFlRTGCloud ADD: 212 = SolrInputDocument(fields: 
[id=212, aaa_i=-121065355, bbb_i=-1433471138, ccc_s=mwmtd, ddd_s=, eee_s=, 
fff_s=w, ggg_s=ixn, hhh_s=ozho, geo_1_srpt=POINT( 42 62 ), geo_2_srpt=POINT( 42 
23 ), next_2_ids_ss=[213, 214], axx_i=-403428656, ayy_i=-370270838, 
azz_s=llilqcxjxl])
   [junit4]   2> 677314 INFO  (qtp1685831004-2799) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[212 
(1594768998506954752)]} 0 51
   [junit4]   2> 677367 INFO  
(TEST-TestRandomFlRTGCloud.testRandomizedUpdatesAndRTGs-seed#[9AE3B2F8A0EB66C1])
 [    ] o.a.s.c.TestRandomFlRTGCloud ADD: 19 = SolrInputDocument(fields: 
[id=19, aaa_i=-1739944540, bbb_i=-63194232, ccc_s=rnphldauat, ddd_s=, 
eee_s=fdgypwmq, fff_s=thnyc, ggg_s=uxbsqo, hhh_s=ht, geo_1_srpt=POINT( 42 -16 
), geo_2_srpt=POINT( 42 23 ), next_2_ids_ss=[20, 21], axx_i=-96820521, 
ayy_i=183928147, azz_s=jgf])
   [junit4]   2> 677456 INFO  (qtp943035213-2787) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.u.p.LogUpdateProcessorFactory 
[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[19 
(1594768998591889408)]} 0 78
   [junit4]   2> 677459 INFO  
(TEST-TestRandomFlRTGCloud.testRandomizedUpdatesAndRTGs-seed#[9AE3B2F8A0EB66C1])
 [    ] o.a.s.c.TestRandomFlRTGCloud UPD: numDocsThisIter=5 
numDocsThisIterThatExist=0, docIds=[7, 197, 22, 2, 16]
   [junit4]   2> 677459 INFO  
(TEST-TestRandomFlRTGCloud.testRandomizedUpdatesAndRTGs-seed#[9AE3B2F8A0EB66C1])
 [    ] o.a.s.c.TestRandomFlRTGCloud ADD: 7 = SolrInputDocument(fields: [id=7, 
aaa_i=-728661000, bbb_i=1693080803, ccc_s=hgftfg, ddd_s=, eee_s=jktc, 
fff_s=dtooetfv, ggg_s=, hhh_s=aq, geo_1_srpt=POINT( 42 -29 ), geo_2_srpt=POINT( 
42 -29 ), next_2_ids_ss=[8, 9], axx_i=-1371097430, ayy_i=-318782211, 
azz_s=fgnfglbc])
   [junit4]   2> 677471 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.u.p.LogUpdateProcessorFactory 
[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[7 
(1594768998688358400)]} 0 11
   [junit4]   2> 677471 INFO  
(TEST-TestRandomFlRTGCloud.testRandomizedUpdatesAndRTGs-seed#[9AE3B2F8A0EB66C1])
 [    ] o.a.s.c.TestRandomFlRTGCloud ADD: 197 = SolrInputDocument(fields: 
[id=197, aaa_i=-2023604387, bbb_i=-257500098, ccc_s=nt, ddd_s=dpdabtnqa, 
eee_s=m, fff_s=q, ggg_s=cku, hhh_s=nurxdmlh, geo_1_srpt=POINT( 42 -29 ), 
geo_2_srpt=POINT( 42 23 ), next_2_ids_ss=[198, 199], axx_i=-172997185, 
ayy_i=-1545265766, azz_s=rqelqvwbte])
   [junit4]   2> 677566 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1]  
webapp=/solr path=/update 
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:42811/solr/org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2/&wt=javabin&version=2}{add=[197
 (1594768998753370112)]} 0 34
   [junit4]   2> 677567 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.u.p.LogUpdateProcessorFactory 
[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[197]} 0 95
   [junit4]   2> 677574 INFO  
(TEST-TestRandomFlRTGCloud.testRandomizedUpdatesAndRTGs-seed#[9AE3B2F8A0EB66C1])
 [    ] o.a.s.c.TestRandomFlRTGCloud ADD: 22 = SolrInputDocument(fields: 
[id=22, aaa_i=-1610306270, bbb_i=-990649613, ccc_s=uznqrlf, ddd_s=f, eee_s=y, 
fff_s=, ggg_s=ria, hhh_s=dwzh, geo_1_srpt=POINT( 42 -29 ), geo_2_srpt=POINT( 42 
-42 ), next_2_ids_ss=[23, 24], axx_i=-1663454279, ayy_i=-2020825415, 
azz_s=acqole])
   [junit4]   2> 677611 INFO  (qtp1930049981-2806) [n:127.0.0.1:36970_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 677658 INFO  (qtp1685831004-2799) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1]  
webapp=/solr path=/update 
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:42811/solr/org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2/&wt=javabin&version=2}{add=[22
 (1594768998884442112)]} 0 1
   [junit4]   2> 677659 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.u.p.LogUpdateProcessorFactory 
[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[22]} 0 3
   [junit4]   2> 677684 INFO  
(TEST-TestRandomFlRTGCloud.testRandomizedUpdatesAndRTGs-seed#[9AE3B2F8A0EB66C1])
 [    ] o.a.s.c.TestRandomFlRTGCloud ADD: 2 = SolrInputDocument(fields: [id=2, 
aaa_i=1357631739, bbb_i=-30079287, ccc_s=bo, ddd_s=guexzwm, eee_s=chb, 
fff_s=ckqg, ggg_s=k, hhh_s=, geo_1_srpt=POINT( 42 -3 ), geo_2_srpt=POINT( 42 36 
), next_2_ids_ss=[3, 4], axx_i=139013357, ayy_i=-23901748, azz_s=jzurzdb])
   [junit4]   2> 677686 INFO  (qtp943035213-2787) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.u.p.LogUpdateProcessorFactory 
[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2 
(1594768998913802240)]} 0 1
   [junit4]   2> 677686 INFO  
(TEST-TestRandomFlRTGCloud.testRandomizedUpdatesAndRTGs-seed#[9AE3B2F8A0EB66C1])
 [    ] o.a.s.c.TestRandomFlRTGCloud ADD: 16 = SolrInputDocument(fields: 
[id=16, aaa_i=1618465881, bbb_i=-738626744, ccc_s=yb, ddd_s=, eee_s=xfldgb, 
fff_s=dp, ggg_s=fa, hhh_s=hv, geo_1_srpt=POINT( 42 62 ), geo_2_srpt=POINT( 42 
36 ), next_2_ids_ss=[17, 18], axx_i=1030168766, ayy_i=1492915235, azz_s=uipc])
   [junit4]   2> 677722 INFO  (qtp1685831004-2801) [n:127.0.0.1:37581_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard1 r:core_node3 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard1_replica_n1]  
webapp=/solr path=/update params={wt=javabin&version=2}{add=[16 
(1594768998951550976)]} 0 1
   [junit4]   2> 677723 INFO  
(TEST-TestRandomFlRTGCloud.testRandomizedUpdatesAndRTGs-seed#[9AE3B2F8A0EB66C1])
 [    ] o.a.s.c.TestRandomFlRTGCloud RTG: numDocsThisIter=4 
numDocsThisIterThatExist=1, docIds=[192, 86, 212, 149]
   [junit4]   2> 677913 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.h.c.RealTimeGetComponent 
LOOKUP_SLICE:shard2=https://127.0.0.1:42811/solr/org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2/
   [junit4]   2> 677913 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.h.c.RealTimeGetComponent 
LOOKUP_SLICE:shard2=https://127.0.0.1:42811/solr/org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2/
   [junit4]   2> 677913 INFO  (qtp943035213-2785) [n:127.0.0.1:42811_solr 
c:org.apache.solr.cloud.TestRandomFlRTGCloud_collection s:shard2 r:core_node4 
x:org.apache.solr.cloud.TestRandomFlRTGCloud_collection_shard2_replica_n2] 
o.a.s.h.c.RealTimeGetComponent 
LOOKUP_SLICE:shard1=https://127.0.0.1:37581/solr/org.apache.s

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

unit4]   2>         at 
org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:1000)
   [junit4]   2>         at 
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1063)
   [junit4]   2>   22) Thread[id=16230, 
name=TEST-BasicDistributedZkTest.test-seed#[9AE3B2F8A0EB66C1]-SendThread(127.0.0.1:36010),
 state=TIMED_WAITING, group=TGRP-BasicDistributedZkTest]
   [junit4]   2>         at java.lang.Thread.sleep(Native Method)
   [junit4]   2>         at 
org.apache.zookeeper.client.StaticHostProvider.next(StaticHostProvider.java:105)
   [junit4]   2>         at 
org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:1000)
   [junit4]   2>         at 
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1063)
   [junit4]   2>   23) Thread[id=16272, name=commitScheduler-4302-thread-1, 
state=WAITING, group=TGRP-BasicDistributedZkTest]
   [junit4]   2>         at sun.misc.Unsafe.park(Native Method)
   [junit4]   2>         at 
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
   [junit4]   2>         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
   [junit4]   2>         at 
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1081)
   [junit4]   2>         at 
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
   [junit4]   2>         at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
   [junit4]   2>         at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
   [junit4]   2>         at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]   2>         at java.lang.Thread.run(Thread.java:748)
   [junit4]   2>   24) Thread[id=16206, name=qtp1785639090-16206, 
state=RUNNABLE, group=TGRP-BasicDistributedZkTest]
   [junit4]   2>         at sun.nio.ch.EPollArrayWrapper.epollWait(Native 
Method)
   [junit4]   2>         at 
sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
   [junit4]   2>         at 
sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93)
   [junit4]   2>         at 
sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
   [junit4]   2>         at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
   [junit4]   2>         at 
sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
   [junit4]   2>         at 
org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:375)
   [junit4]   2>         at 
org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:304)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:179)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:140)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:131)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:382)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
   [junit4]   2>         at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{regex_dup_A_s=PostingsFormat(name=Memory), 
regex_dup_B_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
SubjectTerms_mfacet=PostingsFormat(name=LuceneVarGapFixedInterval), 
multiDefault=PostingsFormat(name=Memory), genre_s=PostingsFormat(name=Memory), 
author_t=PostingsFormat(name=Memory), series_t=PostingsFormat(name=Memory), 
rnd_b=Lucene50(blocksize=128), oddField_s=PostingsFormat(name=Memory), 
a_t=PostingsFormat(name=LuceneVarGapFixedInterval), 
cat=PostingsFormat(name=LuceneVarGapFixedInterval), 
foo_b=PostingsFormat(name=Memory), name=Lucene50(blocksize=128), 
inStock=PostingsFormat(name=Memory), id=Lucene50(blocksize=128), 
text=PostingsFormat(name=Memory)}, 
docValues:{regex_dup_A_s=DocValuesFormat(name=Memory), 
other_tl1=DocValuesFormat(name=Lucene70), 
regex_dup_B_s=DocValuesFormat(name=Lucene70), 
range_facet_l_dv=DocValuesFormat(name=Asserting), 
SubjectTerms_mfacet=DocValuesFormat(name=Lucene70), 
n_l1=DocValuesFormat(name=Lucene70), 
multiDefault=DocValuesFormat(name=Lucene70), 
intDefault=DocValuesFormat(name=Lucene70), 
genre_s=DocValuesFormat(name=Memory), n_td1=DocValuesFormat(name=Lucene70), 
n_d1=DocValuesFormat(name=Lucene70), 
range_facet_l=DocValuesFormat(name=Lucene70), 
n_f1=DocValuesFormat(name=Lucene70), series_t=DocValuesFormat(name=Lucene70), 
n_tl1=DocValuesFormat(name=Lucene70), oddField_s=DocValuesFormat(name=Memory), 
n_tf1=DocValuesFormat(name=Lucene70), price=DocValuesFormat(name=Memory), 
a_t=DocValuesFormat(name=Lucene70), cat=DocValuesFormat(name=Lucene70), 
sequence_i=DocValuesFormat(name=Memory), inStock=DocValuesFormat(name=Memory), 
id=DocValuesFormat(name=Asserting), text=DocValuesFormat(name=Memory), 
intDvoDefault=DocValuesFormat(name=Memory), 
timestamp=DocValuesFormat(name=Lucene70), foo_i=DocValuesFormat(name=Lucene70), 
val_i=DocValuesFormat(name=Asserting), n_dt1=DocValuesFormat(name=Lucene70), 
author_t=DocValuesFormat(name=Lucene70), a_i1=DocValuesFormat(name=Lucene70), 
n_ti1=DocValuesFormat(name=Asserting), rnd_b=DocValuesFormat(name=Asserting), 
_version_=DocValuesFormat(name=Lucene70), 
n_tdt1=DocValuesFormat(name=Lucene70), foo_b=DocValuesFormat(name=Memory), 
name=DocValuesFormat(name=Asserting), id_i1=DocValuesFormat(name=Lucene70), 
foo_d=DocValuesFormat(name=Asserting), 
range_facet_i_dv=DocValuesFormat(name=Lucene70), 
foo_f=DocValuesFormat(name=Memory)}, maxPointsInLeafNode=1849, 
maxMBSortInHeap=6.104455259248984, sim=RandomSimilarity(queryNorm=true): {}, 
locale=pt-BR, timezone=Asia/Pontianak
   [junit4]   2> NOTE: Linux 4.4.0-112-generic amd64/Oracle Corporation 
1.8.0_152 (64-bit)/cpus=4,threads=39,free=338004016,total=528482304
   [junit4]   2> NOTE: All tests run in this JVM: [TestTriggerIntegration, 
TriLevelCompositeIdRoutingTest, TestWriterPerf, TestNoOpRegenerator, 
IndexBasedSpellCheckerTest, TestQuerySenderNoQuery, TestSolrFieldCacheBean, 
SimpleFacetsTest, TestHighFrequencyDictionaryFactory, SolrRequestParserTest, 
TestPhraseSuggestions, TestHashQParserPlugin, TestCloudInspectUtil, 
TestLeaderInitiatedRecoveryThread, TestTolerantUpdateProcessorRandomCloud, 
OpenCloseCoreStressTest, TestReloadDeadlock, TestConfigsApi, 
FullSolrCloudDistribCmdsTest, MetricTriggerTest, TestConfig, 
ScheduledTriggerTest, HdfsDirectoryFactoryTest, DebugComponentTest, 
TestOnReconnectListenerSupport, ExternalFileFieldSortTest, SSLMigrationTest, 
MissingSegmentRecoveryTest, TestCloudNestedDocsSort, 
AutoscalingHistoryHandlerTest, TestConfigSetsAPIZkFailure, 
TestComplexPhraseLeadingWildcard, TestExactStatsCache, TestRestManager, 
TestClusterProperties, TestSortByMinMaxFunction, TestZkAclsWithHadoopAuth, 
TestExclusionRuleCollectionAccess, TestComponentsName, 
TestHighlightDedupGrouping, OutOfBoxZkACLAndCredentialsProvidersTest, 
CurrencyFieldTypeTest, CollectionTooManyReplicasTest, RAMDirectoryFactoryTest, 
BadCopyFieldTest, ExecutePlanActionTest, OpenExchangeRatesOrgProviderTest, 
TestSegmentSorting, TestSkipOverseerOperations, 
CloneFieldUpdateProcessorFactoryTest, TestMaxScoreQueryParser, 
TestGenericDistributedQueue, CdcrRequestHandlerTest, TestBinaryField, 
TestInfoStreamLogging, TokenizerChainTest, SpellingQueryConverterTest, 
TestRebalanceLeaders, TestUseDocValuesAsStored, TestFastOutputStream, 
DocValuesNotIndexedTest, TestIBSimilarityFactory, 
DistributedTermsComponentTest, HdfsBasicDistributedZk2Test, MBeansHandlerTest, 
ConnectionReuseTest, EchoParamsTest, TestCollectionsAPIViaSolrCloudCluster, 
SolrJmxReporterTest, TestExportWriter, TestSchemaVersionResource, 
TestChildDocTransformer, TestSubQueryTransformerDistrib, TestFieldSortValues, 
SolrIndexSplitterTest, DocumentAnalysisRequestHandlerTest, SmileWriterTest, 
TestHashPartitioner, CursorPagingTest, OverseerTaskQueueTest, RuleEngineTest, 
ShardRoutingTest, TestStressLiveNodes, CoreSorterTest, ReplicationFactorTest, 
TestCoreBackup, TestPseudoReturnFields, TestBlendedInfixSuggestions, 
TestIndexSearcher, TestCollationField, UninvertDocValuesMergePolicyTest, 
TestFieldCacheSort, TestScoreJoinQPScore, TestInPlaceUpdatesStandalone, 
TestSystemCollAutoCreate, TestRTimerTree, HdfsWriteToMultipleCollectionsTest, 
SolrGangliaReporterTest, OverseerModifyCollectionTest, TestNumericTerms64, 
TestSolrConfigHandler, SolrPluginUtilsTest, TestRemoteStreaming, 
TestIndexingPerformance, ZkSolrClientTest, DistributedFacetPivotLargeTest, 
TestLegacyField, ParsingFieldUpdateProcessorsTest, UtilsToolTest, 
StatsReloadRaceTest, CollectionStateFormat2Test, DeleteNodeTest, 
ChaosMonkeyNothingIsSafeWithPullReplicasTest, TestComputePlanAction, 
TestPullReplicaErrorHandling, TestConfigOverlay, TestJoin, 
FieldAnalysisRequestHandlerTest, DistributedQueryComponentOptimizationTest, 
PluginInfoTest, TestSolrCloudWithSecureImpersonation, 
TestJavabinTupleStreamParser, TestLuceneMatchVersion, SolrShardReporterTest, 
ChaosMonkeyNothingIsSafeTest, ZkStateReaderTest, InfixSuggestersTest, 
TestExtendedDismaxParser, BasicDistributedZkTest]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=BasicDistributedZkTest -Dtests.seed=9AE3B2F8A0EB66C1 
-Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=pt-BR 
-Dtests.timezone=Asia/Pontianak -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J0 | BasicDistributedZkTest (suite) <<<
   [junit4]    > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 
7200000 msec).
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([9AE3B2F8A0EB66C1]:0)
   [junit4] Completed [783/783 (4!)] on J0 in 7283.68s, 1 test, 2 errors <<< 
FAILURES!

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

Reply via email to