Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/22634/
Java: 64bit/jdk-11-ea+25 -XX:+UseCompressedOops -XX:+UseParallelGC
5 tests failed.
FAILED:
junit.framework.TestSuite.org.apache.solr.client.solrj.io.stream.StreamingTest
Error Message:
4 threads leaked from SUITE scope at
org.apache.solr.client.solrj.io.stream.StreamingTest: 1) Thread[id=1957,
name=Thread-466-EventThread, state=WAITING, group=TGRP-StreamingTest]
at java.base@11-ea/jdk.internal.misc.Unsafe.park(Native Method) at
java.base@11-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
at
java.base@11-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
at
java.base@11-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
at
app//org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:502) 2)
Thread[id=2010, name=Connection evictor, state=TIMED_WAITING,
group=TGRP-StreamingTest] at
java.base@11-ea/java.lang.Thread.sleep(Native Method) at
app//org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
at java.base@11-ea/java.lang.Thread.run(Thread.java:834) 3)
Thread[id=1956, name=Thread-466-SendThread(127.0.0.1:45347),
state=TIMED_WAITING, group=TGRP-StreamingTest] at
java.base@11-ea/java.lang.Thread.sleep(Native Method) at
app//org.apache.zookeeper.client.StaticHostProvider.next(StaticHostProvider.java:105)
at
app//org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:1000)
at
app//org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1063) 4)
Thread[id=1958, name=zkConnectionManagerCallback-517-thread-1, state=WAITING,
group=TGRP-StreamingTest] at
java.base@11-ea/jdk.internal.misc.Unsafe.park(Native Method) at
java.base@11-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
at
java.base@11-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
at
java.base@11-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base@11-ea/java.lang.Thread.run(Thread.java:834)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE
scope at org.apache.solr.client.solrj.io.stream.StreamingTest:
1) Thread[id=1957, name=Thread-466-EventThread, state=WAITING,
group=TGRP-StreamingTest]
at java.base@11-ea/jdk.internal.misc.Unsafe.park(Native Method)
at
java.base@11-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
at
java.base@11-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
at
java.base@11-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
at
app//org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:502)
2) Thread[id=2010, name=Connection evictor, state=TIMED_WAITING,
group=TGRP-StreamingTest]
at java.base@11-ea/java.lang.Thread.sleep(Native Method)
at
app//org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
at java.base@11-ea/java.lang.Thread.run(Thread.java:834)
3) Thread[id=1956, name=Thread-466-SendThread(127.0.0.1:45347),
state=TIMED_WAITING, group=TGRP-StreamingTest]
at java.base@11-ea/java.lang.Thread.sleep(Native Method)
at
app//org.apache.zookeeper.client.StaticHostProvider.next(StaticHostProvider.java:105)
at
app//org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:1000)
at
app//org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1063)
4) Thread[id=1958, name=zkConnectionManagerCallback-517-thread-1,
state=WAITING, group=TGRP-StreamingTest]
at java.base@11-ea/jdk.internal.misc.Unsafe.park(Native Method)
at
java.base@11-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
at
java.base@11-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
at
java.base@11-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base@11-ea/java.lang.Thread.run(Thread.java:834)
at __randomizedtesting.SeedInfo.seed([56578F710DDE5771]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.client.solrj.io.stream.StreamingTest
Error Message:
There are still zombie threads that couldn't be terminated: 1)
Thread[id=1956, name=Thread-466-SendThread(127.0.0.1:45347),
state=TIMED_WAITING, group=TGRP-StreamingTest] at
java.base@11-ea/java.lang.Thread.sleep(Native Method) at
app//org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1054) 2)
Thread[id=1958, name=zkConnectionManagerCallback-517-thread-1, state=WAITING,
group=TGRP-StreamingTest] at
java.base@11-ea/jdk.internal.misc.Unsafe.park(Native Method) at
java.base@11-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
at
java.base@11-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
at
java.base@11-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base@11-ea/java.lang.Thread.run(Thread.java:834)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
1) Thread[id=1956, name=Thread-466-SendThread(127.0.0.1:45347),
state=TIMED_WAITING, group=TGRP-StreamingTest]
at java.base@11-ea/java.lang.Thread.sleep(Native Method)
at
app//org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1054)
2) Thread[id=1958, name=zkConnectionManagerCallback-517-thread-1,
state=WAITING, group=TGRP-StreamingTest]
at java.base@11-ea/jdk.internal.misc.Unsafe.park(Native Method)
at
java.base@11-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
at
java.base@11-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
at
java.base@11-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base@11-ea/java.lang.Thread.run(Thread.java:834)
at __randomizedtesting.SeedInfo.seed([56578F710DDE5771]:0)
FAILED:
org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClientTest.testConcurrentUpdate
Error Message:
Expected no errors but got 1, due to: javax.net.ssl.SSLException: Received
fatal alert: internal_error
Stack Trace:
java.lang.AssertionError: Expected no errors but got 1, due to:
javax.net.ssl.SSLException: Received fatal alert: internal_error
at
__randomizedtesting.SeedInfo.seed([56578F710DDE5771:AE51D68AD9E6323A]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClientTest.testConcurrentUpdate(ConcurrentUpdateSolrClientTest.java:183)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
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
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:834)
FAILED: org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testNodeAdded
Error Message:
Timed out waiting for replicas of new collection to be active null Live Nodes:
[127.0.0.1:41975_solr] Last available state: null
Stack Trace:
java.lang.AssertionError: Timed out waiting for replicas of new collection to
be active
null
Live Nodes: [127.0.0.1:41975_solr]
Last available state: null
at
__randomizedtesting.SeedInfo.seed([325FF67B6842931:66E6A91014278132]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.SolrCloudTestCase.waitForState(SolrCloudTestCase.java:280)
at
org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testNodeAdded(ComputePlanActionTest.java:352)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
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
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:834)
FAILED:
org.apache.solr.client.solrj.io.stream.StreamingTest.testDaemonTopicStream
Error Message:
params qt=/get&ids=50000000&fl=id&wt=javabin
Stack Trace:
java.io.IOException: params qt=/get&ids=50000000&fl=id&wt=javabin
at
__randomizedtesting.SeedInfo.seed([56578F710DDE5771:C5F574E019D5BF27]:0)
at
org.apache.solr.client.solrj.io.stream.SolrStream.open(SolrStream.java:111)
at
org.apache.solr.client.solrj.io.stream.StreamingTest.getTuples(StreamingTest.java:2360)
at
org.apache.solr.client.solrj.io.stream.StreamingTest.testDaemonTopicStream(StreamingTest.java:1743)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
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
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:834)
Caused by: org.apache.solr.client.solrj.SolrServerException: IOException
occured when talking to server at: https://127.0.0.1:34899/solr/streams
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:657)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
at
org.apache.solr.client.solrj.io.stream.SolrStream.constructParser(SolrStream.java:265)
at
org.apache.solr.client.solrj.io.stream.SolrStream.open(SolrStream.java:109)
... 40 more
Caused by: javax.net.ssl.SSLException: Received fatal alert: internal_error
at java.base/sun.security.ssl.Alert.createSSLException(Alert.java:129)
at java.base/sun.security.ssl.Alert.createSSLException(Alert.java:117)
at
java.base/sun.security.ssl.TransportContext.fatal(TransportContext.java:312)
at
java.base/sun.security.ssl.Alert$AlertConsumer.consume(Alert.java:270)
at
java.base/sun.security.ssl.TransportContext.dispatch(TransportContext.java:181)
at java.base/sun.security.ssl.SSLTransport.decode(SSLTransport.java:164)
at
java.base/sun.security.ssl.SSLSocketImpl.decode(SSLSocketImpl.java:877)
at
java.base/sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:810)
at
java.base/sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:383)
at
org.apache.http.conn.ssl.SSLConnectionSocketFactory.createLayeredSocket(SSLConnectionSocketFactory.java:396)
at
org.apache.http.conn.ssl.SSLConnectionSocketFactory.connectSocket(SSLConnectionSocketFactory.java:355)
at
org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:142)
at
org.apache.http.impl.conn.PoolingHttpClientConnectionManager.connect(PoolingHttpClientConnectionManager.java:359)
at
org.apache.http.impl.execchain.MainClientExec.establishRoute(MainClientExec.java:381)
at
org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:237)
at
org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:185)
at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
at
org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:111)
at
org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:542)
... 45 more
Build Log:
[...truncated 13119 lines...]
[junit4] Suite: org.apache.solr.cloud.autoscaling.ComputePlanActionTest
[junit4] 2> 571136 INFO
(SUITE-ComputePlanActionTest-seed#[325FF67B6842931]-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/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ComputePlanActionTest_325FF67B6842931-001/init-core-data-001
[junit4] 2> 571136 INFO
(SUITE-ComputePlanActionTest-seed#[325FF67B6842931]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 571137 INFO
(SUITE-ComputePlanActionTest-seed#[325FF67B6842931]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0,
clientAuth=0.0/0.0)
[junit4] 2> 571137 INFO
(SUITE-ComputePlanActionTest-seed#[325FF67B6842931]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ComputePlanActionTest_325FF67B6842931-001/tempDir-001
[junit4] 2> 571137 INFO
(SUITE-ComputePlanActionTest-seed#[325FF67B6842931]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 571137 INFO (Thread-1007) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 571137 INFO (Thread-1007) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 571140 ERROR (Thread-1007) [ ] 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> 571238 INFO
(SUITE-ComputePlanActionTest-seed#[325FF67B6842931]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:45545
[junit4] 2> 571239 INFO (zkConnectionManagerCallback-1393-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 571257 INFO (jetty-launcher-1390-thread-1) [ ]
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git:
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 11-ea+25
[junit4] 2> 571257 INFO (jetty-launcher-1390-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 571257 INFO (jetty-launcher-1390-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 571257 INFO (jetty-launcher-1390-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 571257 INFO (jetty-launcher-1390-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@3ad669dd{/solr,null,AVAILABLE}
[junit4] 2> 571258 INFO (jetty-launcher-1390-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@6fde2632{SSL,[ssl,
http/1.1]}{127.0.0.1:41975}
[junit4] 2> 571258 INFO (jetty-launcher-1390-thread-1) [ ]
o.e.j.s.Server Started @571284ms
[junit4] 2> 571258 INFO (jetty-launcher-1390-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=41975}
[junit4] 2> 571258 ERROR (jetty-launcher-1390-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 571258 INFO (jetty-launcher-1390-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 571258 INFO (jetty-launcher-1390-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.0.0
[junit4] 2> 571258 INFO (jetty-launcher-1390-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 571258 INFO (jetty-launcher-1390-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 571258 INFO (jetty-launcher-1390-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-08-09T11:05:34.302684Z
[junit4] 2> 571259 INFO (zkConnectionManagerCallback-1395-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 571260 INFO (jetty-launcher-1390-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 571322 INFO (jetty-launcher-1390-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45545/solr
[junit4] 2> 571323 INFO (zkConnectionManagerCallback-1399-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 571324 INFO (zkConnectionManagerCallback-1401-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 571353 INFO (jetty-launcher-1390-thread-1)
[n:127.0.0.1:41975_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:41975_solr
[junit4] 2> 571354 INFO (jetty-launcher-1390-thread-1)
[n:127.0.0.1:41975_solr ] o.a.s.c.Overseer Overseer
(id=72130667926454275-127.0.0.1:41975_solr-n_0000000000) starting
[junit4] 2> 571357 INFO (zkConnectionManagerCallback-1408-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 571359 INFO (jetty-launcher-1390-thread-1)
[n:127.0.0.1:41975_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:45545/solr ready
[junit4] 2> 571359 INFO
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:41975_solr
[junit4] 2> 571359 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and
.scheduled_maintenance triggers
[junit4] 2> 571359 INFO (jetty-launcher-1390-thread-1)
[n:127.0.0.1:41975_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:41975_solr
[junit4] 2> 571360 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode
version 1
[junit4] 2> 571360 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion -1
[junit4] 2> 571360 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 1
[junit4] 2> 571360 INFO (zkCallback-1407-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 571360 INFO (zkCallback-1400-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 571362 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial
livenodes: [127.0.0.1:41975_solr]
[junit4] 2> 571364 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
[junit4] 2> 571365 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 1
[junit4] 2> 571365 DEBUG (ScheduledTrigger-1862-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 1
[junit4] 2> 571367 INFO (jetty-launcher-1390-thread-1)
[n:127.0.0.1:41975_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 571378 INFO (jetty-launcher-1390-thread-1)
[n:127.0.0.1:41975_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41975.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@511c3bc7
[junit4] 2> 571382 INFO (jetty-launcher-1390-thread-1)
[n:127.0.0.1:41975_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41975.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@511c3bc7
[junit4] 2> 571383 INFO (jetty-launcher-1390-thread-1)
[n:127.0.0.1:41975_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41975.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@511c3bc7
[junit4] 2> 571383 INFO (jetty-launcher-1390-thread-1)
[n:127.0.0.1:41975_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ComputePlanActionTest_325FF67B6842931-001/tempDir-001/node1/.
[junit4] 2> 571392 INFO (zkConnectionManagerCallback-1411-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 571394 INFO (zkConnectionManagerCallback-1416-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 571395 INFO
(SUITE-ComputePlanActionTest-seed#[325FF67B6842931]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 571396 INFO
(SUITE-ComputePlanActionTest-seed#[325FF67B6842931]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45545/solr ready
[junit4] 2> 571401 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[325FF67B6842931]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testNodeAdded
[junit4] 2> 571402 DEBUG (zkCallback-1407-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
2
[junit4] 2> 571402 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 2
[junit4] 2> 571402 INFO
(TEST-ComputePlanActionTest.testNodeAdded-seed#[325FF67B6842931]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 571403 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
[junit4] 2> 571403 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
[junit4] 2> 571403 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2,
lastZnodeVersion 2
[junit4] 2> 571430 INFO (qtp1026955163-4848) [n:127.0.0.1:41975_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 571431 DEBUG (qtp1026955163-4846) [n:127.0.0.1:41975_solr ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 571432 INFO (qtp1026955163-4846) [n:127.0.0.1:41975_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=16
[junit4] 2> 571432 DEBUG (zkCallback-1407-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
3
[junit4] 2> 571432 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 3
[junit4] 2> 571432 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
[junit4] 2> 571432 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
[junit4] 2> 571432 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3,
lastZnodeVersion 3
[junit4] 2> 571435 INFO (qtp1026955163-4889) [n:127.0.0.1:41975_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 571435 DEBUG (qtp1026955163-4844) [n:127.0.0.1:41975_solr ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 571435 INFO (qtp1026955163-4844) [n:127.0.0.1:41975_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=3
[junit4] 2> 571435 DEBUG (zkCallback-1407-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
4
[junit4] 2> 571435 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 4
[junit4] 2> 571436 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
[junit4] 2> 571436 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
[junit4] 2> 571436 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 4,
lastZnodeVersion 4
[junit4] 2> 571439 INFO (qtp1026955163-4848) [n:127.0.0.1:41975_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 571440 DEBUG (qtp1026955163-4846) [n:127.0.0.1:41975_solr ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 571440 INFO (qtp1026955163-4846) [n:127.0.0.1:41975_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=3
[junit4] 2> 571440 DEBUG (zkCallback-1407-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
5
[junit4] 2> 571440 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 5
[junit4] 2> 571441 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger -
Initial livenodes: [127.0.0.1:41975_solr]
[junit4] 2> 571441 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger
instantiated with properties: {event=nodeAdded, waitFor=1,
actions=[{name=compute_plan, class=solr.ComputePlanAction}, {name=test,
class=org.apache.solr.cloud.autoscaling.ComputePlanActionTest$AssertingTriggerAction}],
enabled=true}
[junit4] 2> 571442 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
[junit4] 2> 571442 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 5,
lastZnodeVersion 5
[junit4] 2> 571442 DEBUG (ScheduledTrigger-1862-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 571442 DEBUG (ScheduledTrigger-1862-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 571442 INFO (qtp1026955163-4889) [n:127.0.0.1:41975_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 571442 DEBUG (qtp1026955163-4844) [n:127.0.0.1:41975_solr ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 571443 INFO (qtp1026955163-4844) [n:127.0.0.1:41975_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 571443 DEBUG (zkCallback-1407-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
6
[junit4] 2> 571443 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 6
[junit4] 2> 571443 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
[junit4] 2> 571443 INFO (qtp1026955163-4846) [n:127.0.0.1:41975_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
collection.configName=conf&name=testNodeAdded&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 571443 DEBUG
(OverseerAutoScalingTriggerThread-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 6,
lastZnodeVersion 6
[junit4] 2> 571444 INFO (OverseerThreadFactory-1864-thread-1) [ ]
o.a.s.c.a.c.CreateCollectionCmd Create collection testNodeAdded
[junit4] 2> 571446 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "name":"testNodeAdded",
[junit4] 2> "fromApi":"true",
[junit4] 2> "collection.configName":"conf",
[junit4] 2> "numShards":"1",
[junit4] 2> "nrtReplicas":"2",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "operation":"create"} current state version: 0
[junit4] 2> 571446 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.o.ClusterStateMutator building a new cName: testNodeAdded
[junit4] 2> 571446 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/testNodeAdded/state.json
[junit4] 2> 571547 WARN (OverseerThreadFactory-1864-thread-1) [ ]
o.a.s.c.a.c.CreateCollectionCmd Specified number of replicas of 2 on collection
testNodeAdded is higher than the number of Solr instances currently live or
live and part of your createNodeSet(1). It's unusual to run two replica of the
same slice on the same Solr-instance.
[junit4] 2> 571551 INFO (qtp1026955163-4848) [n:127.0.0.1:41975_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 571556 INFO (OverseerThreadFactory-1864-thread-1) [ ]
o.a.s.c.s.c.a.PolicyHelper returnSession, curr-time 1115019467
sessionWrapper.createTime 1115019463379030, this.sessionWrapper.createTime
1115019463379030
[junit4] 2> 571558 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:41975/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 571559 INFO
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:41975/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 571559 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{}}
[junit4] 2> 571559 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node3":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:41975/solr";,
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 571559 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:41975/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 571559 INFO
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:41975/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 571560 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node3":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:41975/solr";,
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 571560 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:41975/solr";,
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node4":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "base_url":"https://127.0.0.1:41975/solr";,
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 571660 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.o.ZkStateWriter going to update_collection
/collections/testNodeAdded/state.json version: 0
[junit4] 2> 571765 WARN (qtp1026955163-4845) [ ]
o.e.j.u.t.s.EatWhatYouKill
[junit4] 2> java.lang.RuntimeException: No value present
[junit4] 2> at
sun.security.ssl.SSLEngineImpl.getTaskThrown(SSLEngineImpl.java:887) ~[?:?]
[junit4] 2> at
sun.security.ssl.SSLEngineImpl.checkTaskThrown(SSLEngineImpl.java:868) ~[?:?]
[junit4] 2> at
sun.security.ssl.SSLEngineImpl.unwrap(SSLEngineImpl.java:432) ~[?:?]
[junit4] 2> at
sun.security.ssl.SSLEngineImpl.unwrap(SSLEngineImpl.java:417) ~[?:?]
[junit4] 2> at javax.net.ssl.SSLEngine.unwrap(SSLEngine.java:626)
~[?:?]
[junit4] 2> at
org.eclipse.jetty.io.ssl.SslConnection$DecryptedEndPoint.fill(SslConnection.java:681)
~[jetty-io-9.4.11.v20180605.jar:9.4.11.v20180605]
[junit4] 2> at
org.eclipse.jetty.server.HttpConnection.fillRequestBuffer(HttpConnection.java:331)
~[jetty-server-9.4.11.v20180605.jar:9.4.11.v20180605]
[junit4] 2> at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:243)
~[jetty-server-9.4.11.v20180605.jar:9.4.11.v20180605]
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:281)
~[jetty-io-9.4.11.v20180605.jar:9.4.11.v20180605]
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102)
~[jetty-io-9.4.11.v20180605.jar:9.4.11.v20180605]
[junit4] 2> at
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:291)
~[jetty-io-9.4.11.v20180605.jar:9.4.11.v20180605]
[junit4] 2> at
org.eclipse.jetty.io.ssl.SslConnection$3.succeeded(SslConnection.java:151)
~[jetty-io-9.4.11.v20180605.jar:9.4.11.v20180605]
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102)
~[jetty-io-9.4.11.v20180605.jar:9.4.11.v20180605]
[junit4] 2> at
org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:118)
~[jetty-io-9.4.11.v20180605.jar:9.4.11.v20180605]
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:333)
[jetty-util-9.4.11.v20180605.jar:9.4.11.v20180605]
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:310)
[jetty-util-9.4.11.v20180605.jar:9.4.11.v20180605]
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:168)
[jetty-util-9.4.11.v20180605.jar:9.4.11.v20180605]
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:132)
[jetty-util-9.4.11.v20180605.jar:9.4.11.v20180605]
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:762)
[jetty-util-9.4.11.v20180605.jar:9.4.11.v20180605]
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:680)
[jetty-util-9.4.11.v20180605.jar:9.4.11.v20180605]
[junit4] 2> at java.lang.Thread.run(Thread.java:834) [?:?]
[junit4] 2> Caused by: java.util.NoSuchElementException: No value present
[junit4] 2> at java.util.Optional.get(Optional.java:148) ~[?:?]
[junit4] 2> at
sun.security.ssl.ServerHello$T13ServerHelloProducer.produce(ServerHello.java:547)
~[?:?]
[junit4] 2> at
sun.security.ssl.SSLHandshake.produce(SSLHandshake.java:429) ~[?:?]
[junit4] 2> at
sun.security.ssl.ClientHello$T13ClientHelloConsumer.goServerHello(ClientHello.java:1189)
~[?:?]
[junit4] 2> at
sun.security.ssl.ClientHello$T13ClientHelloConsumer.consume(ClientHello.java:1125)
~[?:?]
[junit4] 2> at
sun.security.ssl.ClientHello$ClientHelloConsumer.onClientHello(ClientHello.java:831)
~[?:?]
[junit4] 2> at
sun.security.ssl.ClientHello$ClientHelloConsumer.consume(ClientHello.java:792)
~[?:?]
[junit4] 2> at
sun.security.ssl.SSLHandshake.consume(SSLHandshake.java:390) ~[?:?]
[junit4] 2> at
sun.security.ssl.HandshakeContext.dispatch(HandshakeContext.java:445) ~[?:?]
[junit4] 2> at
sun.security.ssl.SSLEngineImpl$DelegatedTask$DelegatedAction.run(SSLEngineImpl.java:978)
~[?:?]
[junit4] 2> at
sun.security.ssl.SSLEngineImpl$DelegatedTask$DelegatedAction.run(SSLEngineImpl.java:958)
~[?:?]
[junit4] 2> at java.security.AccessController.doPrivileged(Native
Method) ~[?:?]
[junit4] 2> at
sun.security.ssl.SSLEngineImpl$DelegatedTask.run(SSLEngineImpl.java:926) ~[?:?]
[junit4] 2> at
org.eclipse.jetty.io.ssl.SslConnection$DecryptedEndPoint.fill(SslConnection.java:775)
~[jetty-io-9.4.11.v20180605.jar:9.4.11.v20180605]
[junit4] 2> ... 15 more
[junit4] 2> 571765 ERROR (OverseerThreadFactory-1864-thread-1) [ ]
o.a.s.c.a.c.OverseerCollectionMessageHandler Error from shard:
https://127.0.0.1:41975/solr
[junit4] 2> org.apache.solr.client.solrj.SolrServerException: IOException
occured when talking to server at: https://127.0.0.1:41975/solr
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:657)
~[java/:?]
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
~[java/:?]
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
~[java/:?]
[junit4] 2> at
org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) ~[java/:?]
[junit4] 2> at
org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:172)
~[java/:?]
[junit4] 2> at
java.util.concurrent.FutureTask.run(FutureTask.java:264) ~[?:?]
[junit4] 2> at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) ~[?:?]
[junit4] 2> at
java.util.concurrent.FutureTask.run(FutureTask.java:264) ~[?:?]
[junit4] 2> at
com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
~[metrics-core-3.2.6.jar:3.2.6]
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
[java/:?]
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
[?:?]
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[?:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:834) [?:?]
[junit4] 2> Caused by: javax.net.ssl.SSLHandshakeException: Remote host
terminated the handshake
[junit4] 2> at
sun.security.ssl.SSLSocketImpl.handleEOF(SSLSocketImpl.java:1121) ~[?:?]
[junit4] 2> at
sun.security.ssl.SSLSocketImpl.decode(SSLSocketImpl.java:885) ~[?:?]
[junit4] 2> at
sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:810) ~[?:?]
[junit4] 2> at
sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:383) ~[?:?]
[junit4] 2> at
org.apache.http.conn.ssl.SSLConnectionSocketFactory.createLayeredSocket(SSLConnectionSocketFactory.java:396)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.conn.ssl.SSLConnectionSocketFactory.connectSocket(SSLConnectionSocketFactory.java:355)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:142)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.conn.PoolingHttpClientConnectionManager.connect(PoolingHttpClientConnectionManager.java:359)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.execchain.MainClientExec.establishRoute(MainClientExec.java:381)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:237)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:185)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:111)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:542)
~[java/:?]
[junit4] 2> ... 12 more
[junit4] 2> Caused by: java.io.EOFException: SSL peer shut down incorrectly
[junit4] 2> at
sun.security.ssl.SSLSocketInputRecord.decode(SSLSocketInputRecord.java:169)
~[?:?]
[junit4] 2> at
sun.security.ssl.SSLTransport.decode(SSLTransport.java:108) ~[?:?]
[junit4] 2> at
sun.security.ssl.SSLSocketImpl.decode(SSLSocketImpl.java:877) ~[?:?]
[junit4] 2> at
sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:810) ~[?:?]
[junit4] 2> at
sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:383) ~[?:?]
[junit4] 2> at
org.apache.http.conn.ssl.SSLConnectionSocketFactory.createLayeredSocket(SSLConnectionSocketFactory.java:396)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.conn.ssl.SSLConnectionSocketFactory.connectSocket(SSLConnectionSocketFactory.java:355)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:142)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.conn.PoolingHttpClientConnectionManager.connect(PoolingHttpClientConnectionManager.java:359)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.execchain.MainClientExec.establishRoute(MainClientExec.java:381)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:237)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:185)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:111)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
~[httpclient-4.5.3.jar:4.5.3]
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:542)
~[java/:?]
[junit4] 2> ... 12 more
[junit4] 2> 571771 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
x:testNodeAdded_shard1_replica_n2] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=testNodeAdded_shard1_replica_n2&action=CREATE&numShards=1&collection=testNodeAdded&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 571772 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
x:testNodeAdded_shard1_replica_n2] o.a.s.c.TransientSolrCoreCacheDefault
Allocating transient cache for 2147483647 transient cores
[junit4] 2> 571774 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node4",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:41975/solr";,
[junit4] 2> "node_name":"127.0.0.1:41975_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 571774 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node4",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:41975/solr";,
[junit4] 2> "node_name":"127.0.0.1:41975_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 571774 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Will update state for replica:
core_node4:{"core":"testNodeAdded_shard1_replica_n2","base_url":"https://127.0.0.1:41975/solr","node_name":"127.0.0.1:41975_solr","state":"down","type":"NRT","force_set_state":"false"}
[junit4] 2> 571774 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Collection is now:
DocCollection(testNodeAdded//collections/testNodeAdded/state.json/1)={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"1",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"2",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:41975/solr";,
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node4":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "base_url":"https://127.0.0.1:41975/solr";,
[junit4] 2> "node_name":"127.0.0.1:41975_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}}}}}
[junit4] 2> 571874 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.o.ZkStateWriter going to update_collection
/collections/testNodeAdded/state.json version: 1
[junit4] 2> 572443 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 572443 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 572779 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 572783 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.s.IndexSchema [testNodeAdded_shard1_replica_n2] Schema name=minimal
[junit4] 2> 572784 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 572784 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.c.CoreContainer Creating SolrCore 'testNodeAdded_shard1_replica_n2' using
configuration from collection testNodeAdded, trusted=true
[junit4] 2> 572789 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41975.solr.core.testNodeAdded.shard1.replica_n2' (registry
'solr.core.testNodeAdded.shard1.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@511c3bc7
[junit4] 2> 572789 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 572789 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.c.SolrCore [[testNodeAdded_shard1_replica_n2] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ComputePlanActionTest_325FF67B6842931-001/tempDir-001/node1/testNodeAdded_shard1_replica_n2],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ComputePlanActionTest_325FF67B6842931-001/tempDir-001/node1/./testNodeAdded_shard1_replica_n2/data/]
[junit4] 2> 572840 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 572840 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 572842 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 572842 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 572843 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@31f738fd[testNodeAdded_shard1_replica_n2] main]
[junit4] 2> 572844 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 572844 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 572845 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 572845 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1608319223347544064
[junit4] 2> 572845 INFO
(searcherExecutor-1869-thread-1-processing-n:127.0.0.1:41975_solr
x:testNodeAdded_shard1_replica_n2 c:testNodeAdded s:shard1 r:core_node4)
[n:127.0.0.1:41975_solr c:testNodeAdded s:shard1 r:core_node4
x:testNodeAdded_shard1_replica_n2] o.a.s.c.SolrCore
[testNodeAdded_shard1_replica_n2] Registered new searcher
Searcher@31f738fd[testNodeAdded_shard1_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 572849 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/testNodeAdded/terms/shard1 to Terms{values={core_node4=0},
version=0}
[junit4] 2> 572850 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shard1: total=2 found=1 timeoutin=9999ms
[junit4] 2> 572850 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded"} current state version: 0
[junit4] 2> 572951 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.o.ZkStateWriter going to update_collection
/collections/testNodeAdded/state.json version: 2
[junit4] 2> 573443 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 573444 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 574444 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 574444 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 575444 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 575444 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 576444 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 576444 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 577444 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 577445 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 578445 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 578445 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 579445 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 579445 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 580445 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 580445 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 581445 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 581445 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 582446 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 582446 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 582869 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext Was waiting for replicas to come up, but
they are taking too long - assuming they won't come back till later
[junit4] 2> 582869 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 582869 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:41975/solr/testNodeAdded_shard1_replica_n2/
[junit4] 2> 582870 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 582870 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.c.SyncStrategy
https://127.0.0.1:41975/solr/testNodeAdded_shard1_replica_n2/ has no replicas
[junit4] 2> 582872 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:41975/solr/testNodeAdded_shard1_replica_n2/ shard1
[junit4] 2> 582874 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "base_url":"https://127.0.0.1:41975/solr";,
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "state":"active"} current state version: 0
[junit4] 2> 582874 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.o.ZkStateWriter going to update_collection
/collections/testNodeAdded/state.json version: 3
[junit4] 2> 582925 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 582926 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node4",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:41975/solr";,
[junit4] 2> "node_name":"127.0.0.1:41975_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 582926 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node4",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:41975/solr";,
[junit4] 2> "node_name":"127.0.0.1:41975_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 582926 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Will update state for replica:
core_node4:{"core":"testNodeAdded_shard1_replica_n2","base_url":"https://127.0.0.1:41975/solr","node_name":"127.0.0.1:41975_solr","state":"active","type":"NRT","force_set_state":"false","leader":"true"}
[junit4] 2> 582926 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Collection is now:
DocCollection(testNodeAdded//collections/testNodeAdded/state.json/4)={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"1",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"2",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:41975/solr";,
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node4":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "base_url":"https://127.0.0.1:41975/solr";,
[junit4] 2> "node_name":"127.0.0.1:41975_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "leader":"true"}}}}}
[junit4] 2> 582930 INFO (qtp1026955163-4894) [n:127.0.0.1:41975_solr
c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=testNodeAdded_shard1_replica_n2&action=CREATE&numShards=1&collection=testNodeAdded&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=11158
[junit4] 2> 582930 ERROR (OverseerThreadFactory-1864-thread-1) [ ]
o.a.s.c.a.c.OverseerCollectionMessageHandler Cleaning up collection
[testNodeAdded].
[junit4] 2> 582932 INFO (OverseerThreadFactory-1864-thread-1) [ ]
o.a.s.c.a.c.OverseerCollectionMessageHandler Executing Collection
Cmd=action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true&deleteMetricsHistory=true,
asyncId=null
[junit4] 2> 582933 INFO (qtp1026955163-4842) [n:127.0.0.1:41975_solr
x:testNodeAdded_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.testNodeAdded.shard1.replica_n2, tag=null
[junit4] 2> 582933 INFO (qtp1026955163-4842) [n:127.0.0.1:41975_solr
x:testNodeAdded_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1d8db28b: rootName =
solr_41975, domain = solr.core.testNodeAdded.shard1.replica_n2, service url =
null, agent id = null] for registry solr.core.testNodeAdded.shard1.replica_n2 /
com.codahale.metrics.MetricRegistry@43887b09
[junit4] 2> 582947 INFO (qtp1026955163-4842) [n:127.0.0.1:41975_solr
x:testNodeAdded_shard1_replica_n2] o.a.s.c.SolrCore
[testNodeAdded_shard1_replica_n2] CLOSING SolrCore
org.apache.solr.core.SolrCore@36ffad3b
[junit4] 2> 582947 INFO (qtp1026955163-4842) [n:127.0.0.1:41975_solr
x:testNodeAdded_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.testNodeAdded.shard1.replica_n2, tag=36ffad3b
[junit4] 2> 582947 INFO (qtp1026955163-4842) [n:127.0.0.1:41975_solr
x:testNodeAdded_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.testNodeAdded.shard1.leader, tag=36ffad3b
[junit4] 2> 582954 INFO (qtp1026955163-4842) [n:127.0.0.1:41975_solr
x:testNodeAdded_shard1_replica_n2] o.a.s.c.ZkShardTerms Successful update of
terms at /collections/testNodeAdded/terms/shard1 to Terms{values={}, version=1}
[junit4] 2> 582965 INFO (qtp1026955163-4842) [n:127.0.0.1:41975_solr
x:testNodeAdded_shard1_replica_n2] o.a.s.s.HttpSolrCall [admin] webapp=null
path=/admin/cores
params={deleteInstanceDir=true&deleteMetricsHistory=true&core=testNodeAdded_shard1_replica_n2&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
status=0 QTime=32
[junit4] 2> 582965 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "operation":"deletecore",
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "node_name":"127.0.0.1:41975_solr",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "base_url":"https://127.0.0.1:41975/solr";,
[junit4] 2> "core_node_name":"core_node4"} current state version: 0
[junit4] 2> 582973 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.Overseer processMessage: queueSize: 3, message = {
[junit4] 2> "operation":"delete",
[junit4] 2> "name":"testNodeAdded"} current state version: 0
[junit4] 2> 583073 DEBUG
(OverseerStateUpdate-72130667926454275-127.0.0.1:41975_solr-n_0000000000) [
] o.a.s.c.o.ZkStateWriter going to delete state.json
/collections/testNodeAdded/state.json
[junit4] 2> 583074 INFO (zkCallback-1400-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDeleted
path:/collections/testNodeAdded/state.json] for collection [testNodeAdded] has
occurred - updating... (live nodes size: [1])
[junit4] 2> 583446 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 583446 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 583587 INFO (OverseerThreadFactory-1864-thread-1) [ ]
o.a.s.c.a.c.CreateCollectionCmd Cleaned up artifacts for failed create
collection for [testNodeAdded]
[junit4] 2> 583589 INFO (qtp1026955163-4846) [n:127.0.0.1:41975_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> 584446 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 584446 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 585446 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 585446 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 585452 INFO
(OverseerCollectionConfigSetProcessor-72130667926454275-127.0.0.1:41975_solr-n_0000000000)
[ ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 586446 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 586446 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 587447 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 587447 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 588448 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 588448 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 589448 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 589448 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 590449 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 590449 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 591449 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 591449 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 592449 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 592449 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 593449 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 593449 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 594449 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 594450 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 595450 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 595450 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 596450 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 596450 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 597450 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 597450 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 598450 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 598450 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 599451 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 599451 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 600451 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 600451 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 601451 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 601451 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 602451 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 602451 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 603451 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 603451 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 604452 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 604452 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 605452 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 605452 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 606452 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 606452 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 607452 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 607452 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 608453 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 608453 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 609453 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 609453 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 610453 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 610453 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 611453 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 611453 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 612453 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 612453 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 613454 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 613454 DEBUG (ScheduledTrigger-1862-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 613592 ERROR (qtp1026955163-4846) [n:127.0.0.1:41975_solr ]
o.a.s.h.a.CollectionsHandler Timed out waiting for new collection's
[...truncated too long message...]
[junit4] 1> at
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:502)
[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
[junit4] 2> Aug 09, 2018 11:32:59 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> SEVERE: There are still zombie threads that couldn't be
terminated:
[junit4] 2> 1) Thread[id=1956,
name=Thread-466-SendThread(127.0.0.1:45347), state=TIMED_WAITING,
group=TGRP-StreamingTest]
[junit4] 2> at java.base@11-ea/java.lang.Thread.sleep(Native
Method)
[junit4] 2> at
app//org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1054)
[junit4] 2> 2) Thread[id=1958,
name=zkConnectionManagerCallback-517-thread-1, state=WAITING,
group=TGRP-StreamingTest]
[junit4] 2> at
java.base@11-ea/jdk.internal.misc.Unsafe.park(Native Method)
[junit4] 2> at
java.base@11-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
[junit4] 2> at
java.base@11-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
[junit4] 2> at
java.base@11-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
[junit4] 2> at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
[junit4] 2> at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
[junit4] 2> at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[junit4] 2> at
java.base@11-ea/java.lang.Thread.run(Thread.java:834)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{level1_s=PostingsFormat(name=MockRandom),
s_multi=PostingsFormat(name=MockRandom),
a_ss=PostingsFormat(name=LuceneFixedGap),
level2_s=PostingsFormat(name=Asserting), a_s=PostingsFormat(name=MockRandom),
multiDefault=PostingsFormat(name=LuceneFixedGap), s_sing=FSTOrd50,
b_sing=PostingsFormat(name=LuceneFixedGap),
b_multi=PostingsFormat(name=LuceneFixedGap), id=FSTOrd50},
docValues:{multiDefault=DocValuesFormat(name=Direct),
intDefault=DocValuesFormat(name=Lucene70), a_f=DocValuesFormat(name=Lucene70),
a_i=DocValuesFormat(name=Asserting), dt_sing=DocValuesFormat(name=Direct),
level1_s=DocValuesFormat(name=Lucene70), dt_multi=DocValuesFormat(name=Direct),
l_multi=DocValuesFormat(name=Lucene70), s_multi=DocValuesFormat(name=Lucene70),
a_ss=DocValuesFormat(name=Direct), level2_s=DocValuesFormat(name=Lucene70),
a_s=DocValuesFormat(name=Lucene70), id=DocValuesFormat(name=Asserting),
d_multi=DocValuesFormat(name=Direct), timestamp=DocValuesFormat(name=Direct),
d_sing=DocValuesFormat(name=Lucene70), i_multi=DocValuesFormat(name=Asserting),
b_sing=DocValuesFormat(name=Direct), b_multi=DocValuesFormat(name=Direct),
f_multi=DocValuesFormat(name=Direct), _version_=DocValuesFormat(name=Lucene70),
f_sing=DocValuesFormat(name=Direct), s_sing=DocValuesFormat(name=Asserting),
i_sing=DocValuesFormat(name=Lucene70), l_sing=DocValuesFormat(name=Lucene70)},
maxPointsInLeafNode=1213, maxMBSortInHeap=7.219740449513733,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@73e7d8e7),
locale=ms-BN, timezone=Asia/Ust-Nera
[junit4] 2> NOTE: Linux 4.15.0-29-generic amd64/Oracle Corporation 11-ea
(64-bit)/cpus=8,threads=3,free=378612656,total=511180800
[junit4] 2> NOTE: All tests run in this JVM: [LargeVolumeEmbeddedTest,
ArcSineEvaluatorTest, HttpSolrClientConPoolTest, LessThanEvaluatorTest,
SolrExampleXMLTest, SchemaTest, JdbcDriverTest, CubedRootEvaluatorTest,
SolrExampleEmbeddedTest, AndEvaluatorTest, AscEvaluatorTest,
ReverseEvaluatorTest, TestZkConfigManager, MathExpressionTest,
TestJavaBinCodec, SquareRootEvaluatorTest, ConcurrentUpdateSolrClientTest,
ClientUtilsTest, RawValueEvaluatorTest, SolrSchemalessExampleTest,
SolrExampleStreamingTest, StreamingTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=StreamingTest
-Dtests.seed=56578F710DDE5771 -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.locale=ms-BN -Dtests.timezone=Asia/Ust-Nera -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J1 | StreamingTest (suite) <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE
scope at org.apache.solr.client.solrj.io.stream.StreamingTest:
[junit4] > 1) Thread[id=1957, name=Thread-466-EventThread,
state=WAITING, group=TGRP-StreamingTest]
[junit4] > at
java.base@11-ea/jdk.internal.misc.Unsafe.park(Native Method)
[junit4] > at
java.base@11-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
[junit4] > at
java.base@11-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
[junit4] > at
java.base@11-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
[junit4] > at
app//org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:502)
[junit4] > 2) Thread[id=2010, name=Connection evictor,
state=TIMED_WAITING, group=TGRP-StreamingTest]
[junit4] > at java.base@11-ea/java.lang.Thread.sleep(Native
Method)
[junit4] > at
app//org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
[junit4] > at
java.base@11-ea/java.lang.Thread.run(Thread.java:834)
[junit4] > 3) Thread[id=1956,
name=Thread-466-SendThread(127.0.0.1:45347), state=TIMED_WAITING,
group=TGRP-StreamingTest]
[junit4] > at java.base@11-ea/java.lang.Thread.sleep(Native
Method)
[junit4] > at
app//org.apache.zookeeper.client.StaticHostProvider.next(StaticHostProvider.java:105)
[junit4] > at
app//org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:1000)
[junit4] > at
app//org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1063)
[junit4] > 4) Thread[id=1958,
name=zkConnectionManagerCallback-517-thread-1, state=WAITING,
group=TGRP-StreamingTest]
[junit4] > at
java.base@11-ea/jdk.internal.misc.Unsafe.park(Native Method)
[junit4] > at
java.base@11-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
[junit4] > at
java.base@11-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
[junit4] > at
java.base@11-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
[junit4] > at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
[junit4] > at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
[junit4] > at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[junit4] > at
java.base@11-ea/java.lang.Thread.run(Thread.java:834)
[junit4] > at
__randomizedtesting.SeedInfo.seed([56578F710DDE5771]:0)Throwable #2:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=1956,
name=Thread-466-SendThread(127.0.0.1:45347), state=TIMED_WAITING,
group=TGRP-StreamingTest]
[junit4] > at java.base@11-ea/java.lang.Thread.sleep(Native
Method)
[junit4] > at
app//org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1054)
[junit4] > 2) Thread[id=1958,
name=zkConnectionManagerCallback-517-thread-1, state=WAITING,
group=TGRP-StreamingTest]
[junit4] > at
java.base@11-ea/jdk.internal.misc.Unsafe.park(Native Method)
[junit4] > at
java.base@11-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
[junit4] > at
java.base@11-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
[junit4] > at
java.base@11-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
[junit4] > at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
[junit4] > at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
[junit4] > at
java.base@11-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[junit4] > at
java.base@11-ea/java.lang.Thread.run(Thread.java:834)
[junit4] > at
__randomizedtesting.SeedInfo.seed([56578F710DDE5771]:0)
[junit4] Completed [154/155 (2!)] on J1 in 88.21s, 28 tests, 3 errors, 2
skipped <<< FAILURES!
[...truncated 7831 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:633: The following
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:128: Found 1
violations in source files (Unescaped symbol "<-" on line #249).
Total time: 64 minutes 50 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Setting
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Setting
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
Setting
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
