'[JENKINS] Lucene-Solr-Tests-master - Build # 2289 - Still Unstable'

[prev in list] [next in list] [prev in thread] [next in thread] 

List:       lucene-dev
Subject:    [JENKINS] Lucene-Solr-Tests-master - Build # 2289 - Still Unstable
From:       Apache Jenkins Server <jenkins () builds ! apache ! org>
Date:       2018-01-31 19:48:12
Message-ID: 624930041.540.1517428274048.JavaMail.jenkins () jenkins-master ! apache ! org
[Download RAW message or body]

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

7 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.analytics.facet.PivotFacetTest

Error Message:
1 thread leaked from SUITE scope at org.apache.solr.analytics.facet.PivotFacetTest:   \
1) Thread[id=59, name=qtp88290436-59, state=TIMED_WAITING, group=TGRP-PivotFacetTest] \
at sun.misc.Unsafe.park(Native Method)         at \
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)         at \
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163) \
at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308) \
at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373) \
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)   \
at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)    \
at java.lang.Thread.run(Thread.java:748)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope \
at org.apache.solr.analytics.facet.PivotFacetTest:   1) Thread[id=59, \
name=qtp88290436-59, state=TIMED_WAITING, group=TGRP-PivotFacetTest]  at \
                sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
                
        at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
                
        at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
                
        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
                
        at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
  at java.lang.Thread.run(Thread.java:748)
	at __randomizedtesting.SeedInfo.seed([8AC9E657FA81F3EA]:0)


FAILED:  junit.framework.TestSuite.org.apache.solr.analytics.facet.PivotFacetTest

Error Message:
There are still zombie threads that couldn't be terminated:    1) Thread[id=59, \
name=qtp88290436-59, state=TIMED_WAITING, group=TGRP-PivotFacetTest]         at \
sun.misc.Unsafe.park(Native Method)         at \
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)         at \
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163) \
at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308) \
at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373) \
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)   \
at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)    \
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=59, name=qtp88290436-59, \
state=TIMED_WAITING, group=TGRP-PivotFacetTest]  at sun.misc.Unsafe.park(Native \
                Method)
        at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
                
        at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
                
        at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
                
        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
                
        at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
  at java.lang.Thread.run(Thread.java:748)
	at __randomizedtesting.SeedInfo.seed([8AC9E657FA81F3EA]:0)


FAILED:  org.apache.solr.cloud.AliasIntegrationTest.testModifyMetadataCAR

Error Message:


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


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

Error Message:


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


FAILED:  org.apache.solr.cloud.TestTlogReplica.testRecovery

Error Message:
Can not find doc 8 in https://127.0.0.1:40701/solr

Stack Trace:
java.lang.AssertionError: Can not find doc 8 in https://127.0.0.1:40701/solr
	at __randomizedtesting.SeedInfo.seed([443E3E06A86FE42E:85CE47AA853F2E89]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.junit.Assert.assertNotNull(Assert.java:526)
	at org.apache.solr.cloud.TestTlogReplica.checkRTG(TestTlogReplica.java:885)
	at org.apache.solr.cloud.TestTlogReplica.testRecovery(TestTlogReplica.java:599)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
  at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
  at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
  at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
  at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
  at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
  at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
  at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
  at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
  at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
  at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
  at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
  at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
  at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
  at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
  at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
  at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
  at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
  at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
  at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
  at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
  at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
  at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
  at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
  at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
  at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
  at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
  at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
  at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
  at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
  at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
  at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
  at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
  at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
  at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
  at java.lang.Thread.run(Thread.java:748)


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

Error Message:


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


FAILED:  org.apache.solr.cloud.autoscaling.sim.TestLargeCluster.testSearchRate

Error Message:
The trigger did not fire at all

Stack Trace:
java.lang.AssertionError: The trigger did not fire at all
	at __randomizedtesting.SeedInfo.seed([443E3E06A86FE42E:1976208F67A94261]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.apache.solr.cloud.autoscaling.sim.TestLargeCluster.testSearchRate(TestLargeCluster.java:547)
  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)




Build Log:
[...truncated 12356 lines...]
   [junit4] Suite: org.apache.solr.cloud.TestUtilizeNode
   [junit4]   2> 1357131 INFO  (SUITE-TestUtilizeNode-seed#[443E3E06A86FE42E]-worker) \
[    ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: \
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom  [junit4] \
2> Creating dataDir: \
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestUtilizeNode_443E3E06A86FE42E-001/init-core-data-001
  [junit4]   2> 1357132 WARN  (SUITE-TestUtilizeNode-seed#[443E3E06A86FE42E]-worker) \
[    ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=7 numCloses=7  [junit4]  \
2> 1357132 INFO  (SUITE-TestUtilizeNode-seed#[443E3E06A86FE42E]-worker) [    ] \
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) \
w/NUMERIC_DOCVALUES_SYSPROP=false  [junit4]   2> 1357150 INFO  \
(SUITE-TestUtilizeNode-seed#[443E3E06A86FE42E]-worker) [    ] o.a.s.SolrTestCaseJ4 \
Randomized ssl (true) and clientAuth (true) via: \
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)  \
[junit4]   2> 1357153 INFO  (SUITE-TestUtilizeNode-seed#[443E3E06A86FE42E]-worker) [  \
] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in \
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestUtilizeNode_443E3E06A86FE42E-001/tempDir-001
  [junit4]   2> 1357153 INFO  (SUITE-TestUtilizeNode-seed#[443E3E06A86FE42E]-worker) \
[    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER  [junit4]   2> 1357153 INFO  \
(Thread-1424) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0  [junit4]   \
2> 1357153 INFO  (Thread-1424) [    ] o.a.s.c.ZkTestServer Starting server  [junit4]  \
2> 1357180 ERROR (Thread-1424) [    ] 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> 1357263 INFO  \
(SUITE-TestUtilizeNode-seed#[443E3E06A86FE42E]-worker) [    ] o.a.s.c.ZkTestServer \
start zk server on port:34270  [junit4]   2> 1357265 INFO  \
(zkConnectionManagerCallback-1283-thread-1) [    ] o.a.s.c.c.ConnectionManager \
zkClient has connected  [junit4]   2> 1357290 INFO  (jetty-launcher-1280-thread-1) [  \
] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T12:27:37-09:00, \
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8  [junit4]   2> 1357292 INFO  \
(jetty-launcher-1280-thread-2) [    ] o.e.j.s.Server jetty-9.4.8.v20171121, build \
timestamp: 2017-11-21T12:27:37-09:00, git hash: \
82b8fb23f757335bb3329d540ce37a2a2615f0a8  [junit4]   2> 1357293 INFO  \
(jetty-launcher-1280-thread-3) [    ] o.e.j.s.Server jetty-9.4.8.v20171121, build \
timestamp: 2017-11-21T12:27:37-09:00, git hash: \
82b8fb23f757335bb3329d540ce37a2a2615f0a8  [junit4]   2> 1357317 INFO  \
(jetty-launcher-1280-thread-4) [    ] o.e.j.s.Server jetty-9.4.8.v20171121, build \
timestamp: 2017-11-21T12:27:37-09:00, git hash: \
82b8fb23f757335bb3329d540ce37a2a2615f0a8  [junit4]   2> 1357375 INFO  \
(jetty-launcher-1280-thread-2) [    ] o.e.j.s.session DefaultSessionIdManager \
workerName=node0  [junit4]   2> 1357375 INFO  (jetty-launcher-1280-thread-2) [    ] \
o.e.j.s.session No SessionScavenger set, using defaults  [junit4]   2> 1357375 INFO  \
(jetty-launcher-1280-thread-2) [    ] o.e.j.s.session Scavenging every 600000ms  \
[junit4]   2> 1357375 INFO  (jetty-launcher-1280-thread-2) [    ] \
o.e.j.s.h.ContextHandler Started \
o.e.j.s.ServletContextHandler@5281c44b{/solr,null,AVAILABLE}  [junit4]   2> 1357376 \
INFO  (jetty-launcher-1280-thread-2) [    ] o.e.j.s.AbstractConnector Started \
ServerConnector@79533218{SSL,[ssl, http/1.1]}{127.0.0.1:38684}  [junit4]   2> 1357376 \
INFO  (jetty-launcher-1280-thread-2) [    ] o.e.j.s.Server Started @1362122ms  \
[junit4]   2> 1357376 INFO  (jetty-launcher-1280-thread-2) [    ] \
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=38684}  \
[junit4]   2> 1357376 ERROR (jetty-launcher-1280-thread-2) [    ] \
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing \
or incomplete.  [junit4]   2> 1357376 INFO  (jetty-launcher-1280-thread-2) [    ] \
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.0.0  \
[junit4]   2> 1357376 INFO  (jetty-launcher-1280-thread-2) [    ] \
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null  \
[junit4]   2> 1357376 INFO  (jetty-launcher-1280-thread-2) [    ] \
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null  [junit4]   2> 1357377 \
INFO  (jetty-launcher-1280-thread-2) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| \
Start time: 2018-01-31T18:27:44.923Z  [junit4]   2> 1357498 INFO  \
(jetty-launcher-1280-thread-4) [    ] o.e.j.s.session DefaultSessionIdManager \
workerName=node0  [junit4]   2> 1357498 INFO  (jetty-launcher-1280-thread-4) [    ] \
o.e.j.s.session No SessionScavenger set, using defaults  [junit4]   2> 1357498 INFO  \
(jetty-launcher-1280-thread-4) [    ] o.e.j.s.session Scavenging every 660000ms  \
[junit4]   2> 1357498 INFO  (jetty-launcher-1280-thread-4) [    ] \
o.e.j.s.h.ContextHandler Started \
o.e.j.s.ServletContextHandler@1d389fc3{/solr,null,AVAILABLE}  [junit4]   2> 1357499 \
INFO  (jetty-launcher-1280-thread-4) [    ] o.e.j.s.AbstractConnector Started \
ServerConnector@5cbc57c5{SSL,[ssl, http/1.1]}{127.0.0.1:33988}  [junit4]   2> 1357499 \
INFO  (jetty-launcher-1280-thread-4) [    ] o.e.j.s.Server Started @1362245ms  \
[junit4]   2> 1357499 INFO  (jetty-launcher-1280-thread-4) [    ] \
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=33988}  \
[junit4]   2> 1357499 ERROR (jetty-launcher-1280-thread-4) [    ] \
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing \
or incomplete.  [junit4]   2> 1357499 INFO  (jetty-launcher-1280-thread-4) [    ] \
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.0.0  \
[junit4]   2> 1357499 INFO  (jetty-launcher-1280-thread-4) [    ] \
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null  \
[junit4]   2> 1357499 INFO  (jetty-launcher-1280-thread-4) [    ] \
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null  [junit4]   2> 1357499 \
INFO  (jetty-launcher-1280-thread-4) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| \
Start time: 2018-01-31T18:27:45.045Z  [junit4]   2> 1357501 INFO  \
(jetty-launcher-1280-thread-3) [    ] o.e.j.s.session DefaultSessionIdManager \
workerName=node0  [junit4]   2> 1357501 INFO  (jetty-launcher-1280-thread-3) [    ] \
o.e.j.s.session No SessionScavenger set, using defaults  [junit4]   2> 1357501 INFO  \
(jetty-launcher-1280-thread-3) [    ] o.e.j.s.session Scavenging every 600000ms  \
[junit4]   2> 1357501 INFO  (jetty-launcher-1280-thread-3) [    ] \
o.e.j.s.h.ContextHandler Started \
o.e.j.s.ServletContextHandler@5066a5b2{/solr,null,AVAILABLE}  [junit4]   2> 1357501 \
INFO  (jetty-launcher-1280-thread-3) [    ] o.e.j.s.AbstractConnector Started \
ServerConnector@9010263{SSL,[ssl, http/1.1]}{127.0.0.1:46485}  [junit4]   2> 1357501 \
INFO  (jetty-launcher-1280-thread-3) [    ] o.e.j.s.Server Started @1362247ms  \
[junit4]   2> 1357501 INFO  (jetty-launcher-1280-thread-3) [    ] \
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=46485}  \
[junit4]   2> 1357501 ERROR (jetty-launcher-1280-thread-3) [    ] \
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing \
or incomplete.  [junit4]   2> 1357501 INFO  (jetty-launcher-1280-thread-3) [    ] \
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.0.0  \
[junit4]   2> 1357501 INFO  (jetty-launcher-1280-thread-3) [    ] \
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null  \
[junit4]   2> 1357501 INFO  (jetty-launcher-1280-thread-3) [    ] \
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null  [junit4]   2> 1357502 \
INFO  (jetty-launcher-1280-thread-3) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| \
Start time: 2018-01-31T18:27:45.048Z  [junit4]   2> 1357607 INFO  \
(jetty-launcher-1280-thread-1) [    ] o.e.j.s.session DefaultSessionIdManager \
workerName=node0  [junit4]   2> 1357607 INFO  (jetty-launcher-1280-thread-1) [    ] \
o.e.j.s.session No SessionScavenger set, using defaults  [junit4]   2> 1357608 INFO  \
(jetty-launcher-1280-thread-1) [    ] o.e.j.s.session Scavenging every 600000ms  \
[junit4]   2> 1357608 INFO  (jetty-launcher-1280-thread-1) [    ] \
o.e.j.s.h.ContextHandler Started \
o.e.j.s.ServletContextHandler@6fb400e1{/solr,null,AVAILABLE}  [junit4]   2> 1357608 \
INFO  (jetty-launcher-1280-thread-1) [    ] o.e.j.s.AbstractConnector Started \
ServerConnector@140a9e0b{SSL,[ssl, http/1.1]}{127.0.0.1:34167}  [junit4]   2> 1357608 \
INFO  (jetty-launcher-1280-thread-1) [    ] o.e.j.s.Server Started @1362354ms  \
[junit4]   2> 1357608 INFO  (jetty-launcher-1280-thread-1) [    ] \
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34167}  \
[junit4]   2> 1357609 ERROR (jetty-launcher-1280-thread-1) [    ] \
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing \
or incomplete.  [junit4]   2> 1357609 INFO  (jetty-launcher-1280-thread-1) [    ] \
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.0.0  \
[junit4]   2> 1357609 INFO  (jetty-launcher-1280-thread-1) [    ] \
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null  \
[junit4]   2> 1357609 INFO  (jetty-launcher-1280-thread-1) [    ] \
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null  [junit4]   2> 1357609 \
INFO  (jetty-launcher-1280-thread-1) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| \
Start time: 2018-01-31T18:27:45.155Z  [junit4]   2> 1357625 INFO  \
(zkConnectionManagerCallback-1287-thread-1) [    ] o.a.s.c.c.ConnectionManager \
zkClient has connected  [junit4]   2> 1357625 INFO  \
(zkConnectionManagerCallback-1289-thread-1) [    ] o.a.s.c.c.ConnectionManager \
zkClient has connected  [junit4]   2> 1357625 INFO  \
(zkConnectionManagerCallback-1285-thread-1) [    ] o.a.s.c.c.ConnectionManager \
zkClient has connected  [junit4]   2> 1357628 INFO  \
(zkConnectionManagerCallback-1291-thread-1) [    ] o.a.s.c.c.ConnectionManager \
zkClient has connected  [junit4]   2> 1357629 INFO  (jetty-launcher-1280-thread-1) [  \
] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...  [junit4]   2> \
1357629 INFO  (jetty-launcher-1280-thread-4) [    ] o.a.s.s.SolrDispatchFilter \
solr.xml found in ZooKeeper. Loading...  [junit4]   2> 1357639 INFO  \
(jetty-launcher-1280-thread-2) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in \
ZooKeeper. Loading...  [junit4]   2> 1357643 INFO  (jetty-launcher-1280-thread-3) [   \
] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...  [junit4]   2> \
1357717 INFO  (jetty-launcher-1280-thread-4) [    ] o.a.s.c.ZkContainer Zookeeper \
client=127.0.0.1:34270/solr  [junit4]   2> 1357719 INFO  \
(jetty-launcher-1280-thread-3) [    ] o.a.s.c.ZkContainer Zookeeper \
client=127.0.0.1:34270/solr  [junit4]   2> 1357802 INFO  \
(jetty-launcher-1280-thread-2) [    ] o.a.s.c.ZkContainer Zookeeper \
client=127.0.0.1:34270/solr  [junit4]   2> 1357878 INFO  \
(zkConnectionManagerCallback-1301-thread-1) [    ] o.a.s.c.c.ConnectionManager \
zkClient has connected  [junit4]   2> 1357894 INFO  (jetty-launcher-1280-thread-1) [  \
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34270/solr  [junit4]   2> 1357895 \
INFO  (zkConnectionManagerCallback-1295-thread-1) [    ] o.a.s.c.c.ConnectionManager \
zkClient has connected  [junit4]   2> 1357912 INFO  \
(zkConnectionManagerCallback-1305-thread-1) [    ] o.a.s.c.c.ConnectionManager \
zkClient has connected  [junit4]   2> 1357913 INFO  \
(zkConnectionManagerCallback-1309-thread-1-processing-n:127.0.0.1:46485_solr) \
[n:127.0.0.1:46485_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected  \
[junit4]   2> 1357915 INFO  (zkConnectionManagerCallback-1307-thread-1) [    ] \
o.a.s.c.c.ConnectionManager zkClient has connected  [junit4]   2> 1357947 INFO  \
(zkConnectionManagerCallback-1311-thread-1-processing-n:127.0.0.1:38684_solr) \
[n:127.0.0.1:38684_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected  \
[junit4]   2> 1357974 INFO  \
(zkConnectionManagerCallback-1314-thread-1-processing-n:127.0.0.1:34167_solr) \
[n:127.0.0.1:34167_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected  \
[junit4]   2> 1358001 INFO  \
(zkConnectionManagerCallback-1316-thread-1-processing-n:127.0.0.1:33988_solr) \
[n:127.0.0.1:33988_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected  \
[junit4]   2> 1358101 INFO  (jetty-launcher-1280-thread-2) [n:127.0.0.1:38684_solr    \
] o.a.s.c.Overseer Overseer (id=null) closing  [junit4]   2> 1358154 INFO  \
(jetty-launcher-1280-thread-2) [n:127.0.0.1:38684_solr    ] \
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:38684_solr  \
[junit4]   2> 1358156 INFO  (jetty-launcher-1280-thread-2) [n:127.0.0.1:38684_solr    \
] o.a.s.c.Overseer Overseer (id=72180644216438794-127.0.0.1:38684_solr-n_0000000000) \
starting  [junit4]   2> 1358223 INFO  (jetty-launcher-1280-thread-2) \
[n:127.0.0.1:38684_solr    ] o.a.s.c.ZkController Register node as live in \
ZooKeeper:/live_nodes/127.0.0.1:38684_solr  [junit4]   2> 1358261 INFO  \
(OverseerStateUpdate-72180644216438794-127.0.0.1:38684_solr-n_0000000000) \
[n:127.0.0.1:38684_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from \
ZooKeeper... (0) -> (1)  [junit4]   2> 1358682 INFO  (jetty-launcher-1280-thread-1) \
[n:127.0.0.1:34167_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from \
ZooKeeper... (0) -> (1)  [junit4]   2> 1358683 INFO  (jetty-launcher-1280-thread-1) \
[n:127.0.0.1:34167_solr    ] o.a.s.c.Overseer Overseer (id=null) closing  [junit4]   \
2> 1358684 INFO  (jetty-launcher-1280-thread-1) [n:127.0.0.1:34167_solr    ] \
o.a.s.c.ZkController Register node as live in \
ZooKeeper:/live_nodes/127.0.0.1:34167_solr  [junit4]   2> 1358774 INFO  \
(zkCallback-1313-thread-1-processing-n:127.0.0.1:34167_solr) [n:127.0.0.1:34167_solr  \
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)  [junit4]   \
2> 1358839 INFO  (jetty-launcher-1280-thread-2) [n:127.0.0.1:38684_solr    ] \
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38684.solr.node' (registry \
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2c2f94ce  \
[junit4]   2> 1358891 INFO  \
(zkCallback-1310-thread-1-processing-n:127.0.0.1:38684_solr) [n:127.0.0.1:38684_solr  \
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)  [junit4]   \
2> 1358895 INFO  (jetty-launcher-1280-thread-2) [n:127.0.0.1:38684_solr    ] \
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38684.solr.jvm' (registry \
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2c2f94ce  \
[junit4]   2> 1358895 INFO  (jetty-launcher-1280-thread-2) [n:127.0.0.1:38684_solr    \
] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38684.solr.jetty' (registry \
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2c2f94ce  \
[junit4]   2> 1358922 INFO  (jetty-launcher-1280-thread-2) [n:127.0.0.1:38684_solr    \
] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath \
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestUtilizeNode_443E3E06A86FE42E-001/tempDir-001/node2/.
  [junit4]   2> 1359069 INFO  (jetty-launcher-1280-thread-1) [n:127.0.0.1:34167_solr  \
] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34167.solr.node' (registry \
   [junit4]   2> 1359120 INFO  (jetty-launcher-1280-thread-1) [n:127.0.0.1:34167_solr \
] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34167.solr.jetty' (registry \
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2c2f94ce  \
[junit4]   2> 1359121 INFO  (jetty-launcher-1280-thread-1) [n:127.0.0.1:34167_solr    \
] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath \
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestUtilizeNode_443E3E06A86FE42E-001/tempDir-001/node1/.
  [junit4]   2> 1359138 INFO  (jetty-launcher-1280-thread-3) [n:127.0.0.1:46485_solr  \
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)  [junit4]   \
2> 1359154 INFO  (jetty-launcher-1280-thread-3) [n:127.0.0.1:46485_solr    ] \
o.a.s.c.Overseer Overseer (id=null) closing  [junit4]   2> 1359156 INFO  \
(jetty-launcher-1280-thread-3) [n:127.0.0.1:46485_solr    ] o.a.s.c.ZkController \
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46485_solr  [junit4]   2> \
1359174 INFO  (zkCallback-1313-thread-1-processing-n:127.0.0.1:34167_solr) \
[n:127.0.0.1:34167_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from \
ZooKeeper... (2) -> (3)  [junit4]   2> 1359175 INFO  \
(zkCallback-1310-thread-1-processing-n:127.0.0.1:38684_solr) [n:127.0.0.1:38684_solr  \
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)  [junit4]   \
2> 1359248 INFO  (zkCallback-1308-thread-1-processing-n:127.0.0.1:46485_solr) \
[n:127.0.0.1:46485_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from \
ZooKeeper... (2) -> (3)  [junit4]   2> 1359480 INFO  (jetty-launcher-1280-thread-3) \
[n:127.0.0.1:46485_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for \
'solr_46485.solr.node' (registry 'solr.node') enabled at server: \
com.sun.jmx.mbeanserver.JmxMBeanServer@2c2f94ce  [junit4]   2> 1359504 INFO  \
(jetty-launcher-1280-thread-4) [n:127.0.0.1:33988_solr    ] o.a.s.c.c.ZkStateReader \
Updated live nodes from ZooKeeper... (0) -> (3)  [junit4]   2> 1359505 INFO  \
(jetty-launcher-1280-thread-4) [n:127.0.0.1:33988_solr    ] o.a.s.c.Overseer Overseer \
(id=null) closing  [junit4]   2> 1359506 INFO  (jetty-launcher-1280-thread-4) \
[n:127.0.0.1:33988_solr    ] o.a.s.c.ZkController Register node as live in \
ZooKeeper:/live_nodes/127.0.0.1:33988_solr  [junit4]   2> 1359532 INFO  \
(jetty-launcher-1280-thread-3) [n:127.0.0.1:46485_solr    ] o.a.s.m.r.SolrJmxReporter \
JMX monitoring for 'solr_46485.solr.jvm' (registry 'solr.jvm') enabled at server: \
com.sun.jmx.mbeanserver.JmxMBeanServer@2c2f94ce  [junit4]   2> 1359532 INFO  \
(jetty-launcher-1280-thread-3) [n:127.0.0.1:46485_solr    ] o.a.s.m.r.SolrJmxReporter \
JMX monitoring for 'solr_46485.solr.jetty' (registry 'solr.jetty') enabled at server: \
com.sun.jmx.mbeanserver.JmxMBeanServer@2c2f94ce  [junit4]   2> 1359533 INFO  \
(jetty-launcher-1280-thread-3) [n:127.0.0.1:46485_solr    ] \
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath \
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestUtilizeNode_443E3E06A86FE42E-001/tempDir-001/node3/.
  [junit4]   2> 1359560 INFO  \
(zkCallback-1310-thread-2-processing-n:127.0.0.1:38684_solr) [n:127.0.0.1:38684_solr  \
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)  [junit4]   \
2> 1359571 INFO  (zkCallback-1313-thread-1-processing-n:127.0.0.1:34167_solr) \
[n:127.0.0.1:34167_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from \
ZooKeeper... (3) -> (4)  [junit4]   2> 1359561 INFO  \
(zkCallback-1315-thread-1-processing-n:127.0.0.1:33988_solr) [n:127.0.0.1:33988_solr  \
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)  [junit4]   \
2> 1359596 INFO  (zkCallback-1308-thread-1-processing-n:127.0.0.1:46485_solr) \
[n:127.0.0.1:46485_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from \
ZooKeeper... (3) -> (4)  [junit4]   2> 1359806 INFO  (jetty-launcher-1280-thread-4) \
[n:127.0.0.1:33988_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for \
'solr_33988.solr.node' (registry 'solr.node') enabled at server: \
com.sun.jmx.mbeanserver.JmxMBeanServer@2c2f94ce  [junit4]   2> 1359840 INFO  \
(jetty-launcher-1280-thread-4) [n:127.0.0.1:33988_solr    ] o.a.s.m.r.SolrJmxReporter \
JMX monitoring for 'solr_33988.solr.jvm' (registry 'solr.jvm') enabled at server: \
com.sun.jmx.mbeanserver.JmxMBeanServer@2c2f94ce  [junit4]   2> 1359841 INFO  \
(jetty-launcher-1280-thread-4) [n:127.0.0.1:33988_solr    ] o.a.s.m.r.SolrJmxReporter \
JMX monitoring for 'solr_33988.solr.jetty' (registry 'solr.jetty') enabled at server: \
com.sun.jmx.mbeanserver.JmxMBeanServer@2c2f94ce  [junit4]   2> 1359841 INFO  \
(jetty-launcher-1280-thread-4) [n:127.0.0.1:33988_solr    ] \
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath \
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.TestUtilizeNode_443E3E06A86FE42E-001/tempDir-001/node4/.
  [junit4]   2> 1359996 INFO  (zkConnectionManagerCallback-1325-thread-1) [    ] \
o.a.s.c.c.ConnectionManager zkClient has connected  [junit4]   2> 1360007 INFO  \
(zkConnectionManagerCallback-1329-thread-1) [    ] o.a.s.c.c.ConnectionManager \
zkClient has connected  [junit4]   2> 1360007 INFO  \
(SUITE-TestUtilizeNode-seed#[443E3E06A86FE42E]-worker) [    ] o.a.s.c.c.ZkStateReader \
Updated live nodes from ZooKeeper... (0) -> (4)  [junit4]   2> 1360008 INFO  \
(SUITE-TestUtilizeNode-seed#[443E3E06A86FE42E]-worker) [    ] \
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34270/solr ready  \
[junit4]   2> 1360134 INFO  (qtp2076910093-6540) [n:127.0.0.1:34167_solr    ] \
o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with params \
action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true  [junit4]   2> \
1360152 INFO  (qtp2076910093-6540) [n:127.0.0.1:34167_solr    ] o.a.s.s.HttpSolrCall \
[admin] webapp=null path=/admin/collections \
params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=18  [junit4]   2> \
1360250 INFO  (TEST-TestUtilizeNode.test-seed#[443E3E06A86FE42E]) [    ] \
o.a.s.SolrTestCaseJ4 ###Starting test  [junit4]   2> 1360273 INFO  \
(TEST-TestUtilizeNode.test-seed#[443E3E06A86FE42E]) [    ] o.a.s.c.c.ZkStateReader \
Updated live nodes from ZooKeeper... (0) -> (4)  [junit4]   2> 1360290 INFO  \
(zkConnectionManagerCallback-1332-thread-1) [    ] o.a.s.c.c.ConnectionManager \
zkClient has connected  [junit4]   2> 1360313 INFO  (qtp2076910093-6543) \
[n:127.0.0.1:34167_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action \
:create with params replicationFactor=2&collection.configName=conf1&name=utilizenodecoll&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2 \
and sendToOCPQueue=true  [junit4]   2> 1360318 INFO  \
(OverseerThreadFactory-3141-thread-2-processing-n:127.0.0.1:38684_solr) \
[n:127.0.0.1:38684_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection \
utilizenodecoll  [junit4]   2> 1360318 INFO  \
(OverseerCollectionConfigSetProcessor-72180644216438794-127.0.0.1:38684_solr-n_0000000000) \
[n:127.0.0.1:38684_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> 1360522 INFO  \
(OverseerStateUpdate-72180644216438794-127.0.0.1:38684_solr-n_0000000000) \
[n:127.0.0.1:38684_solr    ] o.a.s.c.o.SliceMutator createReplica() {  [junit4]   2>  \
"operation":"ADDREPLICA",  [junit4]   2>   "collection":"utilizenodecoll",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"utilizenodecoll_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:34167/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1360549 INFO  \
(OverseerStateUpdate-72180644216438794-127.0.0.1:38684_solr-n_0000000000) \
[n:127.0.0.1:38684_solr    ] o.a.s.c.o.SliceMutator createReplica() {  [junit4]   2>  \
"operation":"ADDREPLICA",  [junit4]   2>   "collection":"utilizenodecoll",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"utilizenodecoll_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:46485/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1360551 INFO  \
(OverseerStateUpdate-72180644216438794-127.0.0.1:38684_solr-n_0000000000) \
[n:127.0.0.1:38684_solr    ] o.a.s.c.o.SliceMutator createReplica() {  [junit4]   2>  \
"operation":"ADDREPLICA",  [junit4]   2>   "collection":"utilizenodecoll",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"utilizenodecoll_shard2_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:38684/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1360617 INFO  \
(OverseerStateUpdate-72180644216438794-127.0.0.1:38684_solr-n_0000000000) \
[n:127.0.0.1:38684_solr    ] o.a.s.c.o.SliceMutator createReplica() {  [junit4]   2>  \
"operation":"ADDREPLICA",  [junit4]   2>   "collection":"utilizenodecoll",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"utilizenodecoll_shard2_replica_n6",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:33988/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1361229 INFO  (qtp2076910093-6542) [n:127.0.0.1:34167_solr    ] \
o.a.s.h.a.CoreAdminOperation core create command \
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf1&newCollection=true \
&name=utilizenodecoll_shard1_replica_n1&action=CREATE&numShards=2&collection=utilizenodecoll&shard=shard1&wt=javabin&version=2&replicaType=NRT
  [junit4]   2> 1361230 INFO  (qtp2076910093-6542) [n:127.0.0.1:34167_solr    ] \
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 \
transient cores  [junit4]   2> 1361536 INFO  (qtp1562974966-6520) \
[n:127.0.0.1:33988_solr    ] o.a.s.h.a.CoreAdminOperation core create command \
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true \
&name=utilizenodecoll_shard2_replica_n6&action=CREATE&numShards=2&collection=utilizenodecoll&shard=shard2&wt=javabin&version=2&replicaType=NRT
  [junit4]   2> 1361536 INFO  (qtp156119322-6530) [n:127.0.0.1:46485_solr    ] \
o.a.s.h.a.CoreAdminOperation core create command \
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf1&newCollection=true \
&name=utilizenodecoll_shard1_replica_n2&action=CREATE&numShards=2&collection=utilizenodecoll&shard=shard1&wt=javabin&version=2&replicaType=NRT
  [junit4]   2> 1361537 INFO  (qtp1562974966-6520) [n:127.0.0.1:33988_solr    ] \
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 \
transient cores  [junit4]   2> 1361537 INFO  (qtp156119322-6530) \
[n:127.0.0.1:46485_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating \
transient cache for 2147483647 transient cores  [junit4]   2> 1361548 INFO  \
(zkCallback-1313-thread-1-processing-n:127.0.0.1:34167_solr) [n:127.0.0.1:34167_solr  \
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected \
type:NodeDataChanged path:/collections/utilizenodecoll/state.json] for collection \
[utilizenodecoll] has occurred - updating... (live nodes size: [4])  [junit4]   2> \
1361569 INFO  (zkCallback-1313-thread-2-processing-n:127.0.0.1:34167_solr) \
[n:127.0.0.1:34167_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: \
[WatchedEvent state:SyncConnected type:NodeDataChanged \
path:/collections/utilizenodecoll/state.json] for collection [utilizenodecoll] has \
occurred - updating... (live nodes size: [4])  [junit4]   2> 1361739 INFO  \
(qtp1062719361-6515) [n:127.0.0.1:38684_solr    ] o.a.s.h.a.CoreAdminOperation core \
create command qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&new \
Collection=true&name=utilizenodecoll_shard2_replica_n4&action=CREATE&numShards=2&collection=utilizenodecoll&shard=shard2&wt=javabin&version=2&replicaType=NRT
  [junit4]   2> 1361739 INFO  (qtp1062719361-6515) [n:127.0.0.1:38684_solr    ] \
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 \
transient cores  [junit4]   2> 1362002 INFO  \
(zkCallback-1313-thread-2-processing-n:127.0.0.1:34167_solr) [n:127.0.0.1:34167_solr  \
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected \
type:NodeDataChanged path:/collections/utilizenodecoll/state.json] for collection \
[utilizenodecoll] has occurred - updating... (live nodes size: [4])  [junit4]   2> \
1362002 INFO  (zkCallback-1313-thread-1-processing-n:127.0.0.1:34167_solr) \
[n:127.0.0.1:34167_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: \
[WatchedEvent state:SyncConnected type:NodeDataChanged \
path:/collections/utilizenodecoll/state.json] for collection [utilizenodecoll] has \
occurred - updating... (live nodes size: [4])  [junit4]   2> 1362015 INFO  \
(zkCallback-1310-thread-2-processing-n:127.0.0.1:38684_solr) [n:127.0.0.1:38684_solr  \
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected \
type:NodeDataChanged path:/collections/utilizenodecoll/state.json] for collection \
[utilizenodecoll] has occurred - updating... (live nodes size: [4])  [junit4]   2> \
1362022 INFO  (zkCallback-1310-thread-1-processing-n:127.0.0.1:38684_solr) \
[n:127.0.0.1:38684_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: \
[WatchedEvent state:SyncConnected type:NodeDataChanged \
path:/collections/utilizenodecoll/state.json] for collection [utilizenodecoll] has \
occurred - updating... (live nodes size: [4])  [junit4]   2> 1362023 INFO  \
(zkCallback-1308-thread-1-processing-n:127.0.0.1:46485_solr) [n:127.0.0.1:46485_solr  \
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected \
type:NodeDataChanged path:/collections/utilizenodecoll/state.json] for collection \
[utilizenodecoll] has occurred - updating... (live nodes size: [4])  [junit4]   2> \
1362023 INFO  (zkCallback-1315-thread-1-processing-n:127.0.0.1:33988_solr) \
[n:127.0.0.1:33988_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: \
[WatchedEvent state:SyncConnected type:NodeDataChanged \
path:/collections/utilizenodecoll/state.json] for collection [utilizenodecoll] has \
occurred - updating... (live nodes size: [4])  [junit4]   2> 1362023 INFO  \
(zkCallback-1308-thread-2-processing-n:127.0.0.1:46485_solr) [n:127.0.0.1:46485_solr  \
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected \
type:NodeDataChanged path:/collections/utilizenodecoll/state.json] for collection \
[utilizenodecoll] has occurred - updating... (live nodes size: [4])  [junit4]   2> \
1362023 INFO  (zkCallback-1315-thread-2-processing-n:127.0.0.1:33988_solr) \
[n:127.0.0.1:33988_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: \
[WatchedEvent state:SyncConnected type:NodeDataChanged \
path:/collections/utilizenodecoll/state.json] for collection [utilizenodecoll] has \
occurred - updating... (live nodes size: [4])  [junit4]   2> 1362616 INFO  \
(qtp2076910093-6542) [n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 r:core_node3 \
x:utilizenodecoll_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: \
8.0.0  [junit4]   2> 1362697 INFO  (qtp2076910093-6542) [n:127.0.0.1:34167_solr \
c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1] \
o.a.s.s.IndexSchema [utilizenodecoll_shard1_replica_n1] Schema name=cloud-dynamic  \
[junit4]   2> 1362944 INFO  (qtp1562974966-6520) [n:127.0.0.1:33988_solr \
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n6] \
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0  [junit4]   2> 1362997 INFO  \
(qtp156119322-6530) [n:127.0.0.1:46485_solr c:utilizenodecoll s:shard1 r:core_node5 \
x:utilizenodecoll_shard1_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: \
8.0.0  [junit4]   2> 1363013 INFO  (qtp2076910093-6542) [n:127.0.0.1:34167_solr \
c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1] \
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id  [junit4]  \
2> 1363013 INFO  (qtp2076910093-6542) [n:127.0.0.1:34167_solr c:utilizenodecoll \
s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1] o.a.s.c.CoreContainer \
Creating SolrCore 'utilizenodecoll_shard1_replica_n1' using configuration from \
collection utilizenodecoll, trusted=true  [junit4]   2> 1363014 INFO  \
(qtp2076910093-6542) [n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 r:core_node3 \
x:utilizenodecoll_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for \
'solr_34167.solr.core.utilizenodecoll.shard1.replica_n1' (registry \
'solr.core.utilizenodecoll.shard1.replica_n1') enabled at server: \
com.sun.jmx.mbeanserver.JmxMBeanServer@2c2f94ce  [junit4]   2> 1363014 INFO  \
(qtp2076910093-6542) [n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 r:core_node3 \
x:utilizenodecoll_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder  \
[junit4]   2> 1363014 INFO  (qtp2076910093-6542) [n:127.0.0.1:34167_solr \
c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1] \
o.a.s.c.SolrCore [[utilizenodecoll_shard1_replica_n1] ] Opening new SolrCore at \
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/t \
est/J0/temp/solr.cloud.TestUtilizeNode_443E3E06A86FE42E-001/tempDir-001/node1/utilizenodecoll_shard1_replica_n1], \
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/sol \
r-core/test/J0/temp/solr.cloud.TestUtilizeNode_443E3E06A86FE42E-001/tempDir-001/node1/./utilizenodecoll_shard1_replica_n1/data/]
  [junit4]   2> 1363047 INFO  (qtp1062719361-6515) [n:127.0.0.1:38684_solr \
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4] \
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0  [junit4]   2> 1363199 INFO  \
(qtp156119322-6530) [n:127.0.0.1:46485_solr c:utilizenodecoll s:shard1 r:core_node5 \
x:utilizenodecoll_shard1_replica_n2] o.a.s.s.IndexSchema \
[utilizenodecoll_shard1_replica_n2] Schema name=cloud-dynamic  [junit4]   2> 1363199 \
INFO  (qtp1062719361-6515) [n:127.0.0.1:38684_solr c:utilizenodecoll s:shard2 \
r:core_node7 x:utilizenodecoll_shard2_replica_n4] o.a.s.s.IndexSchema \
[utilizenodecoll_shard2_replica_n4] Schema name=cloud-dynamic  [junit4]   2> 1363215 \
INFO  (qtp1562974966-6520) [n:127.0.0.1:33988_solr c:utilizenodecoll s:shard2 \
r:core_node8 x:utilizenodecoll_shard2_replica_n6] o.a.s.s.IndexSchema \
[utilizenodecoll_shard2_replica_n6] Schema name=cloud-dynamic  [junit4]   2> 1363460 \
INFO  (qtp156119322-6530) [n:127.0.0.1:46485_solr c:utilizenodecoll s:shard1 \
r:core_node5 x:utilizenodecoll_shard1_replica_n2] o.a.s.s.IndexSchema Loaded schema \
cloud-dynamic/1.6 with uniqueid field id  [junit4]   2> 1363460 INFO  \
(qtp156119322-6530) [n:127.0.0.1:46485_solr c:utilizenodecoll s:shard1 r:core_node5 \
x:utilizenodecoll_shard1_replica_n2] o.a.s.c.CoreContainer Creating SolrCore \
'utilizenodecoll_shard1_replica_n2' using configuration from collection \
utilizenodecoll, trusted=true  [junit4]   2> 1363460 INFO  (qtp156119322-6530) \
[n:127.0.0.1:46485_solr c:utilizenodecoll s:shard1 r:core_node5 \
x:utilizenodecoll_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for \
'solr_46485.solr.core.utilizenodecoll.shard1.replica_n2' (registry \
'solr.core.utilizenodecoll.shard1.replica_n2') enabled at server: \
com.sun.jmx.mbeanserver.JmxMBeanServer@2c2f94ce  [junit4]   2> 1363460 INFO  \
(qtp156119322-6530) [n:127.0.0.1:46485_solr c:utilizenodecoll s:shard1 r:core_node5 \
x:utilizenodecoll_shard1_replica_n2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder  \
[junit4]   2> 1363460 INFO  (qtp156119322-6530) [n:127.0.0.1:46485_solr \
c:utilizenodecoll s:shard1 r:core_node5 x:utilizenodecoll_shard1_replica_n2] \
o.a.s.c.SolrCore [[utilizenodecoll_shard1_replica_n2] ] Opening new SolrCore at \
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/t \
est/J0/temp/solr.cloud.TestUtilizeNode_443E3E06A86FE42E-001/tempDir-001/node3/utilizenodecoll_shard1_replica_n2], \
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/sol \
r-core/test/J0/temp/solr.cloud.TestUtilizeNode_443E3E06A86FE42E-001/tempDir-001/node3/./utilizenodecoll_shard1_replica_n2/data/]
  [junit4]   2> 1363492 INFO  (qtp1562974966-6520) [n:127.0.0.1:33988_solr \
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n6] \
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id  [junit4]  \
2> 1363492 INFO  (qtp1562974966-6520) [n:127.0.0.1:33988_solr c:utilizenodecoll \
s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n6] o.a.s.c.CoreContainer \
Creating SolrCore 'utilizenodecoll_shard2_replica_n6' using configuration from \
collection utilizenodecoll, trusted=true  [junit4]   2> 1363492 INFO  \
(qtp1562974966-6520) [n:127.0.0.1:33988_solr c:utilizenodecoll s:shard2 r:core_node8 \
x:utilizenodecoll_shard2_replica_n6] o.a.s.m.r.SolrJmxReporter JMX monitoring for \
'solr_33988.solr.core.utilizenodecoll.shard2.replica_n6' (registry \
'solr.core.utilizenodecoll.shard2.replica_n6') enabled at server: \
com.sun.jmx.mbeanserver.JmxMBeanServer@2c2f94ce  [junit4]   2> 1363493 INFO  \
(qtp1562974966-6520) [n:127.0.0.1:33988_solr c:utilizenodecoll s:shard2 r:core_node8 \
x:utilizenodecoll_shard2_replica_n6] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder  \
[junit4]   2> 1363493 INFO  (qtp1562974966-6520) [n:127.0.0.1:33988_solr \
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n6] \
o.a.s.c.SolrCore [[utilizenodecoll_shard2_replica_n6] ] Opening new SolrCore at \
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/t \
est/J0/temp/solr.cloud.TestUtilizeNode_443E3E06A86FE42E-001/tempDir-001/node4/utilizenodecoll_shard2_replica_n6], \
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/sol \
r-core/test/J0/temp/solr.cloud.TestUtilizeNode_443E3E06A86FE42E-001/tempDir-001/node4/./utilizenodecoll_shard2_replica_n6/data/]
  [junit4]   2> 1363512 INFO  (qtp1062719361-6515) [n:127.0.0.1:38684_solr \
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4] \
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id  [junit4]  \
2> 1363512 INFO  (qtp1062719361-6515) [n:127.0.0.1:38684_solr c:utilizenodecoll \
s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4] o.a.s.c.CoreContainer \
Creating SolrCore 'utilizenodecoll_shard2_replica_n4' using configuration from \
collection utilizenodecoll, trusted=true  [junit4]   2> 1363512 INFO  \
(qtp1062719361-6515) [n:127.0.0.1:38684_solr c:utilizenodecoll s:shard2 r:core_node7 \
x:utilizenodecoll_shard2_replica_n4] o.a.s.m.r.SolrJmxReporter JMX monitoring for \
'solr_38684.solr.core.utilizenodecoll.shard2.replica_n4' (registry \
'solr.core.utilizenodecoll.shard2.replica_n4') enabled at server: \
com.sun.jmx.mbeanserver.JmxMBeanServer@2c2f94ce  [junit4]   2> 1363513 INFO  \
(qtp1062719361-6515) [n:127.0.0.1:38684_solr c:utilizenodecoll s:shard2 r:core_node7 \
x:utilizenodecoll_shard2_replica_n4] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder  \
[junit4]   2> 1363513 INFO  (qtp1062719361-6515) [n:127.0.0.1:38684_solr \
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4] \
o.a.s.c.SolrCore [[utilizenodecoll_shard2_replica_n4] ] Opening new SolrCore at \
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/t \
est/J0/temp/solr.cloud.TestUtilizeNode_443E3E06A86FE42E-001/tempDir-001/node2/utilizenodecoll_shard2_replica_n4], \
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/sol \
r-core/test/J0/temp/solr.cloud.TestUtilizeNode_443E3E06A86FE42E-001/tempDir-001/node2/./utilizenodecoll_shard2_replica_n4/data/]
  [junit4]   2> 1363562 INFO  (qtp2076910093-6542) [n:127.0.0.1:34167_solr \
c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1] \
o.a.s.u.UpdateHandler Using UpdateLog implementation: \
org.apache.solr.update.UpdateLog  [junit4]   2> 1363562 INFO  (qtp2076910093-6542) \
[n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 r:core_node3 \
x:utilizenodecoll_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: \
dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 \
numVersionBuckets=65536  [junit4]   2> 1363563 INFO  (qtp2076910093-6542) \
[n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 r:core_node3 \
x:utilizenodecoll_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled  \
[junit4]   2> 1363563 INFO  (qtp2076910093-6542) [n:127.0.0.1:34167_solr \
c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1] \
o.a.s.u.CommitTracker Soft AutoCommit: disabled  [junit4]   2> 1363578 INFO  \
(qtp2076910093-6542) [n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 r:core_node3 \
x:utilizenodecoll_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening \
[Searcher@2ebb60a1[utilizenodecoll_shard1_replica_n1] main]  [junit4]   2> 1363599 \
INFO  (qtp2076910093-6542) [n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 \
r:core_node3 x:utilizenodecoll_shard1_replica_n1] o.a.s.r.ManagedResourceStorage \
Configured ZooKeeperStorageIO with znodeBase: /configs/conf1  [junit4]   2> 1363599 \
INFO  (qtp2076910093-6542) [n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 \
r:core_node3 x:utilizenodecoll_shard1_replica_n1] o.a.s.r.ManagedResourceStorage \
Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1  \
[junit4]   2> 1363599 INFO  (qtp2076910093-6542) [n:127.0.0.1:34167_solr \
c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1] \
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.  [junit4]   2> \
1363600 INFO  (qtp2076910093-6542) [n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 \
   [junit4]   2> 1363602 INFO  \
(searcherExecutor-3150-thread-1-processing-n:127.0.0.1:34167_solr \
x:utilizenodecoll_shard1_replica_n1 s:shard1 c:utilizenodecoll r:core_node3) \
[n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 r:core_node3 \
x:utilizenodecoll_shard1_replica_n1] o.a.s.c.SolrCore \
[utilizenodecoll_shard1_replica_n1] Registered new searcher \
Searcher@2ebb60a1[utilizenodecoll_shard1_replica_n1] \
main{ExitableDirectoryReader(UninvertingDirectoryReader())}  [junit4]   2> 1363652 \
INFO  (qtp2076910093-6542) [n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 \
r:core_node3 x:utilizenodecoll_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext \
Waiting until we see more replicas up for shard shard1: total=2 found=1 \
timeoutin=9999ms  [junit4]   2> 1363702 INFO  (qtp156119322-6530) \
[n:127.0.0.1:46485_solr c:utilizenodecoll s:shard1 r:core_node5 \
x:utilizenodecoll_shard1_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog \
implementation: org.apache.solr.update.UpdateLog  [junit4]   2> 1363702 INFO  \
(qtp156119322-6530) [n:127.0.0.1:46485_solr c:utilizenodecoll s:shard1 r:core_node5 \
x:utilizenodecoll_shard1_replica_n2] o.a.s.u.UpdateLog Initializing UpdateLog: \
dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 \
numVersionBuckets=65536  [junit4]   2> 1363703 INFO  (qtp156119322-6530) \
[n:127.0.0.1:46485_solr c:utilizenodecoll s:shard1 r:core_node5 \
x:utilizenodecoll_shard1_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: disabled  \
[junit4]   2> 1363703 INFO  (qtp156119322-6530) [n:127.0.0.1:46485_solr \
c:utilizenodecoll s:shard1 r:core_node5 x:utilizenodecoll_shard1_replica_n2] \
o.a.s.u.CommitTracker Soft AutoCommit: disabled  [junit4]   2> 1363737 INFO  \
(qtp156119322-6530) [n:127.0.0.1:46485_solr c:utilizenodecoll s:shard1 r:core_node5 \
x:utilizenodecoll_shard1_replica_n2] o.a.s.s.SolrIndexSearcher Opening \
[Searcher@6ee4fb44[utilizenodecoll_shard1_replica_n2] main]  [junit4]   2> 1363745 \
INFO  (qtp156119322-6530) [n:127.0.0.1:46485_solr c:utilizenodecoll s:shard1 \
r:core_node5 x:utilizenodecoll_shard1_replica_n2] o.a.s.r.ManagedResourceStorage \
Configured ZooKeeperStorageIO with znodeBase: /configs/conf1  [junit4]   2> 1363745 \
INFO  (qtp156119322-6530) [n:127.0.0.1:46485_solr c:utilizenodecoll s:shard1 \
r:core_node5 x:utilizenodecoll_shard1_replica_n2] o.a.s.r.ManagedResourceStorage \
Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1  \
[junit4]   2> 1363746 INFO  (qtp156119322-6530) [n:127.0.0.1:46485_solr \
c:utilizenodecoll s:shard1 r:core_node5 x:utilizenodecoll_shard1_replica_n2] \
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.  [junit4]   2> \
1363747 INFO  (searcherExecutor-3152-thread-1-processing-n:127.0.0.1:46485_solr \
x:utilizenodecoll_shard1_replica_n2 s:shard1 c:utilizenodecoll r:core_node5) \
[n:127.0.0.1:46485_solr c:utilizenodecoll s:shard1 r:core_node5 \
x:utilizenodecoll_shard1_replica_n2] o.a.s.c.SolrCore \
[utilizenodecoll_shard1_replica_n2] Registered new searcher \
Searcher@6ee4fb44[utilizenodecoll_shard1_replica_n2] \
main{ExitableDirectoryReader(UninvertingDirectoryReader())}  [junit4]   2> 1363747 \
INFO  (qtp156119322-6530) [n:127.0.0.1:46485_solr c:utilizenodecoll s:shard1 \
r:core_node5 x:utilizenodecoll_shard1_replica_n2] o.a.s.u.UpdateLog Could not find \
max version in index or recent updates, using new clock 1591133624119328768  [junit4] \
2> 1363817 INFO  (zkCallback-1313-thread-1-processing-n:127.0.0.1:34167_solr) \
[n:127.0.0.1:34167_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: \
[WatchedEvent state:SyncConnected type:NodeDataChanged \
path:/collections/utilizenodecoll/state.json] for collection [utilizenodecoll] has \
occurred - updating... (live nodes size: [4])  [junit4]   2> 1363817 INFO  \
(zkCallback-1313-thread-2-processing-n:127.0.0.1:34167_solr) [n:127.0.0.1:34167_solr  \
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected \
type:NodeDataChanged path:/collections/utilizenodecoll/state.json] for collection \
[utilizenodecoll] has occurred - updating... (live nodes size: [4])  [junit4]   2> \
1363821 INFO  (zkCallback-1308-thread-1-processing-n:127.0.0.1:46485_solr) \
[n:127.0.0.1:46485_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: \
[WatchedEvent state:SyncConnected type:NodeDataChanged \
path:/collections/utilizenodecoll/state.json] for collection [utilizenodecoll] has \
occurred - updating... (live nodes size: [4])  [junit4]   2> 1363829 INFO  \
(zkCallback-1310-thread-1-processing-n:127.0.0.1:38684_solr) [n:127.0.0.1:38684_solr  \
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected \
type:NodeDataChanged path:/collections/utilizenodecoll/state.json] for collection \
[utilizenodecoll] has occurred - updating... (live nodes size: [4])  [junit4]   2> \
1363829 INFO  (zkCallback-1310-thread-2-processing-n:127.0.0.1:38684_solr) \
[n:127.0.0.1:38684_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: \
[WatchedEvent state:SyncConnected type:NodeDataChanged \
path:/collections/utilizenodecoll/state.json] for collection [utilizenodecoll] has \
occurred - updating... (live nodes size: [4])  [junit4]   2> 1363833 INFO  \
(qtp1562974966-6520) [n:127.0.0.1:33988_solr c:utilizenodecoll s:shard2 r:core_node8 \
x:utilizenodecoll_shard2_replica_n6] o.a.s.u.UpdateHandler Using UpdateLog \
implementation: org.apache.solr.update.UpdateLog  [junit4]   2> 1363834 INFO  \
(qtp1562974966-6520) [n:127.0.0.1:33988_solr c:utilizenodecoll s:shard2 r:core_node8 \
x:utilizenodecoll_shard2_replica_n6] o.a.s.u.UpdateLog Initializing UpdateLog: \
dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 \
numVersionBuckets=65536  [junit4]   2> 1363835 INFO  (qtp1562974966-6520) \
[n:127.0.0.1:33988_solr c:utilizenodecoll s:shard2 r:core_node8 \
x:utilizenodecoll_shard2_replica_n6] o.a.s.u.CommitTracker Hard AutoCommit: disabled  \
[junit4]   2> 1363835 INFO  (qtp1562974966-6520) [n:127.0.0.1:33988_solr \
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n6] \
o.a.s.u.CommitTracker Soft AutoCommit: disabled  [junit4]   2> 1363836 INFO  \
(qtp1562974966-6520) [n:127.0.0.1:33988_solr c:utilizenodecoll s:shard2 r:core_node8 \
x:utilizenodecoll_shard2_replica_n6] o.a.s.s.SolrIndexSearcher Opening \
[Searcher@65040446[utilizenodecoll_shard2_replica_n6] main]  [junit4]   2> 1363837 \
INFO  (qtp1562974966-6520) [n:127.0.0.1:33988_solr c:utilizenodecoll s:shard2 \
r:core_node8 x:utilizenodecoll_shard2_replica_n6] o.a.s.r.ManagedResourceStorage \
Configured ZooKeeperStorageIO with znodeBase: /configs/conf1  [junit4]   2> 1363870 \
INFO  (zkCallback-1315-thread-2-processing-n:127.0.0.1:33988_solr) \
[n:127.0.0.1:33988_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: \
[WatchedEvent state:SyncConnected type:NodeDataChanged \
path:/collections/utilizenodecoll/state.json] for collection [utilizenodecoll] has \
occurred - updating... (live nodes size: [4])  [junit4]   2> 1363870 INFO  \
(zkCallback-1315-thread-1-processing-n:127.0.0.1:33988_solr) [n:127.0.0.1:33988_solr  \
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected \
type:NodeDataChanged path:/collections/utilizenodecoll/state.json] for collection \
[utilizenodecoll] has occurred - updating... (live nodes size: [4])  [junit4]   2> \
1363870 INFO  (zkCallback-1308-thread-3-processing-n:127.0.0.1:46485_solr) \
[n:127.0.0.1:46485_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: \
[WatchedEvent state:SyncConnected type:NodeDataChanged \
path:/collections/utilizenodecoll/state.json] for collection [utilizenodecoll] has \
occurred - updating... (live nodes size: [4])  [junit4]   2> 1363870 INFO  \
(qtp1562974966-6520) [n:127.0.0.1:33988_solr c:utilizenodecoll s:shard2 r:core_node8 \
x:utilizenodecoll_shard2_replica_n6] o.a.s.r.ManagedResourceStorage Loaded null at \
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1  [junit4]   2> \
1363871 INFO  (qtp1562974966-6520) [n:127.0.0.1:33988_solr c:utilizenodecoll s:shard2 \
r:core_node8 x:utilizenodecoll_shard2_replica_n6] o.a.s.h.ReplicationHandler Commits \
will be reserved for 10000ms.  [junit4]   2> 1363871 INFO  (qtp1562974966-6520) \
[n:127.0.0.1:33988_solr c:utilizenodecoll s:shard2 r:core_node8 \
x:utilizenodecoll_shard2_replica_n6] o.a.s.u.UpdateLog Could not find max version in \
index or recent updates, using new clock 1591133624249352192  [junit4]   2> 1363872 \
INFO  (searcherExecutor-3153-thread-1-processing-n:127.0.0.1:33988_solr \
x:utilizenodecoll_shard2_replica_n6 s:shard2 c:utilizenodecoll r:core_node8) \
[n:127.0.0.1:33988_solr c:utilizenodecoll s:shard2 r:core_node8 \
x:utilizenodecoll_shard2_replica_n6] o.a.s.c.SolrCore \
[utilizenodecoll_shard2_replica_n6] Registered new searcher \
Searcher@65040446[utilizenodecoll_shard2_replica_n6] \
main{ExitableDirectoryReader(UninvertingDirectoryReader())}  [junit4]   2> 1363888 \
INFO  (qtp1562974966-6520) [n:127.0.0.1:33988_solr c:utilizenodecoll s:shard2 \
r:core_node8 x:utilizenodecoll_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext \
Waiting until we see more replicas up for shard shard2: total=2 found=1 \
timeoutin=9999ms  [junit4]   2> 1363951 INFO  (qtp1062719361-6515) \
[n:127.0.0.1:38684_solr c:utilizenodecoll s:shard2 r:core_node7 \
x:utilizenodecoll_shard2_replica_n4] o.a.s.u.UpdateHandler Using UpdateLog \
implementation: org.apache.solr.update.UpdateLog  [junit4]   2> 1363951 INFO  \
(qtp1062719361-6515) [n:127.0.0.1:38684_solr c:utilizenodecoll s:shard2 r:core_node7 \
x:utilizenodecoll_shard2_replica_n4] o.a.s.u.UpdateLog Initializing UpdateLog: \
dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 \
numVersionBuckets=65536  [junit4]   2> 1363968 INFO  (qtp1062719361-6515) \
[n:127.0.0.1:38684_solr c:utilizenodecoll s:shard2 r:core_node7 \
x:utilizenodecoll_shard2_replica_n4] o.a.s.u.CommitTracker Hard AutoCommit: disabled  \
[junit4]   2> 1363968 INFO  (qtp1062719361-6515) [n:127.0.0.1:38684_solr \
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4] \
o.a.s.u.CommitTracker Soft AutoCommit: disabled  [junit4]   2> 1363969 INFO  \
(qtp1062719361-6515) [n:127.0.0.1:38684_solr c:utilizenodecoll s:shard2 r:core_node7 \
x:utilizenodecoll_shard2_replica_n4] o.a.s.s.SolrIndexSearcher Opening \
[Searcher@36371ace[utilizenodecoll_shard2_replica_n4] main]  [junit4]   2> 1363991 \
INFO  (qtp1062719361-6515) [n:127.0.0.1:38684_solr c:utilizenodecoll s:shard2 \
r:core_node7 x:utilizenodecoll_shard2_replica_n4] o.a.s.r.ManagedResourceStorage \
Configured ZooKeeperStorageIO with znodeBase: /configs/conf1  [junit4]   2> 1363992 \
INFO  (qtp1062719361-6515) [n:127.0.0.1:38684_solr c:utilizenodecoll s:shard2 \
r:core_node7 x:utilizenodecoll_shard2_replica_n4] o.a.s.r.ManagedResourceStorage \
Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1  \
[junit4]   2> 1363992 INFO  (qtp1062719361-6515) [n:127.0.0.1:38684_solr \
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4] \
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.  [junit4]   2> \
1363992 INFO  (qtp1062719361-6515) [n:127.0.0.1:38684_solr c:utilizenodecoll s:shard2 \
r:core_node7 x:utilizenodecoll_shard2_replica_n4] o.a.s.u.UpdateLog Could not find \
max version in index or recent updates, using new clock 1591133624376229888  [junit4] \
2> 1363995 INFO  (searcherExecutor-3154-thread-1-processing-n:127.0.0.1:38684_solr \
x:utilizenodecoll_shard2_replica_n4 s:shard2 c:utilizenodecoll r:core_node7) \
[n:127.0.0.1:38684_solr c:utilizenodecoll s:shard2 r:core_node7 \
x:utilizenodecoll_shard2_replica_n4] o.a.s.c.SolrCore \
[utilizenodecoll_shard2_replica_n4] Registered new searcher \
Searcher@36371ace[utilizenodecoll_shard2_replica_n4] \
main{ExitableDirectoryReader(UninvertingDirectoryReader())}  [junit4]   2> 1364008 \
INFO  (zkCallback-1310-thread-2-processing-n:127.0.0.1:38684_solr) \
[n:127.0.0.1:38684_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: \
[WatchedEvent state:SyncConnected type:NodeDataChanged \
path:/collections/utilizenodecoll/state.json] for collection [utilizenodecoll] has \
occurred - updating... (live nodes size: [4])  [junit4]   2> 1364008 INFO  \
(zkCallback-1310-thread-1-processing-n:127.0.0.1:38684_solr) [n:127.0.0.1:38684_solr  \
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected \
type:NodeDataChanged path:/collections/utilizenodecoll/state.json] for collection \
[utilizenodecoll] has occurred - updating... (live nodes size: [4])  [junit4]   2> \
1364012 INFO  (zkCallback-1315-thread-1-processing-n:127.0.0.1:33988_solr) \
[n:127.0.0.1:33988_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: \
[WatchedEvent state:SyncConnected type:NodeDataChanged \
path:/collections/utilizenodecoll/state.json] for collection [utilizenodecoll] has \
occurred - updating... (live nodes size: [4])  [junit4]   2> 1364012 INFO  \
(zkCallback-1315-thread-2-processing-n:127.0.0.1:33988_solr) [n:127.0.0.1:33988_solr  \
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected \
type:NodeDataChanged path:/collections/utilizenodecoll/state.json] for collection \
[utilizenodecoll] has occurred - updating... (live nodes size: [4])  [junit4]   2> \
1364032 INFO  (zkCallback-1313-thread-2-processing-n:127.0.0.1:34167_solr) \
[n:127.0.0.1:34167_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: \
[WatchedEvent state:SyncConnected type:NodeDataChanged \
path:/collections/utilizenodecoll/state.json] for collection [utilizenodecoll] has \
occurred - updating... (live nodes size: [4])  [junit4]   2> 1364032 INFO  \
(zkCallback-1313-thread-1-processing-n:127.0.0.1:34167_solr) [n:127.0.0.1:34167_solr  \
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected \
type:NodeDataChanged path:/collections/utilizenodecoll/state.json] for collection \
[utilizenodecoll] has occurred - updating... (live nodes size: [4])  [junit4]   2> \
1364032 INFO  (zkCallback-1308-thread-3-processing-n:127.0.0.1:46485_solr) \
[n:127.0.0.1:46485_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: \
[WatchedEvent state:SyncConnected type:NodeDataChanged \
path:/collections/utilizenodecoll/state.json] for collection [utilizenodecoll] has \
occurred - updating... (live nodes size: [4])  [junit4]   2> 1364032 INFO  \
(zkCallback-1308-thread-2-processing-n:127.0.0.1:46485_solr) [n:127.0.0.1:46485_solr  \
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected \
type:NodeDataChanged path:/collections/utilizenodecoll/state.json] for collection \
[utilizenodecoll] has occurred - updating... (live nodes size: [4])  [junit4]   2> \
1364153 INFO  (qtp2076910093-6542) [n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 \
r:core_node3 x:utilizenodecoll_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext \
Enough replicas found to continue.  [junit4]   2> 1364153 INFO  (qtp2076910093-6542) \
[n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 r:core_node3 \
x:utilizenodecoll_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the \
new leader - try and sync  [junit4]   2> 1364153 INFO  (qtp2076910093-6542) \
[n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 r:core_node3 \
x:utilizenodecoll_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to \
https://127.0.0.1:34167/solr/utilizenodecoll_shard1_replica_n1/  [junit4]   2> \
1364186 INFO  (qtp2076910093-6542) [n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 \
r:core_node3 x:utilizenodecoll_shard1_replica_n1] o.a.s.u.PeerSync PeerSync: \
   [junit4]   2> 1364237 INFO  (qtp156119322-6507) [n:127.0.0.1:46485_solr \
c:utilizenodecoll s:shard1 r:core_node5 x:utilizenodecoll_shard1_replica_n2] \
o.a.s.c.S.Request [utilizenodecoll_shard1_replica_n2]  webapp=/solr path=/get \
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} \
status=0 QTime=0  [junit4]   2> 1364397 INFO  (qtp1562974966-6520) \
[n:127.0.0.1:33988_solr c:utilizenodecoll s:shard2 r:core_node8 \
x:utilizenodecoll_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext Enough \
replicas found to continue.  [junit4]   2> 1364397 INFO  (qtp1562974966-6520) \
[n:127.0.0.1:33988_solr c:utilizenodecoll s:shard2 r:core_node8 \
x:utilizenodecoll_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext I may be the \
new leader - try and sync  [junit4]   2> 1364397 INFO  (qtp1562974966-6520) \
[n:127.0.0.1:33988_solr c:utilizenodecoll s:shard2 r:core_node8 \
x:utilizenodecoll_shard2_replica_n6] o.a.s.c.SyncStrategy Sync replicas to \
https://127.0.0.1:33988/solr/utilizenodecoll_shard2_replica_n6/  [junit4]   2> \
1364397 INFO  (qtp1562974966-6520) [n:127.0.0.1:33988_solr c:utilizenodecoll s:shard2 \
r:core_node8 x:utilizenodecoll_shard2_replica_n6] o.a.s.u.PeerSync PeerSync: \
core=utilizenodecoll_shard2_replica_n6 url=https://127.0.0.1:33988/solr START \
replicas=[https://127.0.0.1:38684/solr/utilizenodecoll_shard2_replica_n4/] \
nUpdates=100  [junit4]   2> 1364401 INFO  (qtp1062719361-6506) \
[n:127.0.0.1:38684_solr c:utilizenodecoll s:shard2 r:core_node7 \
x:utilizenodecoll_shard2_replica_n4] o.a.s.c.S.Request \
[utilizenodecoll_shard2_replica_n4]  webapp=/solr path=/get \
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} \
status=0 QTime=0  [junit4]   2> 1364494 INFO  (qtp2076910093-6542) \
[n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 r:core_node3 \
x:utilizenodecoll_shard1_replica_n1] o.a.s.u.PeerSync PeerSync: \
core=utilizenodecoll_shard1_replica_n1 url=https://127.0.0.1:34167/solr DONE.  We \
have no versions.  sync failed.  [junit4]   2> 1364494 INFO  (qtp2076910093-6542) \
[n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 r:core_node3 \
x:utilizenodecoll_shard1_replica_n1] o.a.s.c.SyncStrategy Leader's attempt to sync \
with shard failed, moving to the next candidate  [junit4]   2> 1364494 INFO  \
(qtp2076910093-6542) [n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 r:core_node3 \
x:utilizenodecoll_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext We failed \
sync, but we have no versions - we can't sync in that case - we were active before, \
so become leader anyway  [junit4]   2> 1364494 INFO  (qtp2076910093-6542) \
[n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 r:core_node3 \
x:utilizenodecoll_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found all \
replicas participating in election, clear LIR  [junit4]   2> 1364497 INFO  \
(qtp2076910093-6542) [n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 r:core_node3 \
x:utilizenodecoll_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new \
leader: https://127.0.0.1:34167/solr/utilizenodecoll_shard1_replica_n1/ shard1  \
[junit4]   2> 1364620 INFO  \
(zkCallback-1308-thread-2-processing-n:127.0.0.1:46485_solr) [n:127.0.0.1:46485_solr  \
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected \
type:NodeDataChanged path:/collections/utilizenodecoll/state.json] for collection \
[utilizenodecoll] has occurred - updating... (live nodes size: [4])  [junit4]   2> \
1364620 INFO  (zkCallback-1315-thread-3-processing-n:127.0.0.1:33988_solr) \
[n:127.0.0.1:33988_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: \
[WatchedEvent state:SyncConnected type:NodeDataChanged \
path:/collections/utilizenodecoll/state.json] for collection [utilizenodecoll] has \
occurred - updating... (live nodes size: [4])  [junit4]   2> 1364620 INFO  \
(zkCallback-1308-thread-3-processing-n:127.0.0.1:46485_solr) [n:127.0.0.1:46485_solr  \
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected \
type:NodeDataChanged path:/collections/utilizenodecoll/state.json] for collection \
[utilizenodecoll] has occurred - updating... (live nodes size: [4])  [junit4]   2> \
1364620 INFO  (zkCallback-1313-thread-2-processing-n:127.0.0.1:34167_solr) \
[n:127.0.0.1:34167_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: \
[WatchedEvent state:SyncConnected type:NodeDataChanged \
path:/collections/utilizenodecoll/state.json] for collection [utilizenodecoll] has \
occurred - updating... (live nodes size: [4])  [junit4]   2> 1364620 INFO  \
(zkCallback-1315-thread-2-processing-n:127.0.0.1:33988_solr) [n:127.0.0.1:33988_solr  \
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected \
type:NodeDataChanged path:/collections/utilizenodecoll/state.json] for collection \
[utilizenodecoll] has occurred - updating... (live nodes size: [4])  [junit4]   2> \
1364620 INFO  (zkCallback-1310-thread-2-processing-n:127.0.0.1:38684_solr) \
[n:127.0.0.1:38684_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: \
[WatchedEvent state:SyncConnected type:NodeDataChanged \
path:/collections/utilizenodecoll/state.json] for collection [utilizenodecoll] has \
occurred - updating... (live nodes size: [4])  [junit4]   2> 1364620 INFO  \
(zkCallback-1313-thread-1-processing-n:127.0.0.1:34167_solr) [n:127.0.0.1:34167_solr  \
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected \
type:NodeDataChanged path:/collections/utilizenodecoll/state.json] for collection \
[utilizenodecoll] has occurred - updating... (live nodes size: [4])  [junit4]   2> \
1364620 INFO  (zkCallback-1310-thread-1-processing-n:127.0.0.1:38684_solr) \
[n:127.0.0.1:38684_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: \
[WatchedEvent state:SyncConnected type:NodeDataChanged \
path:/collections/utilizenodecoll/state.json] for collection [utilizenodecoll] has \
occurred - updating... (live nodes size: [4])  [junit4]   2> 1364621 INFO  \
(qtp2076910093-6542) [n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 r:core_node3 \
x:utilizenodecoll_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no \
recovery necessary  [junit4]   2> 1364622 INFO  (qtp2076910093-6542) \
[n:127.0.0.1:34167_solr c:utilizenodecoll s:shard1 r:core_node3 \
x:utilizenodecoll_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null \
path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node3&collection.configNam \
e=conf1&newCollection=true&name=utilizenodecoll_shard1_replica_n1&action=CREATE&numSha \
rds=2&collection=utilizenodecoll&shard=shard1&wt=javabin&version=2&replicaType=NRT} \
status=0 QTime=3392  [junit4]   2> 1364716 INFO  (qtp1562974966-6520) \
[n:127.0.0.1:33988_solr c:utilizenodecoll s:shard2 r:core_node8 \
x:utilizenodecoll_shard2_replica_n6] o.a.s.u.PeerSync PeerSync: \
core=utilizenodecoll_shard2_replica_n6 url=https://127.0.0.1:33988/solr DONE.  We \
have no versions.  sync failed.  

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

Test, DistributedFacetPivotLargeTest, InfixSuggestersTest, \
TestTolerantUpdateProcessorRandomCloud, TestStressLiveNodes, ZkStateWriterTest, \
TestRandomDVFaceting, TestOnReconnectListenerSupport, TestSuggestSpellingConverter, \
SpatialHeatmapFacetsTest, CoreMergeIndexesAdminHandlerTest, HighlighterMaxOffsetTest, \
DisMaxRequestHandlerTest, TestJavabinTupleStreamParser, AtomicUpdatesTest, \
DistributedFacetPivotSmallTest, SolrShardReporterTest, DistribCursorPagingTest, \
HLLUtilTest, CdcrVersionReplicationTest, SolrGangliaReporterTest, TestTestInjection, \
ExecutePlanActionTest, ConcurrentDeleteAndCreateCollectionTest, \
BlockJoinFacetDistribTest, ResponseHeaderTest, DistanceFunctionTest, \
IndexSchemaRuntimeFieldTest, BigEndianAscendingWordDeserializerTest, \
SearchRateTriggerTest, TestCollationFieldDocValues, TestReRankQParserPlugin, \
TestNumericRangeQuery64, TestSchemaNameResource, TestConfigSetsAPIExclusivity, \
TestLFUCache, CurrencyRangeFacetCloudTest, RulesTest, DistanceUnitsTest, \
TestRebalanceLeaders, TestOverriddenPrefixQueryForCustomFieldType, MergeStrategyTest, \
TimeZoneUtilsTest, TestSchemaManager, DistributedQueryComponentOptimizationTest, \
HdfsNNFailoverTest, BasicFunctionalityTest, TestBadConfig, \
DistributedQueryElevationComponentTest, CoreAdminHandlerTest, SuggesterTSTTest, \
SuggesterTest, TestStressLucene, TestTrie, SpatialFilterTest, \
WordBreakSolrSpellCheckerTest, SchemaVersionSpecificBehaviorTest, \
SolrCoreCheckLockOnStartupTest, TestPseudoReturnFields, TestUpdate, \
FieldMutatingUpdateProcessorTest, TestWordDelimiterFilterFactory, QueryEqualityTest, \
DocValuesMultiTest, SolrInfoBeanTest, XsltUpdateRequestHandlerTest, \
TestSurroundQueryParser, TestReversedWildcardFilterFactory, TestQueryTypes, \
RequestHandlersTest, TestIndexingPerformance, FastVectorHighlighterTest, \
RegexBoostProcessorTest, IndexSchemaTest, TestCollationField, \
UpdateRequestProcessorFactoryTest, QueryParsingTest, \
UniqFieldsUpdateProcessorFactoryTest, TestPHPSerializedResponseWriter, \
CSVRequestHandlerTest, SearchHandlerTest, TestBinaryField, TestElisionMultitermQuery, \
TestFuzzyAnalyzedSuggestions, TestPhraseSuggestions, TestSweetSpotSimilarityFactory, \
TestLMDirichletSimilarityFactory, TestFastWriter, PluginInfoTest, \
TestSystemIdResolver, DateFieldTest, TestUtils, ZkNodePropsTest, \
DistributedMLTComponentTest, SolrTestCaseJ4Test, TestCrossCoreJoin, \
TestDistributedMissingSort, TestHighlightDedupGrouping, \
ChaosMonkeyNothingIsSafeWithPullReplicasTest, ConcurrentCreateRoutedAliasTest, \
DistributedQueueTest, ForceLeaderTest, NodeMutatorTest, OverseerModifyCollectionTest, \
OverseerStatusTest, PeerSyncReplicationTest, TestCloudPseudoReturnFields, \
TestConfigSetsAPI, TestRandomFlRTGCloud, TestRequestForwarding, TestSegmentSorting, \
TestSolrCloudWithKerberosAlt, TestSolrCloudWithSecureImpersonation, TestTlogReplica]  \
[junit4] Completed [579/774 (5!)] on J2 in 141.91s, 13 tests, 1 failure <<< FAILURES!

[...truncated 3737 lines...]
   [junit4] Suite: org.apache.solr.analytics.facet.PivotFacetTest
   [junit4]   2> Creating dataDir: \
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/contrib/solr \
-analytics/test/J0/temp/solr.analytics.facet.PivotFacetTest_8AC9E657FA81F3EA-001/init-core-data-001
  [junit4]   2> Jan 31, 2018 7:25:11 PM \
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks  [junit4]   2> \
WARNING: Will linger awaiting termination of 1 leaked thread(s).  [junit4]   2> Jan \
31, 2018 7:25:31 PM com.carrotsearch.randomizedtesting.ThreadLeakControl \
checkThreadLeaks  [junit4]   2> SEVERE: 1 thread leaked from SUITE scope at \
org.apache.solr.analytics.facet.PivotFacetTest:   [junit4]   2>    1) Thread[id=59, \
name=qtp88290436-59, state=TIMED_WAITING, group=TGRP-PivotFacetTest]  [junit4]   2>   \
at sun.misc.Unsafe.park(Native Method)  [junit4]   2>         at \
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)  [junit4]   2> \
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
  [junit4]   2>         at \
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
  [junit4]   2>         at \
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
  [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> Jan 31, \
2018 7:25:31 PM com.carrotsearch.randomizedtesting.ThreadLeakControl \
tryToInterruptAll  [junit4]   2> INFO: Starting to interrupt leaked threads:
   [junit4]   2>    1) Thread[id=59, name=qtp88290436-59, state=TIMED_WAITING, \
group=TGRP-PivotFacetTest]  [junit4]   2> Jan 31, 2018 7:25:34 PM \
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll  [junit4]   2> \
SEVERE: There are still zombie threads that couldn't be terminated:  [junit4]   2>    \
1) Thread[id=59, name=qtp88290436-59, state=TIMED_WAITING, group=TGRP-PivotFacetTest] \
[junit4]   2>         at sun.misc.Unsafe.park(Native Method)  [junit4]   2>         \
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)  [junit4]   \
2>         at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
  [junit4]   2>         at \
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
  [junit4]   2>         at \
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
  [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): {string_s=Lucene50(blocksize=128), \
id=PostingsFormat(name=MockRandom), string_sm=Lucene50(blocksize=128)}, \
docValues:{int_i=DocValuesFormat(name=Asserting), \
double_dm=DocValuesFormat(name=Memory), float_fm=DocValuesFormat(name=Lucene70), \
int_im=DocValuesFormat(name=Lucene70), date_dt=DocValuesFormat(name=Asserting), \
date_dtm=DocValuesFormat(name=Lucene70), long_lm=DocValuesFormat(name=Lucene70), \
double_d=DocValuesFormat(name=Lucene70), float_f=DocValuesFormat(name=Memory), \
long_l=DocValuesFormat(name=Asserting), _version_=DocValuesFormat(name=Lucene70), \
string_s=DocValuesFormat(name=Asserting), id=DocValuesFormat(name=Memory), \
string_sm=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=1032, \
maxMBSortInHeap=7.652959654536091, \
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@4a71bc50), \
locale=pl, timezone=MST7MDT  [junit4]   2> NOTE: Linux 4.4.0-104-generic amd64/Oracle \
Corporation 1.8.0_152 (64-bit)/cpus=4,threads=2,free=172716136,total=311427072  \
[junit4]   2> NOTE: All tests run in this JVM: [RemoveFunctionTest, \
CastingIntValueTest, PivotFacetTest]  [junit4]   2> NOTE: reproduce with: ant test  \
-Dtestcase=PivotFacetTest -Dtests.seed=8AC9E657FA81F3EA -Dtests.multiplier=2 \
-Dtests.slow=true -Dtests.locale=pl -Dtests.timezone=MST7MDT -Dtests.asserts=true \
-Dtests.file.encoding=ISO-8859-1  [junit4] ERROR   0.00s J0 | PivotFacetTest (suite) \
<<<  [junit4]    > Throwable #1: com.carrotsearch.randomizedtesting.ThreadLeakError: \
1 thread leaked from SUITE scope at org.apache.solr.analytics.facet.PivotFacetTest:   \
[junit4]    >    1) Thread[id=59, name=qtp88290436-59, state=TIMED_WAITING, \
group=TGRP-PivotFacetTest]  [junit4]    >         at sun.misc.Unsafe.park(Native \
Method)  [junit4]    >         at \
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)  [junit4]    > \
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
  [junit4]    >         at \
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
  [junit4]    >         at \
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
  [junit4]    >         at \
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)  \
[junit4]    >         at \
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)  \
[junit4]    >         at java.lang.Thread.run(Thread.java:748)  [junit4]    > 	at \
__randomizedtesting.SeedInfo.seed([8AC9E657FA81F3EA]:0)Throwable #2: \
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads \
that couldn't be terminated:  [junit4]    >    1) Thread[id=59, name=qtp88290436-59, \
state=TIMED_WAITING, group=TGRP-PivotFacetTest]  [junit4]    >         at \
sun.misc.Unsafe.park(Native Method)  [junit4]    >         at \
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)  [junit4]    > \
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
  [junit4]    >         at \
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
  [junit4]    >         at \
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
  [junit4]    >         at \
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)  \
[junit4]    >         at \
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)  \
[junit4]    >         at java.lang.Thread.run(Thread.java:748)  [junit4]    > 	at \
__randomizedtesting.SeedInfo.seed([8AC9E657FA81F3EA]:0)  [junit4] Completed [24/78 \
(1!)] on J0 in 110.92s, 1 test, 2 errors <<< FAILURES!

[...truncated 45072 lines...]



---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
For additional commands, e-mail: dev-help@lucene.apache.org

[prev in list] [next in list] [prev in thread] [next in thread]
Configure | About | News | Add a list | Sponsored by KoreLogic