Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/2354/
5 tests failed.
FAILED: org.apache.solr.cloud.TestUtilizeNode.test
Error Message:
no replica should be present in 127.0.0.1:34279_solr
Stack Trace:
java.lang.AssertionError: no replica should be present in 127.0.0.1:34279_solr
at
__randomizedtesting.SeedInfo.seed([232BF95961C8BCC:8A66804F38E0E634]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.cloud.TestUtilizeNode.test(TestUtilizeNode.java:99)
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.ComputePlanActionTest.testNodeWithMultipleReplicasLost
Error Message:
The operations computed by ComputePlanAction should not be null
SolrClientNodeStateProvider.DEBUG{AFTER_ACTION=[compute_plan, null],
BEFORE_ACTION=[compute_plan, null]}
Stack Trace:
java.lang.AssertionError: The operations computed by ComputePlanAction should
not be null SolrClientNodeStateProvider.DEBUG{AFTER_ACTION=[compute_plan,
null], BEFORE_ACTION=[compute_plan, null]}
at
__randomizedtesting.SeedInfo.seed([232BF95961C8BCC:32F25E171E6E6A90]: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.autoscaling.ComputePlanActionTest.testNodeWithMultipleReplicasLost(ComputePlanActionTest.java:291)
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([232BF95961C8BCC:5F7AA11C59DA2D83]: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)
FAILED:
junit.framework.TestSuite.org.apache.solr.client.solrj.TestLBHttpSolrClient
Error Message:
1 thread leaked from SUITE scope at
org.apache.solr.client.solrj.TestLBHttpSolrClient: 1) Thread[id=711,
name=qtp806744391-711, state=TIMED_WAITING, group=TGRP-TestLBHttpSolrClient]
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.client.solrj.TestLBHttpSolrClient:
1) Thread[id=711, name=qtp806744391-711, state=TIMED_WAITING,
group=TGRP-TestLBHttpSolrClient]
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([CFA3DBE1EAE1E10A]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.client.solrj.TestLBHttpSolrClient
Error Message:
There are still zombie threads that couldn't be terminated: 1)
Thread[id=711, name=qtp806744391-711, state=TIMED_WAITING,
group=TGRP-TestLBHttpSolrClient] 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=711, name=qtp806744391-711, state=TIMED_WAITING,
group=TGRP-TestLBHttpSolrClient]
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([CFA3DBE1EAE1E10A]:0)
Build Log:
[...truncated 13214 lines...]
[junit4] Suite: org.apache.solr.cloud.TestUtilizeNode
[junit4] 2> 2378867 INFO
(SUITE-TestUtilizeNode-seed#[232BF95961C8BCC]-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/J1/temp/solr.cloud.TestUtilizeNode_232BF95961C8BCC-001/init-core-data-001
[junit4] 2> 2378867 WARN
(SUITE-TestUtilizeNode-seed#[232BF95961C8BCC]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4
[junit4] 2> 2378867 INFO
(SUITE-TestUtilizeNode-seed#[232BF95961C8BCC]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 2378885 INFO
(SUITE-TestUtilizeNode-seed#[232BF95961C8BCC]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 2378886 INFO
(SUITE-TestUtilizeNode-seed#[232BF95961C8BCC]-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/J1/temp/solr.cloud.TestUtilizeNode_232BF95961C8BCC-001/tempDir-001
[junit4] 2> 2378886 INFO
(SUITE-TestUtilizeNode-seed#[232BF95961C8BCC]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2378886 INFO (Thread-2167) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2378886 INFO (Thread-2167) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 2378917 ERROR (Thread-2167) [ ] 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> 2378986 INFO
(SUITE-TestUtilizeNode-seed#[232BF95961C8BCC]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:36976
[junit4] 2> 2379005 INFO (zkConnectionManagerCallback-2283-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2379020 INFO (jetty-launcher-2280-thread-1) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-21T16:27:37-05:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2379020 INFO (jetty-launcher-2280-thread-3) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-21T16:27:37-05:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2379020 INFO (jetty-launcher-2280-thread-2) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-21T16:27:37-05:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2379020 INFO (jetty-launcher-2280-thread-4) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-21T16:27:37-05:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2379021 INFO (jetty-launcher-2280-thread-3) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2379021 INFO (jetty-launcher-2280-thread-3) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2379021 INFO (jetty-launcher-2280-thread-3) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 2379021 INFO (jetty-launcher-2280-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@3ae92231{/solr,null,AVAILABLE}
[junit4] 2> 2379022 INFO (jetty-launcher-2280-thread-3) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@53f92a09{HTTP/1.1,[http/1.1]}{127.0.0.1:44302}
[junit4] 2> 2379022 INFO (jetty-launcher-2280-thread-3) [ ]
o.e.j.s.Server Started @2389480ms
[junit4] 2> 2379022 INFO (jetty-launcher-2280-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=44302}
[junit4] 2> 2379022 ERROR (jetty-launcher-2280-thread-3) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2379023 INFO (jetty-launcher-2280-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.0.0
[junit4] 2> 2379023 INFO (jetty-launcher-2280-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2379023 INFO (jetty-launcher-2280-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2379023 INFO (jetty-launcher-2280-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-02-21T05:01:03.425Z
[junit4] 2> 2379024 INFO (zkConnectionManagerCallback-2285-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2379024 INFO (jetty-launcher-2280-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2379044 INFO (jetty-launcher-2280-thread-4) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2379044 INFO (jetty-launcher-2280-thread-4) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2379044 INFO (jetty-launcher-2280-thread-4) [ ]
o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 2379045 INFO (jetty-launcher-2280-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@573b85f9{/solr,null,AVAILABLE}
[junit4] 2> 2379045 INFO (jetty-launcher-2280-thread-4) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@240856e6{HTTP/1.1,[http/1.1]}{127.0.0.1:37256}
[junit4] 2> 2379045 INFO (jetty-launcher-2280-thread-4) [ ]
o.e.j.s.Server Started @2389503ms
[junit4] 2> 2379045 INFO (jetty-launcher-2280-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=37256}
[junit4] 2> 2379045 ERROR (jetty-launcher-2280-thread-4) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2379045 INFO (jetty-launcher-2280-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.0.0
[junit4] 2> 2379045 INFO (jetty-launcher-2280-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2379045 INFO (jetty-launcher-2280-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2379046 INFO (jetty-launcher-2280-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-02-21T05:01:03.448Z
[junit4] 2> 2379062 INFO (jetty-launcher-2280-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2379062 INFO (jetty-launcher-2280-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2379062 INFO (jetty-launcher-2280-thread-1) [ ]
o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 2379062 INFO (zkConnectionManagerCallback-2287-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2379062 INFO (jetty-launcher-2280-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2379064 INFO (jetty-launcher-2280-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7eae02bb{/solr,null,AVAILABLE}
[junit4] 2> 2379176 INFO (jetty-launcher-2280-thread-1) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@622b5567{HTTP/1.1,[http/1.1]}{127.0.0.1:40831}
[junit4] 2> 2379176 INFO (jetty-launcher-2280-thread-1) [ ]
o.e.j.s.Server Started @2389634ms
[junit4] 2> 2379192 INFO (jetty-launcher-2280-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36976/solr
[junit4] 2> 2379193 INFO (jetty-launcher-2280-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=40831}
[junit4] 2> 2379234 ERROR (jetty-launcher-2280-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2379234 INFO (jetty-launcher-2280-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.0.0
[junit4] 2> 2379234 INFO (jetty-launcher-2280-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2379234 INFO (jetty-launcher-2280-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2379234 INFO (jetty-launcher-2280-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-02-21T05:01:03.636Z
[junit4] 2> 2379205 INFO (jetty-launcher-2280-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2379235 INFO (jetty-launcher-2280-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2379235 INFO (jetty-launcher-2280-thread-2) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 2379255 INFO (jetty-launcher-2280-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@3c0f46c5{/solr,null,AVAILABLE}
[junit4] 2> 2379255 INFO (jetty-launcher-2280-thread-2) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@7a35b2e7{HTTP/1.1,[http/1.1]}{127.0.0.1:39778}
[junit4] 2> 2379255 INFO (jetty-launcher-2280-thread-2) [ ]
o.e.j.s.Server Started @2389713ms
[junit4] 2> 2379255 INFO (jetty-launcher-2280-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=39778}
[junit4] 2> 2379255 ERROR (jetty-launcher-2280-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2379260 INFO (jetty-launcher-2280-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.0.0
[junit4] 2> 2379260 INFO (jetty-launcher-2280-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2379260 INFO (jetty-launcher-2280-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2379260 INFO (jetty-launcher-2280-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-02-21T05:01:03.662Z
[junit4] 2> 2379261 INFO (zkConnectionManagerCallback-2291-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2379267 INFO (jetty-launcher-2280-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36976/solr
[junit4] 2> 2379268 INFO (zkConnectionManagerCallback-2299-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2379297 INFO (zkConnectionManagerCallback-2293-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2379297 INFO (zkConnectionManagerCallback-2295-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2379297 INFO (jetty-launcher-2280-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2379315 INFO
(zkConnectionManagerCallback-2303-thread-1-processing-n:127.0.0.1:37256_solr)
[n:127.0.0.1:37256_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2379315 INFO
(zkConnectionManagerCallback-2301-thread-1-processing-n:127.0.0.1:44302_solr)
[n:127.0.0.1:44302_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2379322 INFO (jetty-launcher-2280-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2379428 INFO (jetty-launcher-2280-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36976/solr
[junit4] 2> 2379445 INFO (jetty-launcher-2280-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36976/solr
[junit4] 2> 2379465 INFO (zkConnectionManagerCallback-2309-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2379467 INFO (zkConnectionManagerCallback-2313-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2379490 INFO
(zkConnectionManagerCallback-2315-thread-1-processing-n:127.0.0.1:39778_solr)
[n:127.0.0.1:39778_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2379490 INFO
(zkConnectionManagerCallback-2317-thread-1-processing-n:127.0.0.1:40831_solr)
[n:127.0.0.1:40831_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2379520 INFO (jetty-launcher-2280-thread-3)
[n:127.0.0.1:44302_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2379521 INFO (jetty-launcher-2280-thread-3)
[n:127.0.0.1:44302_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:44302_solr
[junit4] 2> 2379538 INFO (jetty-launcher-2280-thread-3)
[n:127.0.0.1:44302_solr ] o.a.s.c.Overseer Overseer
(id=72157645504643080-127.0.0.1:44302_solr-n_0000000000) starting
[junit4] 2> 2379541 INFO (jetty-launcher-2280-thread-1)
[n:127.0.0.1:40831_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2379554 INFO (jetty-launcher-2280-thread-1)
[n:127.0.0.1:40831_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:40831_solr
[junit4] 2> 2379583 INFO
(zkCallback-2316-thread-1-processing-n:127.0.0.1:40831_solr)
[n:127.0.0.1:40831_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2379601 INFO (jetty-launcher-2280-thread-2)
[n:127.0.0.1:39778_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2379603 INFO (jetty-launcher-2280-thread-2)
[n:127.0.0.1:39778_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2379620 INFO
(zkCallback-2300-thread-1-processing-n:127.0.0.1:44302_solr)
[n:127.0.0.1:44302_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2379637 INFO (jetty-launcher-2280-thread-3)
[n:127.0.0.1:44302_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:44302_solr
[junit4] 2> 2379638 INFO (jetty-launcher-2280-thread-2)
[n:127.0.0.1:39778_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:39778_solr
[junit4] 2> 2379668 INFO
(zkCallback-2300-thread-2-processing-n:127.0.0.1:44302_solr)
[n:127.0.0.1:44302_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 2379680 INFO
(zkCallback-2316-thread-1-processing-n:127.0.0.1:40831_solr)
[n:127.0.0.1:40831_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (3)
[junit4] 2> 2379680 INFO
(zkCallback-2314-thread-1-processing-n:127.0.0.1:39778_solr)
[n:127.0.0.1:39778_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (3)
[junit4] 2> 2379705 INFO
(zkCallback-2300-thread-1-processing-n:127.0.0.1:44302_solr)
[n:127.0.0.1:44302_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2379813 INFO (jetty-launcher-2280-thread-1)
[n:127.0.0.1:40831_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40831.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@678644ba
[junit4] 2> 2379916 INFO (jetty-launcher-2280-thread-1)
[n:127.0.0.1:40831_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40831.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@678644ba
[junit4] 2> 2379917 INFO (jetty-launcher-2280-thread-1)
[n:127.0.0.1:40831_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40831.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@678644ba
[junit4] 2> 2379918 INFO (jetty-launcher-2280-thread-1)
[n:127.0.0.1:40831_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/J1/temp/solr.cloud.TestUtilizeNode_232BF95961C8BCC-001/tempDir-001/node1/.
[junit4] 2> 2380042 INFO (jetty-launcher-2280-thread-4)
[n:127.0.0.1:37256_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 2380076 INFO (jetty-launcher-2280-thread-4)
[n:127.0.0.1:37256_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2380078 INFO (jetty-launcher-2280-thread-4)
[n:127.0.0.1:37256_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:37256_solr
[junit4] 2> 2380103 INFO
(zkCallback-2316-thread-1-processing-n:127.0.0.1:40831_solr)
[n:127.0.0.1:40831_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2380105 INFO (jetty-launcher-2280-thread-2)
[n:127.0.0.1:39778_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39778.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@678644ba
[junit4] 2> 2380111 INFO
(zkCallback-2300-thread-2-processing-n:127.0.0.1:44302_solr)
[n:127.0.0.1:44302_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2380141 INFO (jetty-launcher-2280-thread-3)
[n:127.0.0.1:44302_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_44302.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@678644ba
[junit4] 2> 2380156 INFO
(zkCallback-2314-thread-1-processing-n:127.0.0.1:39778_solr)
[n:127.0.0.1:39778_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2380195 INFO (jetty-launcher-2280-thread-2)
[n:127.0.0.1:39778_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39778.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@678644ba
[junit4] 2> 2380195 INFO (jetty-launcher-2280-thread-2)
[n:127.0.0.1:39778_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39778.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@678644ba
[junit4] 2> 2380209 INFO
(zkCallback-2302-thread-1-processing-n:127.0.0.1:37256_solr)
[n:127.0.0.1:37256_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2380230 INFO (jetty-launcher-2280-thread-3)
[n:127.0.0.1:44302_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_44302.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@678644ba
[junit4] 2> 2380230 INFO (jetty-launcher-2280-thread-3)
[n:127.0.0.1:44302_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_44302.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@678644ba
[junit4] 2> 2380231 INFO (jetty-launcher-2280-thread-3)
[n:127.0.0.1:44302_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/J1/temp/solr.cloud.TestUtilizeNode_232BF95961C8BCC-001/tempDir-001/node3/.
[junit4] 2> 2380249 INFO (jetty-launcher-2280-thread-2)
[n:127.0.0.1:39778_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/J1/temp/solr.cloud.TestUtilizeNode_232BF95961C8BCC-001/tempDir-001/node2/.
[junit4] 2> 2380718 INFO (jetty-launcher-2280-thread-4)
[n:127.0.0.1:37256_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37256.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@678644ba
[junit4] 2> 2380757 INFO (jetty-launcher-2280-thread-4)
[n:127.0.0.1:37256_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37256.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@678644ba
[junit4] 2> 2380790 INFO (jetty-launcher-2280-thread-4)
[n:127.0.0.1:37256_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37256.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@678644ba
[junit4] 2> 2380792 INFO (jetty-launcher-2280-thread-4)
[n:127.0.0.1:37256_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/J1/temp/solr.cloud.TestUtilizeNode_232BF95961C8BCC-001/tempDir-001/node4/.
[junit4] 2> 2381088 INFO (zkConnectionManagerCallback-2325-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2381136 INFO (zkConnectionManagerCallback-2329-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2381218 INFO
(SUITE-TestUtilizeNode-seed#[232BF95961C8BCC]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 2381218 INFO
(SUITE-TestUtilizeNode-seed#[232BF95961C8BCC]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36976/solr ready
[junit4] 2> 2381327 INFO (qtp1652280324-10169) [n:127.0.0.1:40831_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with
params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 2381585 INFO (qtp1652280324-10169) [n:127.0.0.1:40831_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=257
[junit4] 2> 2382474 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [ ] o.a.s.SolrTestCaseJ4
###Starting test
[junit4] 2> 2382579 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 2382700 INFO (zkConnectionManagerCallback-2332-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2382707 INFO (qtp1652280324-10194) [n:127.0.0.1:40831_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> 2382726 INFO
(OverseerThreadFactory-3333-thread-2-processing-n:127.0.0.1:44302_solr)
[n:127.0.0.1:44302_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
utilizenodecoll
[junit4] 2> 2382726 INFO
(OverseerCollectionConfigSetProcessor-72157645504643080-127.0.0.1:44302_solr-n_0000000000)
[n:127.0.0.1:44302_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> 2382967 INFO
(OverseerStateUpdate-72157645504643080-127.0.0.1:44302_solr-n_0000000000)
[n:127.0.0.1:44302_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":"http://127.0.0.1:39778/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2383053 INFO
(OverseerStateUpdate-72157645504643080-127.0.0.1:44302_solr-n_0000000000)
[n:127.0.0.1:44302_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":"http://127.0.0.1:40831/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2383066 INFO
(OverseerStateUpdate-72157645504643080-127.0.0.1:44302_solr-n_0000000000)
[n:127.0.0.1:44302_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":"http://127.0.0.1:44302/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2383067 INFO
(OverseerStateUpdate-72157645504643080-127.0.0.1:44302_solr-n_0000000000)
[n:127.0.0.1:44302_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_n5",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:37256/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2383272 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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> 2383347 INFO (qtp163816418-10168) [n:127.0.0.1:39778_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 2383367 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&newCollection=true&name=utilizenodecoll_shard2_replica_n4&action=CREATE&numShards=2&collection=utilizenodecoll&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2383368 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 2383385 INFO (qtp1652280324-10195) [n:127.0.0.1:40831_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node6&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> 2383386 INFO (qtp1652280324-10195) [n:127.0.0.1:40831_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 2383386 INFO (qtp1484338554-10182) [n:127.0.0.1:37256_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_n5&action=CREATE&numShards=2&collection=utilizenodecoll&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2383399 INFO (qtp1484338554-10182) [n:127.0.0.1:37256_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 2383598 INFO
(zkCallback-2314-thread-1-processing-n:127.0.0.1:39778_solr)
[n:127.0.0.1:39778_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> 2383599 INFO
(zkCallback-2316-thread-1-processing-n:127.0.0.1:40831_solr)
[n:127.0.0.1:40831_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> 2383599 INFO
(zkCallback-2300-thread-2-processing-n:127.0.0.1:44302_solr)
[n:127.0.0.1:44302_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> 2383599 INFO
(zkCallback-2300-thread-1-processing-n:127.0.0.1:44302_solr)
[n:127.0.0.1:44302_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> 2383605 INFO
(zkCallback-2302-thread-1-processing-n:127.0.0.1:37256_solr)
[n:127.0.0.1:37256_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> 2383614 INFO
(zkCallback-2314-thread-2-processing-n:127.0.0.1:39778_solr)
[n:127.0.0.1:39778_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> 2383616 INFO
(zkCallback-2302-thread-2-processing-n:127.0.0.1:37256_solr)
[n:127.0.0.1:37256_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> 2383616 INFO
(zkCallback-2316-thread-2-processing-n:127.0.0.1:40831_solr)
[n:127.0.0.1:40831_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> 2384554 INFO (qtp1652280324-10195) [n:127.0.0.1:40831_solr
c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2384563 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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> 2384578 INFO (qtp1484338554-10182) [n:127.0.0.1:37256_solr
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2384582 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_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> 2384600 INFO (qtp1652280324-10195) [n:127.0.0.1:40831_solr
c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2]
o.a.s.s.IndexSchema [utilizenodecoll_shard1_replica_n2] Schema
name=cloud-dynamic
[junit4] 2> 2384675 INFO (qtp1484338554-10182) [n:127.0.0.1:37256_solr
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5]
o.a.s.s.IndexSchema [utilizenodecoll_shard2_replica_n5] Schema
name=cloud-dynamic
[junit4] 2> 2384686 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_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> 2384695 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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> 2384742 INFO (qtp1652280324-10195) [n:127.0.0.1:40831_solr
c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2]
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 2384742 INFO (qtp1652280324-10195) [n:127.0.0.1:40831_solr
c:utilizenodecoll s:shard1 r:core_node6 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> 2384743 INFO (qtp1652280324-10195) [n:127.0.0.1:40831_solr
c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40831.solr.core.utilizenodecoll.shard1.replica_n2' (registry
'solr.core.utilizenodecoll.shard1.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@678644ba
[junit4] 2> 2384743 INFO (qtp1652280324-10195) [n:127.0.0.1:40831_solr
c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2384743 INFO (qtp1652280324-10195) [n:127.0.0.1:40831_solr
c:utilizenodecoll s:shard1 r:core_node6 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/test/J1/temp/solr.cloud.TestUtilizeNode_232BF95961C8BCC-001/tempDir-001/node1/utilizenodecoll_shard1_replica_n2],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestUtilizeNode_232BF95961C8BCC-001/tempDir-001/node1/./utilizenodecoll_shard1_replica_n2/data/]
[junit4] 2> 2384965 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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> 2384965 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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> 2384966 INFO (qtp163816418-10168) [n:127.0.0.1:39778_solr
c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39778.solr.core.utilizenodecoll.shard1.replica_n1' (registry
'solr.core.utilizenodecoll.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@678644ba
[junit4] 2> 2384966 INFO (qtp163816418-10168) [n:127.0.0.1:39778_solr
c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2384966 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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/test/J1/temp/solr.cloud.TestUtilizeNode_232BF95961C8BCC-001/tempDir-001/node2/utilizenodecoll_shard1_replica_n1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestUtilizeNode_232BF95961C8BCC-001/tempDir-001/node2/./utilizenodecoll_shard1_replica_n1/data/]
[junit4] 2> 2385057 INFO (qtp1484338554-10182) [n:127.0.0.1:37256_solr
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5]
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 2385057 INFO (qtp1484338554-10182) [n:127.0.0.1:37256_solr
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5]
o.a.s.c.CoreContainer Creating SolrCore 'utilizenodecoll_shard2_replica_n5'
using configuration from collection utilizenodecoll, trusted=true
[junit4] 2> 2385057 INFO (qtp1484338554-10182) [n:127.0.0.1:37256_solr
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37256.solr.core.utilizenodecoll.shard2.replica_n5' (registry
'solr.core.utilizenodecoll.shard2.replica_n5') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@678644ba
[junit4] 2> 2385073 INFO (qtp1484338554-10182) [n:127.0.0.1:37256_solr
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2385074 INFO (qtp1484338554-10182) [n:127.0.0.1:37256_solr
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5]
o.a.s.c.SolrCore [[utilizenodecoll_shard2_replica_n5] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestUtilizeNode_232BF95961C8BCC-001/tempDir-001/node4/utilizenodecoll_shard2_replica_n5],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestUtilizeNode_232BF95961C8BCC-001/tempDir-001/node4/./utilizenodecoll_shard2_replica_n5/data/]
[junit4] 2> 2385109 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_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> 2385109 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_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> 2385110 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_solr
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_44302.solr.core.utilizenodecoll.shard2.replica_n4' (registry
'solr.core.utilizenodecoll.shard2.replica_n4') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@678644ba
[junit4] 2> 2385110 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_solr
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2385110 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_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/test/J1/temp/solr.cloud.TestUtilizeNode_232BF95961C8BCC-001/tempDir-001/node3/utilizenodecoll_shard2_replica_n4],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.TestUtilizeNode_232BF95961C8BCC-001/tempDir-001/node3/./utilizenodecoll_shard2_replica_n4/data/]
[junit4] 2> 2385330 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_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> 2385330 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_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> 2385331 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_solr
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2385331 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_solr
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2385332 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_solr
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@5201432c[utilizenodecoll_shard2_replica_n4] main]
[junit4] 2> 2385362 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_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> 2385362 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_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> 2385362 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_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> 2385363 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_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 1592985407733104640
[junit4] 2> 2385378 INFO
(searcherExecutor-3345-thread-1-processing-n:127.0.0.1:44302_solr
x:utilizenodecoll_shard2_replica_n4 s:shard2 c:utilizenodecoll r:core_node7)
[n:127.0.0.1:44302_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@5201432c[utilizenodecoll_shard2_replica_n4]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2385395 INFO (qtp1484338554-10182) [n:127.0.0.1:37256_solr
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 2385395 INFO (qtp1484338554-10182) [n:127.0.0.1:37256_solr
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2385396 INFO (qtp1484338554-10182) [n:127.0.0.1:37256_solr
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2385396 INFO (qtp1484338554-10182) [n:127.0.0.1:37256_solr
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2385398 INFO (qtp1484338554-10182) [n:127.0.0.1:37256_solr
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@30f23516[utilizenodecoll_shard2_replica_n5] main]
[junit4] 2> 2385416 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_solr
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shard2: total=2 found=1 timeoutin=9999ms
[junit4] 2> 2385416 INFO (qtp1484338554-10182) [n:127.0.0.1:37256_solr
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 2385416 INFO (qtp1484338554-10182) [n:127.0.0.1:37256_solr
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2385417 INFO (qtp1484338554-10182) [n:127.0.0.1:37256_solr
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2385418 INFO
(searcherExecutor-3344-thread-1-processing-n:127.0.0.1:37256_solr
x:utilizenodecoll_shard2_replica_n5 s:shard2 c:utilizenodecoll r:core_node8)
[n:127.0.0.1:37256_solr c:utilizenodecoll s:shard2 r:core_node8
x:utilizenodecoll_shard2_replica_n5] o.a.s.c.SolrCore
[utilizenodecoll_shard2_replica_n5] Registered new searcher
Searcher@30f23516[utilizenodecoll_shard2_replica_n5]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2385418 INFO (qtp1484338554-10182) [n:127.0.0.1:37256_solr
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1592985407790776320
[junit4] 2> 2385435 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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> 2385435 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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> 2385437 INFO (qtp163816418-10168) [n:127.0.0.1:39778_solr
c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2385437 INFO (qtp163816418-10168) [n:127.0.0.1:39778_solr
c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2385451 INFO (qtp163816418-10168) [n:127.0.0.1:39778_solr
c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@419e63a0[utilizenodecoll_shard1_replica_n1] main]
[junit4] 2> 2385452 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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> 2385453 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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> 2385453 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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> 2385453 INFO (qtp163816418-10168) [n:127.0.0.1:39778_solr
c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1592985407827476480
[junit4] 2> 2385454 INFO
(searcherExecutor-3343-thread-1-processing-n:127.0.0.1:39778_solr
x:utilizenodecoll_shard1_replica_n1 s:shard1 c:utilizenodecoll r:core_node3)
[n:127.0.0.1:39778_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@419e63a0[utilizenodecoll_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2385477 INFO (qtp1652280324-10195) [n:127.0.0.1:40831_solr
c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 2385477 INFO (qtp1652280324-10195) [n:127.0.0.1:40831_solr
c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2385478 INFO (qtp1652280324-10195) [n:127.0.0.1:40831_solr
c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2385478 INFO (qtp1652280324-10195) [n:127.0.0.1:40831_solr
c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2385485 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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> 2385504 INFO (qtp1652280324-10195) [n:127.0.0.1:40831_solr
c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@794ef231[utilizenodecoll_shard1_replica_n2] main]
[junit4] 2> 2385505 INFO (qtp1652280324-10195) [n:127.0.0.1:40831_solr
c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 2385505 INFO (qtp1652280324-10195) [n:127.0.0.1:40831_solr
c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2385506 INFO (qtp1652280324-10195) [n:127.0.0.1:40831_solr
c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2385506 INFO (qtp1652280324-10195) [n:127.0.0.1:40831_solr
c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1592985407883051008
[junit4] 2> 2385507 INFO
(searcherExecutor-3342-thread-1-processing-n:127.0.0.1:40831_solr
x:utilizenodecoll_shard1_replica_n2 s:shard1 c:utilizenodecoll r:core_node6)
[n:127.0.0.1:40831_solr c:utilizenodecoll s:shard1 r:core_node6
x:utilizenodecoll_shard1_replica_n2] o.a.s.c.SolrCore
[utilizenodecoll_shard1_replica_n2] Registered new searcher
Searcher@794ef231[utilizenodecoll_shard1_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2385589 INFO
(zkCallback-2302-thread-2-processing-n:127.0.0.1:37256_solr)
[n:127.0.0.1:37256_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> 2385589 INFO
(zkCallback-2314-thread-1-processing-n:127.0.0.1:39778_solr)
[n:127.0.0.1:39778_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> 2385589 INFO
(zkCallback-2302-thread-1-processing-n:127.0.0.1:37256_solr)
[n:127.0.0.1:37256_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> 2385590 INFO
(zkCallback-2300-thread-3-processing-n:127.0.0.1:44302_solr)
[n:127.0.0.1:44302_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> 2385590 INFO
(zkCallback-2300-thread-1-processing-n:127.0.0.1:44302_solr)
[n:127.0.0.1:44302_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> 2385590 INFO
(zkCallback-2316-thread-1-processing-n:127.0.0.1:40831_solr)
[n:127.0.0.1:40831_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> 2385590 INFO
(zkCallback-2316-thread-2-processing-n:127.0.0.1:40831_solr)
[n:127.0.0.1:40831_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> 2385590 INFO
(zkCallback-2314-thread-2-processing-n:127.0.0.1:39778_solr)
[n:127.0.0.1:39778_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> 2385916 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_solr
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2385916 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_solr
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 2385917 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_solr
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:44302/solr/utilizenodecoll_shard2_replica_n4/
[junit4] 2> 2385917 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_solr
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4]
o.a.s.u.PeerSync PeerSync: core=utilizenodecoll_shard2_replica_n4
url=http://127.0.0.1:44302/solr START
replicas=[http://127.0.0.1:37256/solr/utilizenodecoll_shard2_replica_n5/]
nUpdates=100
[junit4] 2> 2385924 INFO (qtp1484338554-10189) [n:127.0.0.1:37256_solr
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5]
o.a.s.c.S.Request [utilizenodecoll_shard2_replica_n5] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=1
[junit4] 2> 2385986 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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> 2385986 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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> 2385986 INFO (qtp163816418-10168) [n:127.0.0.1:39778_solr
c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:39778/solr/utilizenodecoll_shard1_replica_n1/
[junit4] 2> 2385986 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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=http://127.0.0.1:39778/solr START
replicas=[http://127.0.0.1:40831/solr/utilizenodecoll_shard1_replica_n2/]
nUpdates=100
[junit4] 2> 2385990 INFO (qtp1652280324-10196) [n:127.0.0.1:40831_solr
c:utilizenodecoll s:shard1 r:core_node6 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=2
[junit4] 2> 2386217 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_solr
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4]
o.a.s.u.PeerSync PeerSync: core=utilizenodecoll_shard2_replica_n4
url=http://127.0.0.1:44302/solr DONE. We have no versions. sync failed.
[junit4] 2> 2386218 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_solr
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 2386218 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_solr
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4]
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> 2386218 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_solr
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 2386221 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_solr
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:44302/solr/utilizenodecoll_shard2_replica_n4/ shard2
[junit4] 2> 2386287 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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=http://127.0.0.1:39778/solr DONE. We have no versions. sync failed.
[junit4] 2> 2386287 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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> 2386287 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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> 2386287 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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> 2386290 INFO (qtp163816418-10168) [n:127.0.0.1:39778_solr
c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:39778/solr/utilizenodecoll_shard1_replica_n1/ shard1
[junit4] 2> 2386391 INFO
(zkCallback-2302-thread-1-processing-n:127.0.0.1:37256_solr)
[n:127.0.0.1:37256_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> 2386391 INFO
(zkCallback-2316-thread-1-processing-n:127.0.0.1:40831_solr)
[n:127.0.0.1:40831_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> 2386391 INFO
(zkCallback-2302-thread-2-processing-n:127.0.0.1:37256_solr)
[n:127.0.0.1:37256_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> 2386391 INFO
(zkCallback-2314-thread-1-processing-n:127.0.0.1:39778_solr)
[n:127.0.0.1:39778_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> 2386391 INFO
(zkCallback-2300-thread-3-processing-n:127.0.0.1:44302_solr)
[n:127.0.0.1:44302_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> 2386391 INFO
(zkCallback-2316-thread-2-processing-n:127.0.0.1:40831_solr)
[n:127.0.0.1:40831_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> 2386391 INFO
(zkCallback-2300-thread-1-processing-n:127.0.0.1:44302_solr)
[n:127.0.0.1:44302_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> 2386391 INFO
(zkCallback-2314-thread-2-processing-n:127.0.0.1:39778_solr)
[n:127.0.0.1:39778_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> 2386422 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_solr
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 2386424 INFO (qtp1775104451-10171) [n:127.0.0.1:44302_solr
c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&newCollection=true&name=utilizenodecoll_shard2_replica_n4&action=CREATE&numShards=2&collection=utilizenodecoll&shard=shard2&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=3073
[junit4] 2> 2386441 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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> 2386442 INFO (qtp163816418-10168) [n:127.0.0.1:39778_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.configName=conf1&newCollection=true&name=utilizenodecoll_shard1_replica_n1&action=CREATE&numShards=2&collection=utilizenodecoll&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=3170
[junit4] 2> 2386469 INFO (qtp1484338554-10182) [n:127.0.0.1:37256_solr
c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true&name=utilizenodecoll_shard2_replica_n5&action=CREATE&numShards=2&collection=utilizenodecoll&shard=shard2&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=3083
[junit4] 2> 2386534 INFO (qtp1652280324-10195) [n:127.0.0.1:40831_solr
c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf1&newCollection=true&name=utilizenodecoll_shard1_replica_n2&action=CREATE&numShards=2&collection=utilizenodecoll&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=3148
[junit4] 2> 2386541 INFO (qtp1652280324-10194) [n:127.0.0.1:40831_solr
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 2386638 INFO
(zkCallback-2302-thread-2-processing-n:127.0.0.1:37256_solr)
[n:127.0.0.1:37256_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> 2386638 INFO
(zkCallback-2316-thread-1-processing-n:127.0.0.1:40831_solr)
[n:127.0.0.1:40831_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> 2386638 INFO
(zkCallback-2302-thread-1-processing-n:127.0.0.1:37256_solr)
[n:127.0.0.1:37256_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> 2386638 INFO
(zkCallback-2314-thread-2-processing-n:127.0.0.1:39778_solr)
[n:127.0.0.1:39778_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> 2386638 INFO
(zkCallback-2316-thread-2-processing-n:127.0.0.1:40831_solr)
[n:127.0.0.1:40831_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> 2386638 INFO
(zkCallback-2314-thread-1-processing-n:127.0.0.1:39778_solr)
[n:127.0.0.1:39778_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> 2386639 INFO
(zkCallback-2300-thread-1-processing-n:127.0.0.1:44302_solr)
[n:127.0.0.1:44302_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> 2386639 INFO
(zkCallback-2300-thread-3-processing-n:127.0.0.1:44302_solr)
[n:127.0.0.1:44302_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> 2386740 INFO
(OverseerCollectionConfigSetProcessor-72157645504643080-127.0.0.1:44302_solr-n_0000000000)
[n:127.0.0.1:44302_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 2387551 INFO (qtp1652280324-10194) [n:127.0.0.1:40831_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=2&collection.configName=conf1&name=utilizenodecoll&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2}
status=0 QTime=4844
[junit4] 2> 2387564 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [ ] o.e.j.s.Server
jetty-9.4.8.v20171121, build timestamp: 2017-11-21T16:27:37-05:00, git hash:
82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2387601 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [ ] o.e.j.s.session
DefaultSessionIdManager workerName=node0
[junit4] 2> 2387601 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [ ] o.e.j.s.session No
SessionScavenger set, using defaults
[junit4] 2> 2387601 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [ ] o.e.j.s.session
Scavenging every 600000ms
[junit4] 2> 2387602 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1f12e52f{/solr,null,AVAILABLE}
[junit4] 2> 2387602 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@137f9c4b{HTTP/1.1,[http/1.1]}{127.0.0.1:34279}
[junit4] 2> 2387602 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [ ] o.e.j.s.Server
Started @2398060ms
[junit4] 2> 2387602 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=34279}
[junit4] 2> 2387602 ERROR
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2387603 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.0.0
[junit4] 2> 2387603 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2387603 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2387603 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-02-21T05:01:12.005Z
[junit4] 2> 2387710 INFO (zkConnectionManagerCallback-2334-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2387730 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2387801 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [ ] o.a.s.c.ZkContainer
Zookeeper client=127.0.0.1:36976/solr
[junit4] 2> 2387853 INFO (zkConnectionManagerCallback-2338-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2387877 INFO
(zkConnectionManagerCallback-2340-thread-1-processing-n:127.0.0.1:34279_solr)
[n:127.0.0.1:34279_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2387927 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [n:127.0.0.1:34279_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 2387928 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [n:127.0.0.1:34279_solr ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2387942 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [n:127.0.0.1:34279_solr ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:34279_solr
[junit4] 2> 2387962 INFO
(zkCallback-2302-thread-1-processing-n:127.0.0.1:37256_solr)
[n:127.0.0.1:37256_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (5)
[junit4] 2> 2387966 INFO
(zkCallback-2314-thread-1-processing-n:127.0.0.1:39778_solr)
[n:127.0.0.1:39778_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (5)
[junit4] 2> 2387966 INFO
(zkCallback-2316-thread-1-processing-n:127.0.0.1:40831_solr)
[n:127.0.0.1:40831_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (5)
[junit4] 2> 2387966 INFO (zkCallback-2328-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2387967 INFO (zkCallback-2328-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2387978 INFO
(zkCallback-2300-thread-3-processing-n:127.0.0.1:44302_solr)
[n:127.0.0.1:44302_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (5)
[junit4] 2> 2388011 INFO
(zkCallback-2339-thread-1-processing-n:127.0.0.1:34279_solr)
[n:127.0.0.1:34279_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (5)
[junit4] 2> 2388445 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [n:127.0.0.1:34279_solr ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34279.solr.node' (registry
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@678644ba
[junit4] 2> 2388500 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [n:127.0.0.1:34279_solr ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34279.solr.jvm' (registry
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@678644ba
[junit4] 2> 2388500 INFO
(TEST-TestUtilizeNode.test-seed#[232BF95961C8BCC]) [n:127.0.0.1:34279_solr ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34279.solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbea
[...truncated too long message...]
EAE1E10A]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer
instance=1244992770
[junit4] 2> 68077 INFO
(TEST-TestLBHttpSolrClient.testReliability-seed#[CFA3DBE1EAE1E10A]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 68077 INFO
(TEST-TestLBHttpSolrClient.testReliability-seed#[CFA3DBE1EAE1E10A]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@30edef01: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@4219d5b5
[junit4] 2> 68079 INFO
(TEST-TestLBHttpSolrClient.testReliability-seed#[CFA3DBE1EAE1E10A]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 68079 INFO
(TEST-TestLBHttpSolrClient.testReliability-seed#[CFA3DBE1EAE1E10A]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@78934828: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@363f6c28
[junit4] 2> 68079 INFO
(TEST-TestLBHttpSolrClient.testReliability-seed#[CFA3DBE1EAE1E10A]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 68079 INFO
(TEST-TestLBHttpSolrClient.testReliability-seed#[CFA3DBE1EAE1E10A]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@ed6f823: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@c84fdc1
[junit4] 2> 68101 INFO (coreCloseExecutor-301-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@13780780
[junit4] 2> 68101 INFO (coreCloseExecutor-301-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=326633344
[junit4] 2> 68101 INFO (coreCloseExecutor-301-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5873f584: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@695e16c2
[junit4] 2> 68186 INFO
(TEST-TestLBHttpSolrClient.testReliability-seed#[CFA3DBE1EAE1E10A]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@4128e52d{/solr,null,UNAVAILABLE}
[junit4] 2> 68186 INFO
(TEST-TestLBHttpSolrClient.testReliability-seed#[CFA3DBE1EAE1E10A]) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 98199 WARN
(TEST-TestLBHttpSolrClient.testReliability-seed#[CFA3DBE1EAE1E10A]) [ ]
o.e.j.u.t.QueuedThreadPool
QueuedThreadPool@qtp806744391{STOPPING,8<=8<=10000,i=0,q=1} Couldn't stop
Thread[qtp806744391-711,5,TGRP-TestLBHttpSolrClient]
[junit4] 2> 98201 INFO
(TEST-TestLBHttpSolrClient.testReliability-seed#[CFA3DBE1EAE1E10A]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testReliability
[junit4] 2> 98215 INFO
(SUITE-TestLBHttpSolrClient-seed#[CFA3DBE1EAE1E10A]-worker) [ ]
o.a.s.SolrTestCaseJ4 -------------------------------------------------------
Done waiting for tracked resources to be released
[junit4] 2> Feb 21, 2018 5:48:29 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> Feb 21, 2018 5:48:49 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> SEVERE: 1 thread leaked from SUITE scope at
org.apache.solr.client.solrj.TestLBHttpSolrClient:
[junit4] 2> 1) Thread[id=711, name=qtp806744391-711,
state=TIMED_WAITING, group=TGRP-TestLBHttpSolrClient]
[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> Feb 21, 2018 5:48:49 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=711, name=qtp806744391-711,
state=TIMED_WAITING, group=TGRP-TestLBHttpSolrClient]
[junit4] 2> Feb 21, 2018 5:48:53 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> SEVERE: There are still zombie threads that couldn't be
terminated:
[junit4] 2> 1) Thread[id=711, name=qtp806744391-711,
state=TIMED_WAITING, group=TGRP-TestLBHttpSolrClient]
[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):
{name=PostingsFormat(name=Direct), id=PostingsFormat(name=Direct)},
docValues:{}, maxPointsInLeafNode=2027, maxMBSortInHeap=6.2956608669212235,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@7d118aa),
locale=zh-HK, timezone=PST8PDT
[junit4] 2> NOTE: Linux 4.4.0-112-generic amd64/Oracle Corporation
1.8.0_152 (64-bit)/cpus=4,threads=4,free=219802744,total=334495744
[junit4] 2> NOTE: All tests run in this JVM: [TestUpdateRequestCodec,
FloorEvaluatorTest, HttpSolrClientSSLAuthConPoolTest, SolrPingTest,
TestV2Request, UniformDistributionEvaluatorTest,
CloudSolrClientMultiConstructorTest, AppendEvaluatorTest, SolrQueryTest,
CollectionAdminRequestRequiredParamsTest, GraphTest, FacetFieldTest,
StreamExpressionToExpessionTest, CeilingEvaluatorTest, SubtractEvaluatorTest,
HyperbolicCosineEvaluatorTest, TestLBHttpSolrClient]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestLBHttpSolrClient -Dtests.seed=CFA3DBE1EAE1E10A
-Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=zh-HK
-Dtests.timezone=PST8PDT -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J1 | TestLBHttpSolrClient (suite) <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.client.solrj.TestLBHttpSolrClient:
[junit4] > 1) Thread[id=711, name=qtp806744391-711,
state=TIMED_WAITING, group=TGRP-TestLBHttpSolrClient]
[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([CFA3DBE1EAE1E10A]:0)Throwable #2:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=711, name=qtp806744391-711,
state=TIMED_WAITING, group=TGRP-TestLBHttpSolrClient]
[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([CFA3DBE1EAE1E10A]:0)
[junit4] Completed [34/146 (1!)] on J1 in 81.72s, 3 tests, 2 errors <<<
FAILURES!
[...truncated 47835 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
