Build: https://builds.apache.org/job/Lucene-Solr-Tests-5.x-Java7/2351/
4 tests failed.
REGRESSION:
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testDistribSearch
Error Message:
expected:<...5C18C4F6A2BA1-001/te[mpDir-003/solrj_test_core_props_shard1_replica1]>
but
was:<...5C18C4F6A2BA1-001/te[stPropertyParamsForCreate-001/instanceDir-ksif]>
Stack Trace:
org.junit.ComparisonFailure:
expected:<...5C18C4F6A2BA1-001/te[mpDir-003/solrj_test_core_props_shard1_replica1]>
but
was:<...5C18C4F6A2BA1-001/te[stPropertyParamsForCreate-001/instanceDir-ksif]>
at
__randomizedtesting.SeedInfo.seed([69B5C18C4F6A2BA1:E8534F9438354B9D]:0)
at org.junit.Assert.assertEquals(Assert.java:125)
at org.junit.Assert.assertEquals(Assert.java:147)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.checkInstanceDirs(CollectionsAPIDistributedZkTest.java:1154)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI(CollectionsAPIDistributedZkTest.java:901)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.doTest(CollectionsAPIDistributedZkTest.java:205)
at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest
Error Message:
ERROR: SolrZkClient opens=22 closes=21
Stack Trace:
java.lang.AssertionError: ERROR: SolrZkClient opens=22 closes=21
at __randomizedtesting.SeedInfo.seed([69B5C18C4F6A2BA1]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.SolrTestCaseJ4.endTrackingZkClients(SolrTestCaseJ4.java:461)
at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:188)
at sun.reflect.GeneratedMethodAccessor30.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:790)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest
Error Message:
6 threads leaked from SUITE scope at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest: 1) Thread[id=1698,
name=zkCallback-172-thread-4, state=TIMED_WAITING,
group=TGRP-CollectionsAPIDistributedZkTest] at
sun.misc.Unsafe.park(Native Method) at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
at
java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745) 2) Thread[id=1474,
name=TEST-CollectionsAPIDistributedZkTest.testDistribSearch-seed#[69B5C18C4F6A2BA1]-EventThread,
state=WAITING, group=TGRP-CollectionsAPIDistributedZkTest] at
sun.misc.Unsafe.park(Native Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:494)
3) Thread[id=1625, name=zkCallback-172-thread-2, state=TIMED_WAITING,
group=TGRP-CollectionsAPIDistributedZkTest] at
sun.misc.Unsafe.park(Native Method) at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
at
java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745) 4) Thread[id=1475,
name=zkCallback-172-thread-1, state=TIMED_WAITING,
group=TGRP-CollectionsAPIDistributedZkTest] at
sun.misc.Unsafe.park(Native Method) at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
at
java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745) 5) Thread[id=1473,
name=TEST-CollectionsAPIDistributedZkTest.testDistribSearch-seed#[69B5C18C4F6A2BA1]-SendThread(127.0.0.1:33177),
state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] at
sun.nio.ch.KQueueArrayWrapper.kevent0(Native Method) at
sun.nio.ch.KQueueArrayWrapper.poll(KQueueArrayWrapper.java:200) at
sun.nio.ch.KQueueSelectorImpl.doSelect(KQueueSelectorImpl.java:103) at
sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87) at
sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98) at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:349)
at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1081) 6)
Thread[id=1636, name=zkCallback-172-thread-3, state=TIMED_WAITING,
group=TGRP-CollectionsAPIDistributedZkTest] at
sun.misc.Unsafe.park(Native Method) at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
at
java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 6 threads leaked from SUITE
scope at org.apache.solr.cloud.CollectionsAPIDistributedZkTest:
1) Thread[id=1698, name=zkCallback-172-thread-4, state=TIMED_WAITING,
group=TGRP-CollectionsAPIDistributedZkTest]
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
2) Thread[id=1474,
name=TEST-CollectionsAPIDistributedZkTest.testDistribSearch-seed#[69B5C18C4F6A2BA1]-EventThread,
state=WAITING, group=TGRP-CollectionsAPIDistributedZkTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:494)
3) Thread[id=1625, name=zkCallback-172-thread-2, state=TIMED_WAITING,
group=TGRP-CollectionsAPIDistributedZkTest]
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
4) Thread[id=1475, name=zkCallback-172-thread-1, state=TIMED_WAITING,
group=TGRP-CollectionsAPIDistributedZkTest]
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
5) Thread[id=1473,
name=TEST-CollectionsAPIDistributedZkTest.testDistribSearch-seed#[69B5C18C4F6A2BA1]-SendThread(127.0.0.1:33177),
state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
at sun.nio.ch.KQueueArrayWrapper.kevent0(Native Method)
at sun.nio.ch.KQueueArrayWrapper.poll(KQueueArrayWrapper.java:200)
at sun.nio.ch.KQueueSelectorImpl.doSelect(KQueueSelectorImpl.java:103)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:349)
at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1081)
6) Thread[id=1636, name=zkCallback-172-thread-3, state=TIMED_WAITING,
group=TGRP-CollectionsAPIDistributedZkTest]
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
at __randomizedtesting.SeedInfo.seed([69B5C18C4F6A2BA1]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest
Error Message:
There are still zombie threads that couldn't be terminated: 1)
Thread[id=1625, name=zkCallback-172-thread-2, state=TIMED_WAITING,
group=TGRP-CollectionsAPIDistributedZkTest] at
sun.misc.Unsafe.park(Native Method) at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
at
java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745) 2) Thread[id=1475,
name=zkCallback-172-thread-1, state=TIMED_WAITING,
group=TGRP-CollectionsAPIDistributedZkTest] at
sun.misc.Unsafe.park(Native Method) at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
at
java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745) 3) Thread[id=1473,
name=TEST-CollectionsAPIDistributedZkTest.testDistribSearch-seed#[69B5C18C4F6A2BA1]-SendThread(127.0.0.1:33177),
state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] at
sun.nio.ch.KQueueArrayWrapper.kevent0(Native Method) at
sun.nio.ch.KQueueArrayWrapper.poll(KQueueArrayWrapper.java:200) at
sun.nio.ch.KQueueSelectorImpl.doSelect(KQueueSelectorImpl.java:103) at
sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87) at
sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98) at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:349)
at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1081) 4)
Thread[id=1636, name=zkCallback-172-thread-3, state=TIMED_WAITING,
group=TGRP-CollectionsAPIDistributedZkTest] at
sun.misc.Unsafe.park(Native Method) at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
at
java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745) 5) Thread[id=1698,
name=zkCallback-172-thread-4, state=TIMED_WAITING,
group=TGRP-CollectionsAPIDistributedZkTest] at
sun.misc.Unsafe.park(Native Method) at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
at
java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
1) Thread[id=1625, name=zkCallback-172-thread-2, state=TIMED_WAITING,
group=TGRP-CollectionsAPIDistributedZkTest]
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
2) Thread[id=1475, name=zkCallback-172-thread-1, state=TIMED_WAITING,
group=TGRP-CollectionsAPIDistributedZkTest]
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
3) Thread[id=1473,
name=TEST-CollectionsAPIDistributedZkTest.testDistribSearch-seed#[69B5C18C4F6A2BA1]-SendThread(127.0.0.1:33177),
state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
at sun.nio.ch.KQueueArrayWrapper.kevent0(Native Method)
at sun.nio.ch.KQueueArrayWrapper.poll(KQueueArrayWrapper.java:200)
at sun.nio.ch.KQueueSelectorImpl.doSelect(KQueueSelectorImpl.java:103)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:349)
at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1081)
4) Thread[id=1636, name=zkCallback-172-thread-3, state=TIMED_WAITING,
group=TGRP-CollectionsAPIDistributedZkTest]
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
5) Thread[id=1698, name=zkCallback-172-thread-4, state=TIMED_WAITING,
group=TGRP-CollectionsAPIDistributedZkTest]
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
at __randomizedtesting.SeedInfo.seed([69B5C18C4F6A2BA1]:0)
Build Log:
[...truncated 9345 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/init-core-data-001
[junit4] 2> 482588 T1248 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(true) and clientAuth (false)
[junit4] 2> 482588 T1248 oas.BaseDistributedSearchTestCase.initHostContext
Setting hostContext system property: /
[junit4] 2> 482594 T1248 oas.SolrTestCaseJ4.setUp ###Starting
testDistribSearch
[junit4] 2> 482595 T1248 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 482595 T1249 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 482695 T1248 oasc.ZkTestServer.run start zk server on
port:33177
[junit4] 2> 482696 T1248
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 482697 T1248 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 482700 T1256 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@12139505
name:ZooKeeperConnection Watcher:127.0.0.1:33177 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 482701 T1248 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 482701 T1248 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 482701 T1248 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 482705 T1248
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 482705 T1248 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 482707 T1259 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5d32ca12
name:ZooKeeperConnection Watcher:127.0.0.1:33177/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 482707 T1248 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 482708 T1248 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 482708 T1248 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 482711 T1248 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 482713 T1248 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 482715 T1248 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 482718 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 482719 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 482722 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 482723 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 482826 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 482827 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 482829 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 482830 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 482833 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 482834 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 482836 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 482837 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 482840 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 482840 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 482843 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 482844 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 482846 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 482847 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 482850 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 482850 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 482853 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 482854 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> 482857 T1248
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 482858 T1248 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 482859 T1262 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@7a47ea5a
name:ZooKeeperConnection Watcher:127.0.0.1:33177/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 482860 T1248 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 482860 T1248 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> Using new style solr.xml
[junit4] 2> 482863 T1248
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 482863 T1248 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 482865 T1265 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5623059d
name:ZooKeeperConnection Watcher:127.0.0.1:33177 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 482865 T1248 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 482866 T1248 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 482866 T1248 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 482868 T1248
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 482869 T1248 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 482871 T1268 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@6528be6f
name:ZooKeeperConnection Watcher:127.0.0.1:33177/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 482871 T1248 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 482871 T1248 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 482873 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf2/solrconfig.xml
[junit4] 2> 482874 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf2/solrconfig.xml
[junit4] 2> 482877 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf2/schema.xml
[junit4] 2> 482878 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf2/schema.xml
[junit4] 2> 482980 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf2/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 482980 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf2/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 482983 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf2/stopwords.txt
[junit4] 2> 482984 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf2/stopwords.txt
[junit4] 2> 482986 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf2/protwords.txt
[junit4] 2> 482987 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf2/protwords.txt
[junit4] 2> 482989 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf2/currency.xml
[junit4] 2> 482990 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf2/currency.xml
[junit4] 2> 482993 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf2/open-exchange-rates.json
[junit4] 2> 482993 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf2/open-exchange-rates.json
[junit4] 2> 482996 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf2/mapping-ISOLatin1Accent.txt
[junit4] 2> 482996 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf2/mapping-ISOLatin1Accent.txt
[junit4] 2> 482999 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf2/old_synonyms.txt
[junit4] 2> 482999 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf2/old_synonyms.txt
[junit4] 2> 483002 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf2/synonyms.txt
[junit4] 2> 483003 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf2/synonyms.txt
[junit4] 2> 483005 T1248 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/elevate.xml
to /configs/conf2/elevate.xml
[junit4] 2> 483006 T1248 oascc.SolrZkClient.makePath makePath:
/configs/conf2/elevate.xml
[junit4] 2> 484205 T1248 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 484209 T1248 oejus.SslContextFactory.doStart Enabled Protocols
[SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1,
TLSv1.1, TLSv1.2]
[junit4] 2> 484211 T1248 oejs.AbstractConnector.doStart Started
[email protected]:33183
[junit4] 2> 484213 T1248 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 484213 T1248 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 484213 T1248 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-002
[junit4] 2> 484213 T1248 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-002/'
[junit4] 2> 484243 T1248 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-002/solr.xml
[junit4] 2> 484284 T1248 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-002
[junit4] 2> 484285 T1248 oasc.CoreContainer.<init> New CoreContainer
2004766378
[junit4] 2> 484285 T1248 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-002/]
[junit4] 2> 484286 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 484286 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 484286 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 484287 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 484287 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 484287 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 484287 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 484287 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 484288 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 484288 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 484290 T1248 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 484292 T1248 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 484292 T1248 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 484292 T1248 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 484292 T1248 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:33177/solr
[junit4] 2> 484293 T1248 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 484293 T1248
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 484293 T1248 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 484315 T1280 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@71365ca3
name:ZooKeeperConnection Watcher:127.0.0.1:33177 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 484316 T1248 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 484316 T1248 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 484318 T1248 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 484320 T1283 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@2779aca7
name:ZooKeeperConnection Watcher:127.0.0.1:33177/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 484321 T1248 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 484322 T1248 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 484325 T1248 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 484328 T1248 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 484331 T1248 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 484334 T1248 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 484338 T1248 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 484340 T1248 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33183_
[junit4] 2> 484341 T1248 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:33183_
[junit4] 2> 484344 T1248 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 484346 T1248 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 484348 T1248 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 484350 T1248 oasc.OverseerElectionContext.runLeaderProcess I
am going to be the leader 127.0.0.1:33183_
[junit4] 2> 484350 T1248 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 484352 T1248 oasc.Overseer.start Overseer
(id=92997245670785030-127.0.0.1:33183_-n_0000000000) starting
[junit4] 2> 484355 T1248 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 484365 T1248 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=10000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 484365 T1285 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 484366 T1248 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 484368 T1248 oascc.SolrZkClient.makePath makePath:
/aliases.json
[junit4] 2> 484370 T1248
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 484374 T1284 oasc.Overseer$ClusterStateUpdater.run Starting to
work on the main queue
[junit4] 2> 484375 T1248 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-002
[junit4] 2> 485321 T1248 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-002/conf/
[junit4] 2> 485321 T1248 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 485323 T1248 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2
[junit4] 2> 485323 T1248 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 485326 T1248
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 485327 T1248 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 485328 T1290 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5cffaed0
name:ZooKeeperConnection Watcher:127.0.0.1:33177/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 485328 T1248 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 485329 T1248 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 485330 T1248
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 485333 T1248 oasc.ChaosMonkey.monkeyLog monkey: init - expire
sessions:false cause connection loss:false
[junit4] 2> 485333 T1248 oasc.AbstractFullDistribZkTestBase.createJettys
Creating collection1 with stateFormat=2
[junit4] 2> 485333 T1248
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 485334 T1248 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 485335 T1293 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@793447a2
name:ZooKeeperConnection Watcher:127.0.0.1:33177/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 485335 T1248 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 485336 T1248 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 485338 T1283 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 485342 T1284 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 0, message = {
[junit4] 2> "operation":"create",
[junit4] 2> "name":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "stateFormat":2} current state version: 0
[junit4] 2> 485342 T1284 oasco.ClusterStateMutator.createCollection
building a new cName: collection1
[junit4] 2> 485343 T1284 oasco.ZkStateWriter.writePendingUpdates going to
create_collection /collections/collection1/state.json
[junit4] 2> 485344 T1290 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 485344 T1283 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 486238 T1248 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 486238 T1248 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 486242 T1248 oejus.SslContextFactory.doStart Enabled Protocols
[SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1,
TLSv1.1, TLSv1.2]
[junit4] 2> 486244 T1248 oejs.AbstractConnector.doStart Started
[email protected]:33188
[junit4] 2> 486246 T1248 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 486246 T1248 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 486246 T1248 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-003
[junit4] 2> 486246 T1248 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-003/'
[junit4] 2> 486276 T1248 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-003/solr.xml
[junit4] 2> 486317 T1248 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-003
[junit4] 2> 486318 T1248 oasc.CoreContainer.<init> New CoreContainer
1249175492
[junit4] 2> 486318 T1248 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-003/]
[junit4] 2> 486319 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 486319 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 486319 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 486319 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 486320 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 486320 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 486320 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 486320 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 486321 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 486321 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 486323 T1248 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 486324 T1248 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 486325 T1248 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 486325 T1248 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 486325 T1248 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:33177/solr
[junit4] 2> 486325 T1248 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 486326 T1248
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 486326 T1248 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 486328 T1305 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@461ee405
name:ZooKeeperConnection Watcher:127.0.0.1:33177 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 486329 T1248 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 486329 T1248 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 486332 T1248 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 486333 T1308 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@21b3e77f
name:ZooKeeperConnection Watcher:127.0.0.1:33177/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 486333 T1248 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 486340 T1248
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 487347 T1248 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33188_
[junit4] 2> 487348 T1248 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:33188_
[junit4] 2> 487353 T1248 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 487358 T1248 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-003
[junit4] 2> 487539 T1248 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-003/conf/
[junit4] 2> 488485 T1248 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 488486 T1248 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2
[junit4] 2> 488487 T1248 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 489392 T1248 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 489393 T1248 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 489397 T1248 oejus.SslContextFactory.doStart Enabled Protocols
[SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1,
TLSv1.1, TLSv1.2]
[junit4] 2> 489398 T1248 oejs.AbstractConnector.doStart Started
[email protected]:33191
[junit4] 2> 489400 T1248 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 489400 T1248 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 489401 T1248 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-004
[junit4] 2> 489401 T1248 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-004/'
[junit4] 2> 489430 T1248 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-004/solr.xml
[junit4] 2> 489471 T1248 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-004
[junit4] 2> 489472 T1248 oasc.CoreContainer.<init> New CoreContainer
2057449659
[junit4] 2> 489472 T1248 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-004/]
[junit4] 2> 489473 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 489473 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 489473 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 489473 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 489474 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 489474 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 489474 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 489474 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 489475 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 489475 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 489477 T1248 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 489478 T1248 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 489479 T1248 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 489479 T1248 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 489479 T1248 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:33177/solr
[junit4] 2> 489479 T1248 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 489480 T1248
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 489480 T1248 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 489482 T1321 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@655e513f
name:ZooKeeperConnection Watcher:127.0.0.1:33177 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 489483 T1248 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 489483 T1248 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 489485 T1248 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 489487 T1324 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@378f53ba
name:ZooKeeperConnection Watcher:127.0.0.1:33177/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 489487 T1248 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 489494 T1248
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 490501 T1248 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33191_
[junit4] 2> 490502 T1248 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:33191_
[junit4] 2> 490507 T1248 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 490512 T1248 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-004
[junit4] 2> 491484 T1248 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-004/conf/
[junit4] 2> 491495 T1248 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 491497 T1248 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2
[junit4] 2> 491497 T1248 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 492809 T1248 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 3
[junit4] 2> 492810 T1248 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 492816 T1248 oejus.SslContextFactory.doStart Enabled Protocols
[SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1,
TLSv1.1, TLSv1.2]
[junit4] 2> 492817 T1248 oejs.AbstractConnector.doStart Started
[email protected]:33194
[junit4] 2> 492821 T1248 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 492821 T1248 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 492821 T1248 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-005
[junit4] 2> 492822 T1248 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-005/'
[junit4] 2> 492868 T1248 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-005/solr.xml
[junit4] 2> 492913 T1248 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-005
[junit4] 2> 492914 T1248 oasc.CoreContainer.<init> New CoreContainer
992068152
[junit4] 2> 492914 T1248 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-005/]
[junit4] 2> 492915 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 492915 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 492916 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 492916 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 492916 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 492916 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 492916 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 492917 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 492917 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 492917 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 492919 T1248 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 492921 T1248 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 492921 T1248 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 492921 T1248 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 492922 T1248 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:33177/solr
[junit4] 2> 492922 T1248 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 492922 T1248
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 492923 T1248 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 492925 T1337 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3da27739
name:ZooKeeperConnection Watcher:127.0.0.1:33177 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 492926 T1248 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 492926 T1248 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 492928 T1248 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 492929 T1340 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@582a1c40
name:ZooKeeperConnection Watcher:127.0.0.1:33177/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 492930 T1248 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 492936 T1248
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 493942 T1248 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33194_
[junit4] 2> 493943 T1248 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:33194_
[junit4] 2> 493949 T1248 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 493953 T1248 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-005
[junit4] 2> 493959 T1248 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-005/conf/
[junit4] 2> 495203 T1248 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 495204 T1248 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2
[junit4] 2> 495205 T1248 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 496116 T1248 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 4
[junit4] 2> 496117 T1248 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 496121 T1248 oejus.SslContextFactory.doStart Enabled Protocols
[SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1,
TLSv1.1, TLSv1.2]
[junit4] 2> 496122 T1248 oejs.AbstractConnector.doStart Started
[email protected]:37526
[junit4] 2> 496124 T1248 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 496124 T1248 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 496125 T1248 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-006
[junit4] 2> 496125 T1248 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-006/'
[junit4] 2> 496359 T1248 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-006/solr.xml
[junit4] 2> 496401 T1248 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-006
[junit4] 2> 496402 T1248 oasc.CoreContainer.<init> New CoreContainer
1465074818
[junit4] 2> 496402 T1248 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-006/]
[junit4] 2> 496403 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 496403 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 496403 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 496404 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 496404 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 496404 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 496404 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 496405 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 496405 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 496405 T1248 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 496407 T1248 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 496409 T1248 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 496409 T1248 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 496409 T1248 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 496410 T1248 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:33177/solr
[junit4] 2> 496410 T1248 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 496410 T1248
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 496411 T1248 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 496412 T1353 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1dcdb515
name:ZooKeeperConnection Watcher:127.0.0.1:33177 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 496413 T1248 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 496413 T1248 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 496415 T1248 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 496416 T1356 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@36699f6 name:ZooKeeperConnection
Watcher:127.0.0.1:33177/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 496416 T1248 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 496421 T1248
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 497426 T1248 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37526_
[junit4] 2> 497427 T1248 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:37526_
[junit4] 2> 497431 T1248 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 497435 T1248 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-006
[junit4] 2> 498127 T1248 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest-69B5C18C4F6A2BA1-001/tempDir-006/conf/
[junit4] 2> 498141 T1248 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 498142 T1248 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J2
[junit4] 2> 498142 T1248 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 498273 T1297 oasha.CollectionsHandler.handleCreateAction
Creating Collection :
router.field=myOwnField&action=CREATE&collection.configName=conf1&wt=javabin&numShards=2&name=solrj_collection&version=2&replicationFactor=2
[junit4] 2> 498275 T1283 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/collection-queue-work state
SyncConnected
[junit4] 2> 498276 T1285 oasc.OverseerCollectionProcessor.run Overseer
Collection Processor: Get the message
id:/overseer/collection-queue-work/qn-0000000000 message:{
[junit4] 2> "operation":"create",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"solrj_collection",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"conf1",
[junit4] 2> "numShards":"2",
[junit4] 2> "router.field":"myOwnField"}
[junit4] 2> 498281 T1359 oasc.OverseerCollectionProcessor.processMessage
WARN OverseerCollectionProcessor.processMessage : create , {
[junit4] 2> "operation":"create",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"solrj_collection",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"conf1",
[junit4] 2> "numShards":"2",
[junit4] 2> "router.field":"myOwnField"}
[junit4] 2> 498285 T1359 oasc.OverseerCollectionProcessor.createConfNode
creating collections conf node /collections/solrj_collection
[junit4] 2> 498286 T1359 oascc.SolrZkClient.makePath makePath:
/collections/solrj_collection
[junit4] 2> 498289 T1283 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 498290 T1284 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"create",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"solrj_collection",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"conf1",
[junit4] 2> "numShards":"2",
[junit4] 2> "router.field":"myOwnField"} current state version: 1
[junit4] 2> 498290 T1284 oasco.ClusterStateMutator.createCollection
building a new cName: solrj_collection
[junit4] 2> 498292 T1283 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 498292 T1324 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 498292 T1356 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 498292 T1290 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 498292 T1308 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 498292 T1340 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 498490 T1359 oasc.OverseerCollectionProcessor.createCollection
Creating SolrCores for new collection solrj_collection, shardNames [shard1,
shard2] , replicationFactor : 2
[junit4] 2> 498491 T1359 oasc.OverseerCollectionProcessor.createCollection
Creating shard solrj_collection_shard1_replica1 as part of slice shard1 of
collection solrj_collection on 127.0.0.1:33188_
[junit4] 2> 498492 T1359 oasc.OverseerCollectionProcessor.createCollection
Creating shard solrj_collection_shard1_replica2 as part of slice shard1 of
collection solrj_collection on 127.0.0.1:33183_
[junit4] 2> 498494 T1359 oasc.OverseerCollectionProcessor.createCollection
Creating shard solrj_collection_shard2_replica1 as part of slice shard2 of
collection solrj_collection on 127.0.0.1:37526_
[junit4] 2> 498496 T1359 oasc.OverseerCollectionProcessor.createCollection
Creating shard solrj_collection_shard2_replica2 as part of slice shard2 of
collection solrj_collection on 127.0.0.1:33191_
[junit4] 2> 498616 T1274 oasha.CoreAdminHandler.handleCreateAction core
create command
action=CREATE&collection.configName=conf1&wt=javabin&numShards=2&name=solrj_collection_shard1_replica2&shard=shard1&version=2&collection=solrj_collection&qt=/admin/cores
[junit4] 2> 498616 T1299 oasha.CoreAdminHandler.handleCreateAction core
create command
action=CREATE&collection.configName=conf1&wt=javabin&numShards=2&name=solrj_collection_shard1_replica1&shard=shard1&version=2&collection=solrj_collection&qt=/admin/cores
[junit4] 2> 498618 T1344 oasha.CoreAdminHandler.handleCreateAction core
create command
action=CREATE&collection.configName=conf1&wt=javabin&numShards=2&name=solrj_collection_shard2_replica1&shard=shard2&version=2&collection=solrj_collection&qt=/admin/cores
[junit4] 2> 498620 T1274 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica2 state=down collection=solrj_collection
[junit4] 2> 498620 T1299 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica1 state=down collection=solrj_collection
[junit4] 2> 498621 T1283 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 498621 T1274 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 498622 T1299 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 498621 T1344 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica1 state=down collection=solrj_collection
[junit4] 2> 498623 T1284 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 2, message = {
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:33183_",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:33183";,
[junit4] 2> "core":"solrj_collection_shard1_replica2"} current
state version: 2
[junit4] 2> 498623 T1344 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 498624 T1284 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:33183_",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:33183";,
[junit4] 2> "core":"solrj_collection_shard1_replica2"}
[junit4] 2> 498625 T1315 oasha.CoreAdminHandler.handleCreateAction core
create command
action=CREATE&collection.configName=conf1&wt=javabin&numShards=2&name=solrj_collection_shard2_replica2&shard=shard2&version=2&collection=solrj_collection&qt=/admin/cores
[junit4] 2> 498626 T1284 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 2, message = {
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:33188_",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:33188";,
[junit4] 2> "core":"solrj_collection_shard1_replica1"} current
state version: 2
[junit4] 2> 498627 T1284 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:33188_",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:33188";,
[junit4] 2> "core":"solrj_collection_shard1_replica1"}
[junit4] 2> 498628 T1315 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica2 state=down collection=solrj_collection
[junit4] 2> 498629 T1283 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 498629 T1315 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 498630 T1284 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 2, message = {
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:37526_",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:37526";,
[junit4] 2> "core":"solrj_collection_shard2_replica1"} current
state version: 2
[junit4] 2> 498631 T1284 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:37526_",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:37526";,
[junit4] 2> "core":"solrj_collection_shard2_replica1"}
[junit4] 2> 498633 T1283 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 498634 T1284 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 2, message = {
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:33191_",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:33191";,
[junit4] 2> "core":"solrj_collection_shard2_replica2"} current
state version: 2
[junit4] 2> 498635 T1284 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:33191_",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:33191";,
[junit4] 2> "core":"solrj_collection_shard2_replica2"}
[junit4] 2> 498738 T1308 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 498738 T1356 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 498738 T1324 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 498738 T1340 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 498738 T1290 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 498738 T1283 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 499622 T1299 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard1_replica1
[junit4] 2> 499622 T1274 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard1_replica2
[junit4] 2> 499623 T1299 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 499623 T1274 oasc.ZkController.create
[...truncated too long message...]
.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > 4) Thread[id=1475, name=zkCallback-172-thread-1,
state=TIMED_WAITING, group=TGRP-CollectionsAPIDistributedZkTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
[junit4] > at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
[junit4] > at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
[junit4] > at
java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > 5) Thread[id=1473,
name=TEST-CollectionsAPIDistributedZkTest.testDistribSearch-seed#[69B5C18C4F6A2BA1]-SendThread(127.0.0.1:33177),
state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
[junit4] > at sun.nio.ch.KQueueArrayWrapper.kevent0(Native Method)
[junit4] > at
sun.nio.ch.KQueueArrayWrapper.poll(KQueueArrayWrapper.java:200)
[junit4] > at
sun.nio.ch.KQueueSelectorImpl.doSelect(KQueueSelectorImpl.java:103)
[junit4] > at
sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
[junit4] > at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
[junit4] > at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:349)
[junit4] > at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1081)
[junit4] > 6) Thread[id=1636, name=zkCallback-172-thread-3,
state=TIMED_WAITING, group=TGRP-CollectionsAPIDistributedZkTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
[junit4] > at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
[junit4] > at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
[junit4] > at
java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > at
__randomizedtesting.SeedInfo.seed([69B5C18C4F6A2BA1]:0)Throwable #3:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=1625, name=zkCallback-172-thread-2,
state=TIMED_WAITING, group=TGRP-CollectionsAPIDistributedZkTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
[junit4] > at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
[junit4] > at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
[junit4] > at
java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > 2) Thread[id=1475, name=zkCallback-172-thread-1,
state=TIMED_WAITING, group=TGRP-CollectionsAPIDistributedZkTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
[junit4] > at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
[junit4] > at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
[junit4] > at
java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > 3) Thread[id=1473,
name=TEST-CollectionsAPIDistributedZkTest.testDistribSearch-seed#[69B5C18C4F6A2BA1]-SendThread(127.0.0.1:33177),
state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
[junit4] > at sun.nio.ch.KQueueArrayWrapper.kevent0(Native Method)
[junit4] > at
sun.nio.ch.KQueueArrayWrapper.poll(KQueueArrayWrapper.java:200)
[junit4] > at
sun.nio.ch.KQueueSelectorImpl.doSelect(KQueueSelectorImpl.java:103)
[junit4] > at
sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
[junit4] > at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
[junit4] > at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:349)
[junit4] > at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1081)
[junit4] > 4) Thread[id=1636, name=zkCallback-172-thread-3,
state=TIMED_WAITING, group=TGRP-CollectionsAPIDistributedZkTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
[junit4] > at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
[junit4] > at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
[junit4] > at
java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > 5) Thread[id=1698, name=zkCallback-172-thread-4,
state=TIMED_WAITING, group=TGRP-CollectionsAPIDistributedZkTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
[junit4] > at
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
[junit4] > at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
[junit4] > at
java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > at
__randomizedtesting.SeedInfo.seed([69B5C18C4F6A2BA1]:0)
[junit4] Completed on J2 in 118.88s, 1 test, 2 failures, 2 errors <<<
FAILURES!
[...truncated 969 lines...]
BUILD FAILED
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:529:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:477:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:61:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/extra-targets.xml:39:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build.xml:190:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/common-build.xml:508:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/lucene/common-build.xml:1363:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/lucene/common-build.xml:970:
There were test failures: 452 suites, 1852 tests, 3 suite-level errors, 1
failure, 1048 ignored (12 assumptions)
Total time: 52 minutes 37 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-Tests-5.x-Java7 #2350
Archived 5 artifacts
Archive block size is 32768
Received 0 blocks and 116854134 bytes
Compression is 0.0%
Took 20 sec
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
