Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.4-Linux/117/ Java: 32bit/jdk-9-ea+153 -server -XX:+UseParallelGC
4 tests failed. FAILED: junit.framework.TestSuite.org.apache.solr.cloud.BasicZkTest Error Message: SolrCore.getOpenCount()==2 Stack Trace: java.lang.RuntimeException: SolrCore.getOpenCount()==2 at __randomizedtesting.SeedInfo.seed([5DFA36307FEA60D4]:0) at org.apache.solr.util.TestHarness.close(TestHarness.java:373) at org.apache.solr.SolrTestCaseJ4.deleteCore(SolrTestCaseJ4.java:731) at org.apache.solr.cloud.AbstractZkTestCase.azt_afterClass(AbstractZkTestCase.java:143) 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:543) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:870) 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:367) at java.base/java.lang.Thread.run(Thread.java:844) FAILED: junit.framework.TestSuite.org.apache.solr.cloud.BasicZkTest Error Message: SolrCore.getOpenCount()==2 Stack Trace: java.lang.RuntimeException: SolrCore.getOpenCount()==2 at __randomizedtesting.SeedInfo.seed([5DFA36307FEA60D4]:0) at org.apache.solr.util.TestHarness.close(TestHarness.java:373) at org.apache.solr.SolrTestCaseJ4.deleteCore(SolrTestCaseJ4.java:731) at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:261) at jdk.internal.reflect.GeneratedMethodAccessor26.invoke(Unknown Source) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:543) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:870) 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:367) at java.base/java.lang.Thread.run(Thread.java:844) FAILED: junit.framework.TestSuite.org.apache.solr.cloud.BasicZkTest Error Message: 21 threads leaked from SUITE scope at org.apache.solr.cloud.BasicZkTest: 1) Thread[id=8076, name=SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker-EventThread, state=WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:192) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062) at java.base@9-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:435) at app//org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:494) 2) Thread[id=8078, name=OverseerStateUpdate-97412557254688771-188.138.57.78:8983_-n_0000000000, state=TIMED_WAITING, group=Overseer state updater.] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2104) at app//org.apache.solr.cloud.DistributedQueue.peek(DistributedQueue.java:164) at app//org.apache.solr.cloud.DistributedQueue.peek(DistributedQueue.java:138) at app//org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:179) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 3) Thread[id=8080, name=OverseerHdfsCoreFailoverThread-97412557254688771-188.138.57.78:8983_-n_0000000000, state=TIMED_WAITING, group=Overseer Hdfs SolrCore Failover Thread.] at java.base@9-ea/java.lang.Thread.sleep(Native Method) at app//org.apache.solr.cloud.OverseerAutoReplicaFailoverThread.run(OverseerAutoReplicaFailoverThread.java:139) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 4) Thread[id=8094, name=SessionTracker, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/java.lang.Object.wait(Native Method) at app//org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:146) 5) Thread[id=8091, name=zkCallback-1126-thread-6, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 6) Thread[id=8087, name=zkCallback-1126-thread-2, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 7) Thread[id=8071, name=solr-idle-connections-evictor, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/java.lang.Thread.sleep(Native Method) at app//org.apache.solr.update.UpdateShardHandler$IdleConnectionsEvictor$1.run(UpdateShardHandler.java:258) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 8) Thread[id=8075, name=SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker-SendThread(127.0.0.1:38157), state=RUNNABLE, group=TGRP-BasicZkTest] at java.base@9-ea/sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at java.base@9-ea/sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:265) at java.base@9-ea/sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:92) at java.base@9-ea/sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86) at java.base@9-ea/sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97) at app//org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:349) at app//org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1081) 9) Thread[id=8093, name=NIOServerCxn.Factory:0.0.0.0/0.0.0.0:38157, state=RUNNABLE, group=TGRP-BasicZkTest] at java.base@9-ea/sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at java.base@9-ea/sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:265) at java.base@9-ea/sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:92) at java.base@9-ea/sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86) at java.base@9-ea/sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97) at app//org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:178) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 10) Thread[id=8090, name=zkCallback-1126-thread-5, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 11) Thread[id=8077, name=zkCallback-1126-thread-1, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 12) Thread[id=8083, name=watches-1127-thread-1, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 13) Thread[id=8096, name=ProcessThread(sid:0 cport:-1):, state=WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:192) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062) at java.base@9-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:435) at app//org.apache.zookeeper.server.PrepRequestProcessor.run(PrepRequestProcessor.java:120) 14) Thread[id=8085, name=searcherExecutor-3791-thread-1, state=WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:192) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062) at java.base@9-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:435) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1086) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 15) Thread[id=8086, name=coreZkRegister-3783-thread-1, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 16) Thread[id=8088, name=zkCallback-1126-thread-3, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 17) Thread[id=8082, name=Thread-2172, state=WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/java.lang.Object.wait(Native Method) at java.base@9-ea/java.lang.Object.wait(Object.java:516) at app//org.apache.solr.core.CloserThread.run(CoreContainer.java:1335) 18) Thread[id=8070, name=solr-idle-connections-evictor, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/java.lang.Thread.sleep(Native Method) at app//org.apache.solr.update.UpdateShardHandler$IdleConnectionsEvictor$1.run(UpdateShardHandler.java:258) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 19) Thread[id=8092, name=Thread-2173, state=WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/java.lang.Object.wait(Native Method) at java.base@9-ea/java.lang.Thread.join(Thread.java:1353) at java.base@9-ea/java.lang.Thread.join(Thread.java:1427) at app//org.apache.zookeeper.server.NIOServerCnxnFactory.join(NIOServerCnxnFactory.java:302) at app//org.apache.solr.cloud.ZkTestServer$ZKServerMain.runFromConfig(ZkTestServer.java:309) at app//org.apache.solr.cloud.ZkTestServer$2.run(ZkTestServer.java:490) 20) Thread[id=8089, name=zkCallback-1126-thread-4, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 21) Thread[id=8079, name=OverseerCollectionConfigSetProcessor-97412557254688771-188.138.57.78:8983_-n_0000000000, state=TIMED_WAITING, group=Overseer collection creation process.] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2104) at app//org.apache.solr.cloud.DistributedQueue.peekElements(DistributedQueue.java:343) at app//org.apache.solr.cloud.OverseerTaskQueue.peekTopN(OverseerTaskQueue.java:235) at app//org.apache.solr.cloud.OverseerTaskProcessor.run(OverseerTaskProcessor.java:227) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) Stack Trace: com.carrotsearch.randomizedtesting.ThreadLeakError: 21 threads leaked from SUITE scope at org.apache.solr.cloud.BasicZkTest: 1) Thread[id=8076, name=SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker-EventThread, state=WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:192) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062) at java.base@9-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:435) at app//org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:494) 2) Thread[id=8078, name=OverseerStateUpdate-97412557254688771-188.138.57.78:8983_-n_0000000000, state=TIMED_WAITING, group=Overseer state updater.] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2104) at app//org.apache.solr.cloud.DistributedQueue.peek(DistributedQueue.java:164) at app//org.apache.solr.cloud.DistributedQueue.peek(DistributedQueue.java:138) at app//org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:179) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 3) Thread[id=8080, name=OverseerHdfsCoreFailoverThread-97412557254688771-188.138.57.78:8983_-n_0000000000, state=TIMED_WAITING, group=Overseer Hdfs SolrCore Failover Thread.] at java.base@9-ea/java.lang.Thread.sleep(Native Method) at app//org.apache.solr.cloud.OverseerAutoReplicaFailoverThread.run(OverseerAutoReplicaFailoverThread.java:139) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 4) Thread[id=8094, name=SessionTracker, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/java.lang.Object.wait(Native Method) at app//org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:146) 5) Thread[id=8091, name=zkCallback-1126-thread-6, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 6) Thread[id=8087, name=zkCallback-1126-thread-2, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 7) Thread[id=8071, name=solr-idle-connections-evictor, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/java.lang.Thread.sleep(Native Method) at app//org.apache.solr.update.UpdateShardHandler$IdleConnectionsEvictor$1.run(UpdateShardHandler.java:258) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 8) Thread[id=8075, name=SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker-SendThread(127.0.0.1:38157), state=RUNNABLE, group=TGRP-BasicZkTest] at java.base@9-ea/sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at java.base@9-ea/sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:265) at java.base@9-ea/sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:92) at java.base@9-ea/sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86) at java.base@9-ea/sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97) at app//org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:349) at app//org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1081) 9) Thread[id=8093, name=NIOServerCxn.Factory:0.0.0.0/0.0.0.0:38157, state=RUNNABLE, group=TGRP-BasicZkTest] at java.base@9-ea/sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at java.base@9-ea/sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:265) at java.base@9-ea/sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:92) at java.base@9-ea/sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86) at java.base@9-ea/sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97) at app//org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:178) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 10) Thread[id=8090, name=zkCallback-1126-thread-5, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 11) Thread[id=8077, name=zkCallback-1126-thread-1, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 12) Thread[id=8083, name=watches-1127-thread-1, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 13) Thread[id=8096, name=ProcessThread(sid:0 cport:-1):, state=WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:192) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062) at java.base@9-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:435) at app//org.apache.zookeeper.server.PrepRequestProcessor.run(PrepRequestProcessor.java:120) 14) Thread[id=8085, name=searcherExecutor-3791-thread-1, state=WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:192) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062) at java.base@9-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:435) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1086) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 15) Thread[id=8086, name=coreZkRegister-3783-thread-1, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 16) Thread[id=8088, name=zkCallback-1126-thread-3, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 17) Thread[id=8082, name=Thread-2172, state=WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/java.lang.Object.wait(Native Method) at java.base@9-ea/java.lang.Object.wait(Object.java:516) at app//org.apache.solr.core.CloserThread.run(CoreContainer.java:1335) 18) Thread[id=8070, name=solr-idle-connections-evictor, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/java.lang.Thread.sleep(Native Method) at app//org.apache.solr.update.UpdateShardHandler$IdleConnectionsEvictor$1.run(UpdateShardHandler.java:258) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 19) Thread[id=8092, name=Thread-2173, state=WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/java.lang.Object.wait(Native Method) at java.base@9-ea/java.lang.Thread.join(Thread.java:1353) at java.base@9-ea/java.lang.Thread.join(Thread.java:1427) at app//org.apache.zookeeper.server.NIOServerCnxnFactory.join(NIOServerCnxnFactory.java:302) at app//org.apache.solr.cloud.ZkTestServer$ZKServerMain.runFromConfig(ZkTestServer.java:309) at app//org.apache.solr.cloud.ZkTestServer$2.run(ZkTestServer.java:490) 20) Thread[id=8089, name=zkCallback-1126-thread-4, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 21) Thread[id=8079, name=OverseerCollectionConfigSetProcessor-97412557254688771-188.138.57.78:8983_-n_0000000000, state=TIMED_WAITING, group=Overseer collection creation process.] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2104) at app//org.apache.solr.cloud.DistributedQueue.peekElements(DistributedQueue.java:343) at app//org.apache.solr.cloud.OverseerTaskQueue.peekTopN(OverseerTaskQueue.java:235) at app//org.apache.solr.cloud.OverseerTaskProcessor.run(OverseerTaskProcessor.java:227) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) at __randomizedtesting.SeedInfo.seed([5DFA36307FEA60D4]:0) FAILED: junit.framework.TestSuite.org.apache.solr.cloud.BasicZkTest Error Message: There are still zombie threads that couldn't be terminated: 1) Thread[id=8085, name=searcherExecutor-3791-thread-1, state=WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:192) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062) at java.base@9-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:435) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1086) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 2) Thread[id=8086, name=coreZkRegister-3783-thread-1, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 3) Thread[id=8088, name=zkCallback-1126-thread-3, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 4) Thread[id=8082, name=Thread-2172, state=WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/java.lang.Object.wait(Native Method) at java.base@9-ea/java.lang.Object.wait(Object.java:516) at app//org.apache.solr.core.CloserThread.run(CoreContainer.java:1335) 5) Thread[id=8091, name=zkCallback-1126-thread-6, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 6) Thread[id=8087, name=zkCallback-1126-thread-2, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 7) Thread[id=8075, name=SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker-SendThread(127.0.0.1:38157), state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/java.lang.Thread.sleep(Native Method) at app//org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:994) 8) Thread[id=8089, name=zkCallback-1126-thread-4, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 9) Thread[id=8090, name=zkCallback-1126-thread-5, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 10) Thread[id=8077, name=zkCallback-1126-thread-1, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 11) Thread[id=8083, name=watches-1127-thread-1, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) Stack Trace: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated: 1) Thread[id=8085, name=searcherExecutor-3791-thread-1, state=WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:192) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062) at java.base@9-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:435) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1086) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 2) Thread[id=8086, name=coreZkRegister-3783-thread-1, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 3) Thread[id=8088, name=zkCallback-1126-thread-3, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 4) Thread[id=8082, name=Thread-2172, state=WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/java.lang.Object.wait(Native Method) at java.base@9-ea/java.lang.Object.wait(Object.java:516) at app//org.apache.solr.core.CloserThread.run(CoreContainer.java:1335) 5) Thread[id=8091, name=zkCallback-1126-thread-6, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 6) Thread[id=8087, name=zkCallback-1126-thread-2, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 7) Thread[id=8075, name=SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker-SendThread(127.0.0.1:38157), state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/java.lang.Thread.sleep(Native Method) at app//org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:994) 8) Thread[id=8089, name=zkCallback-1126-thread-4, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 9) Thread[id=8090, name=zkCallback-1126-thread-5, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 10) Thread[id=8077, name=zkCallback-1126-thread-1, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 11) Thread[id=8083, name=watches-1127-thread-1, state=TIMED_WAITING, group=TGRP-BasicZkTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) at __randomizedtesting.SeedInfo.seed([5DFA36307FEA60D4]:0) Build Log: [...truncated 12179 lines...] [junit4] Suite: org.apache.solr.cloud.BasicZkTest [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.BasicZkTest_5DFA36307FEA60D4-001/init-core-data-001 [junit4] 2> 1429120 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0) [junit4] 2> 1429121 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1429121 INFO (Thread-2171) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1429121 INFO (Thread-2171) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1429221 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:38157 [junit4] 2> 1429226 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml [junit4] 2> 1429228 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml [junit4] 2> 1429231 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 1429233 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 1429239 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 1429240 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 1429243 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 1429245 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 1429248 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 1429251 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 1429254 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 1429258 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 1429259 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1429358 WARN (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead. [junit4] 2> 1429359 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.1 [junit4] 2> 1429377 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test [junit4] 2> 1429436 WARN (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead. [junit4] 2> 1429443 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1429475 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 1429477 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:38157/solr [junit4] 2> 1429486 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.OverseerElectionContext I am going to be the leader 188.138.57.78:8983_ [junit4] 2> 1429487 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.Overseer Overseer (id=97412557254688771-188.138.57.78:8983_-n_0000000000) starting [junit4] 2> 1429489 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/188.138.57.78:8983_ [junit4] 2> 1429490 INFO (zkCallback-1126-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1429538 WARN (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1429540 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@163e15 [junit4] 2> 1429540 WARN (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1429543 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@163e15 [junit4] 2> 1429543 WARN (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1429544 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@163e15 [junit4] 2> 1430547 INFO (coreLoadExecutor-3790-thread-1) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1430607 WARN (coreLoadExecutor-3790-thread-1) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead. [junit4] 2> 1430608 INFO (coreLoadExecutor-3790-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.1 [junit4] 2> 1430625 INFO (coreLoadExecutor-3790-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1430683 WARN (coreLoadExecutor-3790-thread-1) [ ] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead. [junit4] 2> 1430684 INFO (coreLoadExecutor-3790-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1430691 INFO (coreLoadExecutor-3790-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection collection1 [junit4] 2> 1430691 WARN (coreLoadExecutor-3790-thread-1) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1430691 INFO (coreLoadExecutor-3790-thread-1) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@163e15 [junit4] 2> 1430691 INFO (coreLoadExecutor-3790-thread-1) [ ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.BasicZkTest_5DFA36307FEA60D4-001/init-core-data-001/] [junit4] 2> 1430691 INFO (coreLoadExecutor-3790-thread-1) [ ] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@163e15 [junit4] 2> 1430692 INFO (coreLoadExecutor-3790-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=18, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.48594677419833643] [junit4] 2> 1430712 INFO (coreLoadExecutor-3790-thread-1) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1430713 INFO (coreLoadExecutor-3790-thread-1) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1430714 INFO (coreLoadExecutor-3790-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1430714 INFO (coreLoadExecutor-3790-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1430714 INFO (coreLoadExecutor-3790-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=14, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=0.16796875, floorSegmentMB=1.568359375, forceMergeDeletesPctAllowed=14.387722521590952, segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 1430715 INFO (coreLoadExecutor-3790-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6ba892[collection1] main] [junit4] 2> 1430715 INFO (coreLoadExecutor-3790-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1430761 INFO (coreLoadExecutor-3790-thread-1) [ ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1430953 INFO (coreLoadExecutor-3790-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1430953 INFO (searcherExecutor-3791-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1430954 INFO (coreLoadExecutor-3790-thread-1) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1558600917994962944 [junit4] 2> 1430954 INFO (searcherExecutor-3791-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1430954 INFO (searcherExecutor-3791-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1430954 INFO (searcherExecutor-3791-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1430956 INFO (searcherExecutor-3791-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1430957 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 1430957 INFO (searcherExecutor-3791-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1430959 INFO (coreZkRegister-3783-thread-1) [ ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 1430959 INFO (coreZkRegister-3783-thread-1) [ ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 1430960 INFO (searcherExecutor-3791-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1430961 INFO (coreZkRegister-3783-thread-1) [ ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://188.138.57.78:8983/collection1/ shard1 [junit4] 2> 1430962 INFO (searcherExecutor-3791-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1430963 INFO (searcherExecutor-3791-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1430964 INFO (searcherExecutor-3791-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6ba892[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1430966 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testBasic [junit4] 2> 1431067 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=qlkciyopsbgzyvkylsjhchghjrdf&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 1431070 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{delete=[42 (-1558600918114500608)]} 0 1 [junit4] 2> 1431071 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[42 (1558600918116597760)]} 0 0 [junit4] 2> 1431071 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1431071 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@18a83c2 [junit4] 2> 1431075 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@199a3a5[collection1] main] [junit4] 2> 1431075 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1431076 INFO (searcherExecutor-3791-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@199a3a5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.1):c1)))} [junit4] 2> 1431076 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5 [junit4] 2> 1431077 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:42+AND+val_s:aa\;bb&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0 [junit4] 2> 1431077 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:42+AND+val_s:"aa;bb"&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0 [junit4] 2> 1431078 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:42+AND+val_s:aa&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 1431079 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{delete=[42 (-1558600918124986368)]} 0 1 [junit4] 2> 1431079 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1431080 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@18a83c2 [junit4] 2> 1431080 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2276c3[collection1] main] [junit4] 2> 1431080 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1431081 INFO (searcherExecutor-3791-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2276c3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1431081 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 1 [junit4] 2> 1431081 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:42&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 1431083 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[42 (1558600918129180672)]} 0 1 [junit4] 2> 1431083 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[42 (1558600918130229248)]} 0 0 [junit4] 2> 1431083 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1431083 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@18a83c2 [junit4] 2> 1431087 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@15c8a9d[collection1] main] [junit4] 2> 1431087 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1431088 INFO (searcherExecutor-3791-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@15c8a9d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.4.1):c2/1:delGen=1)))} [junit4] 2> 1431089 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5 [junit4] 2> 1431089 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:42&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0 [junit4] 2> 1431091 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[42 (1558600918136520704)]} 0 2 [junit4] 2> 1431091 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[42 (1558600918138617856)]} 0 0 [junit4] 2> 1431092 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1431092 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@18a83c2 [junit4] 2> 1431095 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@271587[collection1] main] [junit4] 2> 1431096 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1431097 INFO (searcherExecutor-3791-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@271587[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.4.1):c2/1:delGen=1)))} [junit4] 2> 1431097 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5 [junit4] 2> 1431097 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:42&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0 [junit4] 2> 1431099 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[101 (1558600918145957888)]} 0 1 [junit4] 2> 1431100 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[101 (1558600918148055040)]} 0 0 [junit4] 2> 1431100 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[105 (1558600918148055041)]} 0 0 [junit4] 2> 1431100 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[102 (1558600918148055042)]} 0 0 [junit4] 2> 1431100 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[103 (1558600918148055043)]} 0 0 [junit4] 2> 1431101 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[101 (1558600918149103616)]} 0 0 [junit4] 2> 1431101 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1431101 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@18a83c2 [junit4] 2> 1431105 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@c8fb0c[collection1] main] [junit4] 2> 1431105 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1431112 WARN (coreZkRegister-3783-thread-1) [ ] o.a.s.c.ZkController Skipping recovery according to sys prop solrcloud.skip.autorecovery [junit4] 2> 1431112 INFO (searcherExecutor-3791-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@c8fb0c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.4.1):c2/1:delGen=1) Uninverting(_3(6.4.1):c6/2:delGen=1)))} [junit4] 2> 1431112 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 11 [junit4] 2> 1431112 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38157 38157 [junit4] 2> 1431394 INFO (Thread-2171) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38157 38157 [junit4] 2> 1431395 WARN (Thread-2171) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 3 /solr/overseer/queue [junit4] 2> 2 /solr/overseer/queue-work [junit4] 2> [junit4] 2> 1431396 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[201 (1558600918457384960)]} 0 1 [junit4] 2> 1431495 WARN (zkCallback-1126-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@926228 name: ZooKeeperConnection Watcher:127.0.0.1:38157/solr got event WatchedEvent state:Disconnected type:None path:null path: null type: None [junit4] 2> 1431495 WARN (zkCallback-1126-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has disconnected [junit4] 2> 1431697 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1431697 INFO (Thread-2173) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:38157 [junit4] 2> 1431697 INFO (Thread-2173) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1431797 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.c.ZkTestServer start zk server on port:38157 [junit4] 2> 1432098 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:[100+TO+110]&rows=2147483647&wt=xml} hits=4 status=0 QTime=0 [junit4] 2> 1432098 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:[100+TO+111]&rows=1147483647&wt=xml} hits=4 status=0 QTime=0 [junit4] 2> 1432099 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:[100+TO+110]&qt=standard&start=0&rows=20&version=2.2} hits=4 status=0 QTime=0 [junit4] 2> 1432099 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{delete=[102 (-1558600919195582464)]} 0 0 [junit4] 2> 1432099 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1432100 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@18a83c2 [junit4] 2> 1432103 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@14ce663[collection1] main] [junit4] 2> 1432103 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1432104 INFO (searcherExecutor-3791-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@14ce663[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.4.1):c2/1:delGen=1) Uninverting(_3(6.4.1):c6/3:delGen=2) Uninverting(_4(6.4.1):c1)))} [junit4] 2> 1432104 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 4 [junit4] 2> 1432104 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:[100+TO+110]&qt=standard&start=0&rows=20&version=2.2} hits=3 status=0 QTime=0 [junit4] 2> 1432106 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{delete=[105 (-1558600919200825344)]} 0 1 [junit4] 2> 1432106 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1432106 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@18a83c2 [junit4] 2> 1432106 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@129113e[collection1] main] [junit4] 2> 1432106 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1432107 INFO (searcherExecutor-3791-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@129113e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.4.1):c2/1:delGen=1) Uninverting(_3(6.4.1):c6/4:delGen=3) Uninverting(_4(6.4.1):c1)))} [junit4] 2> 1432108 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 1 [junit4] 2> 1432108 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:[100+TO+110]&qt=standard&start=0&rows=20&version=2.2} hits=2 status=0 QTime=0 [junit4] 2> 1432110 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@a5f96b[collection1] realtime] [junit4] 2> 1432110 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=id:[100 TO 110] (-1558600919205019648)} 0 2 [junit4] 2> 1432110 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1432110 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@18a83c2 [junit4] 2> 1432111 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@14f796a[collection1] main] [junit4] 2> 1432111 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1432112 INFO (searcherExecutor-3791-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@14f796a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.4.1):c2/1:delGen=1) Uninverting(_4(6.4.1):c1)))} [junit4] 2> 1432113 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 2 [junit4] 2> 1432113 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:[100+TO+110]&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 1432865 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1432927 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.c.Config Ignoring exception matching solrconfig.xml [junit4] 2> 1432927 INFO (TEST-BasicZkTest.testBasic-seed#[5DFA36307FEA60D4]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testBasic [junit4] 2> 1432928 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 1432928 INFO (SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> Feb 06, 2017 4:14:27 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 21 leaked thread(s). [junit4] 2> Feb 06, 2017 4:14:47 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> SEVERE: 21 threads leaked from SUITE scope at org.apache.solr.cloud.BasicZkTest: [junit4] 2> 1) Thread[id=8076, name=SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker-EventThread, state=WAITING, group=TGRP-BasicZkTest] [junit4] 2> at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) [junit4] 2> at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.java:192) [junit4] 2> at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062) [junit4] 2> at java.base@9-ea/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:435) [junit4] 2> at app//org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:494) [junit4] 2> 2) Thread[id=8078, name=OverseerStateUpdate-97412557254688771-188.138.57.78:8983_-n_0000000000, state=TIMED_WAITING, group=Overseer state updater.] [junit4] 2> at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) [junit4] 2> at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) [junit4] 2> at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2104) [junit4] 2> at app//org.apache.solr.cloud.DistributedQueue.peek(DistributedQueue.java:164) [junit4] 2> at app//org.apache.solr.cloud.DistributedQueue.peek(DistributedQueue.java:138) [junit4] 2> at app//org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:179) [junit4] 2> at java.base@9-ea/java.lang.Thread.run(Thread.java:844) [junit4] 2> 3) Thread[id=8080, name=OverseerHdfsCoreFailoverThread-97412557254688771-188.138.57.78:8983_-n_0 [...truncated too long message...] kRegister-3783-thread-1, state=TIMED_WAITING, group=TGRP-BasicZkTest] [junit4] > at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) [junit4] > at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [junit4] > at java.base@9-ea/java.lang.Thread.run(Thread.java:844) [junit4] > 3) Thread[id=8088, name=zkCallback-1126-thread-3, state=TIMED_WAITING, group=TGRP-BasicZkTest] [junit4] > at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) [junit4] > at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [junit4] > at java.base@9-ea/java.lang.Thread.run(Thread.java:844) [junit4] > 4) Thread[id=8082, name=Thread-2172, state=WAITING, group=TGRP-BasicZkTest] [junit4] > at java.base@9-ea/java.lang.Object.wait(Native Method) [junit4] > at java.base@9-ea/java.lang.Object.wait(Object.java:516) [junit4] > at app//org.apache.solr.core.CloserThread.run(CoreContainer.java:1335) [junit4] > 5) Thread[id=8091, name=zkCallback-1126-thread-6, state=TIMED_WAITING, group=TGRP-BasicZkTest] [junit4] > at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) [junit4] > at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [junit4] > at java.base@9-ea/java.lang.Thread.run(Thread.java:844) [junit4] > 6) Thread[id=8087, name=zkCallback-1126-thread-2, state=TIMED_WAITING, group=TGRP-BasicZkTest] [junit4] > at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) [junit4] > at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [junit4] > at java.base@9-ea/java.lang.Thread.run(Thread.java:844) [junit4] > 7) Thread[id=8075, name=SUITE-BasicZkTest-seed#[5DFA36307FEA60D4]-worker-SendThread(127.0.0.1:38157), state=TIMED_WAITING, group=TGRP-BasicZkTest] [junit4] > at java.base@9-ea/java.lang.Thread.sleep(Native Method) [junit4] > at app//org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:994) [junit4] > 8) Thread[id=8089, name=zkCallback-1126-thread-4, state=TIMED_WAITING, group=TGRP-BasicZkTest] [junit4] > at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) [junit4] > at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [junit4] > at java.base@9-ea/java.lang.Thread.run(Thread.java:844) [junit4] > 9) Thread[id=8090, name=zkCallback-1126-thread-5, state=TIMED_WAITING, group=TGRP-BasicZkTest] [junit4] > at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) [junit4] > at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [junit4] > at java.base@9-ea/java.lang.Thread.run(Thread.java:844) [junit4] > 10) Thread[id=8077, name=zkCallback-1126-thread-1, state=TIMED_WAITING, group=TGRP-BasicZkTest] [junit4] > at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) [junit4] > at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [junit4] > at java.base@9-ea/java.lang.Thread.run(Thread.java:844) [junit4] > 11) Thread[id=8083, name=watches-1127-thread-1, state=TIMED_WAITING, group=TGRP-BasicZkTest] [junit4] > at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) [junit4] > at java.base@9-ea/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:232) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:462) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:361) [junit4] > at java.base@9-ea/java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:937) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1085) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) [junit4] > at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [junit4] > at java.base@9-ea/java.lang.Thread.run(Thread.java:844) [junit4] > at __randomizedtesting.SeedInfo.seed([5DFA36307FEA60D4]:0) [junit4] Completed [445/680 (1!)] on J0 in 27.09s, 1 test, 4 errors <<< FAILURES! [...truncated 52328 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org