Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Windows/4235/
Java: 64bit/jdk1.7.0_67 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC
4 tests failed.
REGRESSION:
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testDistribSearch
Error Message:
collection already exists: awholynewcollection_0
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException:
collection already exists: awholynewcollection_0
at
__randomizedtesting.SeedInfo.seed([9D82B774612A0B3A:1C64396C16756B06]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:556)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:212)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:208)
at
org.apache.solr.client.solrj.impl.LBHttpSolrServer.doRequest(LBHttpSolrServer.java:343)
at
org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:304)
at
org.apache.solr.client.solrj.impl.CloudSolrServer.sendRequest(CloudSolrServer.java:880)
at
org.apache.solr.client.solrj.impl.CloudSolrServer.requestWithRetryOnStaleState(CloudSolrServer.java:658)
at
org.apache.solr.client.solrj.impl.CloudSolrServer.request(CloudSolrServer.java:601)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1548)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1499)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1557)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI(CollectionsAPIDistributedZkTest.java:759)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.doTest(CollectionsAPIDistributedZkTest.java:203)
at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
at sun.reflect.GeneratedMethodAccessor46.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$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:43)
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=17 closes=16
Stack Trace:
java.lang.AssertionError: ERROR: SolrZkClient opens=17 closes=16
at __randomizedtesting.SeedInfo.seed([9D82B774612A0B3A]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.SolrTestCaseJ4.endTrackingZkClients(SolrTestCaseJ4.java:455)
at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:188)
at sun.reflect.GeneratedMethodAccessor35.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:43)
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:
3 threads leaked from SUITE scope at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest: 1) Thread[id=6786,
name=zkCallback-897-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=6765,
name=TEST-CollectionsAPIDistributedZkTest.testDistribSearch-seed#[9D82B774612A0B3A]-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=6764,
name=TEST-CollectionsAPIDistributedZkTest.testDistribSearch-seed#[9D82B774612A0B3A]-SendThread(127.0.0.1:53115),
state=TIMED_WAITING, group=TGRP-CollectionsAPIDistributedZkTest] at
java.lang.Thread.sleep(Native Method) at
org.apache.zookeeper.client.StaticHostProvider.next(StaticHostProvider.java:101)
at
org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:940)
at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1003)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 3 threads leaked from SUITE
scope at org.apache.solr.cloud.CollectionsAPIDistributedZkTest:
1) Thread[id=6786, name=zkCallback-897-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=6765,
name=TEST-CollectionsAPIDistributedZkTest.testDistribSearch-seed#[9D82B774612A0B3A]-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=6764,
name=TEST-CollectionsAPIDistributedZkTest.testDistribSearch-seed#[9D82B774612A0B3A]-SendThread(127.0.0.1:53115),
state=TIMED_WAITING, group=TGRP-CollectionsAPIDistributedZkTest]
at java.lang.Thread.sleep(Native Method)
at
org.apache.zookeeper.client.StaticHostProvider.next(StaticHostProvider.java:101)
at
org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:940)
at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1003)
at __randomizedtesting.SeedInfo.seed([9D82B774612A0B3A]: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=6786, name=zkCallback-897-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=6764,
name=TEST-CollectionsAPIDistributedZkTest.testDistribSearch-seed#[9D82B774612A0B3A]-SendThread(127.0.0.1:53115),
state=TIMED_WAITING, group=TGRP-CollectionsAPIDistributedZkTest] at
java.lang.Thread.sleep(Native Method) at
org.apache.zookeeper.client.StaticHostProvider.next(StaticHostProvider.java:101)
at
org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:940)
at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1003)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
1) Thread[id=6786, name=zkCallback-897-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=6764,
name=TEST-CollectionsAPIDistributedZkTest.testDistribSearch-seed#[9D82B774612A0B3A]-SendThread(127.0.0.1:53115),
state=TIMED_WAITING, group=TGRP-CollectionsAPIDistributedZkTest]
at java.lang.Thread.sleep(Native Method)
at
org.apache.zookeeper.client.StaticHostProvider.next(StaticHostProvider.java:101)
at
org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:940)
at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1003)
at __randomizedtesting.SeedInfo.seed([9D82B774612A0B3A]:0)
Build Log:
[...truncated 11241 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\init-core-data-001
[junit4] 2> 2696463 T6596 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(true) and clientAuth (true)
[junit4] 2> 2696463 T6596
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system
property: /
[junit4] 2> 2696468 T6596 oas.SolrTestCaseJ4.setUp ###Starting
testDistribSearch
[junit4] 2> 2696469 T6596 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2696470 T6597 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 2696580 T6596 oasc.ZkTestServer.run start zk server on
port:53115
[junit4] 2> 2696580 T6596
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2696582 T6596 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2696588 T6603 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@733214bf
name:ZooKeeperConnection Watcher:127.0.0.1:53115 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2696589 T6596 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2696589 T6596 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2696589 T6596 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 2696594 T6596
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2696597 T6596 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2696601 T6605 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3f502b7 name:ZooKeeperConnection
Watcher:127.0.0.1:53115/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 2696602 T6596 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2696602 T6596 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2696602 T6596 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 2696606 T6596 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 2696609 T6596 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 2696612 T6596 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 2696616 T6596 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 2696616 T6596 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 2696622 T6596 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 2696622 T6596 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 2696626 T6596 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 2696626 T6596 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 2696629 T6596 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 2696629 T6596 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 2696633 T6596 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 2696633 T6596 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 2696637 T6596 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 2696637 T6596 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 2696642 T6596 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 2696642 T6596 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 2696646 T6596 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 2696646 T6596 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 2696650 T6596 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 2696650 T6596 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 2696654 T6596 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 2696654 T6596 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 2696659 T6596 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 2696660 T6596 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> 2696664 T6596
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2696664 T6598 oazs.NIOServerCnxn.doIO WARN caught end of
stream exception EndOfStreamException: Unable to read additional data from
client sessionid 0x148b12fb7be0001, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 2696666 T6596 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2696668 T6607 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3daef761
name:ZooKeeperConnection Watcher:127.0.0.1:53115/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2696668 T6596 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2696668 T6596 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> Using old style solr.xml
[junit4] 2> 2698120 T6596 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2698129 T6596 oejus.SslContextFactory.doStart Enabled
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3,
TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 2698131 T6596 oejs.AbstractConnector.doStart Started
[email protected]:53125
[junit4] 2> 2698135 T6596 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 2698135 T6596 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 2698135 T6596 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-002
[junit4] 2> 2698136 T6596 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-002\'
[junit4] 2> 2698168 T6596 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-002\solr.xml
[junit4] 2> 2698237 T6596 oasc.CoreContainer.<init> New CoreContainer
1538481192
[junit4] 2> 2698238 T6596 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-002\]
[junit4] 2> 2698239 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 120000
[junit4] 2> 2698239 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to: null
[junit4] 2> 2698239 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 2698240 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 2698240 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 2698240 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 2698240 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 2698242 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 2698242 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 2698245 T6596 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 2698248 T6596 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2698248 T6596 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2698248 T6596 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 2698249 T6596 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:53115/solr
[junit4] 2> 2698249 T6596 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 2698249 T6596
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2698251 T6596 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2698253 T6618 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3c784b66
name:ZooKeeperConnection Watcher:127.0.0.1:53115 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2698254 T6596 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2698254 T6596 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2698259 T6596 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2698260 T6620 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@13997f0 name:ZooKeeperConnection
Watcher:127.0.0.1:53115/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 2698261 T6596 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2698263 T6596 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 2698267 T6596 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 2698271 T6596 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 2698275 T6596 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 2698279 T6596 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 2698284 T6596 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 2698286 T6596 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53125_
[junit4] 2> 2698287 T6596 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:53125_
[junit4] 2> 2698291 T6596 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 2698295 T6596 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 2698299 T6596 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 2698302 T6596 oasc.OverseerElectionContext.runLeaderProcess I
am going to be the leader 127.0.0.1:53125_
[junit4] 2> 2698302 T6596 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 2698306 T6596 oasc.Overseer.start Overseer
(id=92518610865356804-127.0.0.1:53125_-n_0000000000) starting
[junit4] 2> 2698309 T6596 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 2698322 T6596 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 2698324 T6622 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 2698325 T6596 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 2698331 T6596 oascc.SolrZkClient.makePath makePath:
/aliases.json
[junit4] 2> 2698333 T6596
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2698339 T6621 oasc.Overseer$ClusterStateUpdater.run Starting
to work on the main queue
[junit4] 2> 2698342 T6596 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2698342 T6596 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 2698347 T6596
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2698350 T6596 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2698352 T6626 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1b430f12
name:ZooKeeperConnection Watcher:127.0.0.1:53115/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2698352 T6596 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2698352 T6596 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2698354 T6596
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2698360 T6596 oasc.ChaosMonkey.monkeyLog monkey: init - expire
sessions:false cause connection loss:false
[junit4] 2> 2699984 T6596 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 2699986 T6596 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2699999 T6596 oejus.SslContextFactory.doStart Enabled
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3,
TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 2700002 T6596 oejs.AbstractConnector.doStart Started
[email protected]:53137
[junit4] 2> 2700009 T6596 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 2700009 T6596 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 2700010 T6596 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-003
[junit4] 2> 2700010 T6596 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-003\'
[junit4] 2> 2700062 T6596 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-003\solr.xml
[junit4] 2> 2700154 T6596 oasc.CoreContainer.<init> New CoreContainer
1097772730
[junit4] 2> 2700154 T6596 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-003\]
[junit4] 2> 2700156 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 120000
[junit4] 2> 2700157 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to: null
[junit4] 2> 2700157 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 2700157 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 2700158 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 2700158 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 2700159 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 2700159 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 2700160 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 2700164 T6596 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 2700169 T6596 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2700170 T6596 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2700170 T6596 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 2700171 T6596 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:53115/solr
[junit4] 2> 2700171 T6596 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 2700171 T6596
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2700174 T6596 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2700176 T6637 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5591e774
name:ZooKeeperConnection Watcher:127.0.0.1:53115 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2700177 T6596 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2700178 T6596 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2700181 T6598 oazs.NIOServerCnxn.doIO WARN caught end of
stream exception EndOfStreamException: Unable to read additional data from
client sessionid 0x148b12fb7be0006, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 2700183 T6596 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2700186 T6639 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@6cbb8e3 name:ZooKeeperConnection
Watcher:127.0.0.1:53115/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 2700186 T6596 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2700197 T6596
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2701188 T6596 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53137_
[junit4] 2> 2701189 T6596 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:53137_
[junit4] 2> 2701198 T6596 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 2701205 T6596 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2701205 T6596 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 2702736 T6596 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 2702737 T6596 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2702749 T6596 oejus.SslContextFactory.doStart Enabled
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3,
TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 2702751 T6596 oejs.AbstractConnector.doStart Started
[email protected]:53146
[junit4] 2> 2702756 T6596 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 2702756 T6596 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 2702756 T6596 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-004
[junit4] 2> 2702759 T6596 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-004\'
[junit4] 2> 2702806 T6596 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-004\solr.xml
[junit4] 2> 2702893 T6596 oasc.CoreContainer.<init> New CoreContainer
2137669153
[junit4] 2> 2702893 T6596 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-004\]
[junit4] 2> 2702894 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 120000
[junit4] 2> 2702894 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to: null
[junit4] 2> 2702895 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 2702895 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 2702895 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 2702896 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 2702896 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 2702896 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 2702896 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 2702900 T6596 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 2702903 T6596 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2702903 T6596 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2702903 T6596 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 2702903 T6596 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:53115/solr
[junit4] 2> 2702904 T6596 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 2702904 T6596
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2702905 T6596 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2702907 T6654 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1290121b
name:ZooKeeperConnection Watcher:127.0.0.1:53115 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2702908 T6596 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2702909 T6596 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2702916 T6596 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2702917 T6656 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@d43982b name:ZooKeeperConnection
Watcher:127.0.0.1:53115/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 2702918 T6596 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2702935 T6596
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2703930 T6596 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53146_
[junit4] 2> 2703931 T6596 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:53146_
[junit4] 2> 2703942 T6596 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 2703948 T6596 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2703948 T6596 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 2705542 T6596 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 3
[junit4] 2> 2705544 T6596 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2705555 T6596 oejus.SslContextFactory.doStart Enabled
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3,
TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 2705558 T6596 oejs.AbstractConnector.doStart Started
[email protected]:53155
[junit4] 2> 2705565 T6596 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 2705566 T6596 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 2705566 T6596 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-005
[junit4] 2> 2705566 T6596 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-005\'
[junit4] 2> 2705616 T6596 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-005\solr.xml
[junit4] 2> 2705704 T6596 oasc.CoreContainer.<init> New CoreContainer
568619558
[junit4] 2> 2705704 T6596 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-005\]
[junit4] 2> 2705706 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 120000
[junit4] 2> 2705706 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to: null
[junit4] 2> 2705707 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 2705707 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 2705707 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 2705708 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 2705708 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 2705709 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 2705709 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 2705714 T6596 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 2705721 T6596 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2705721 T6596 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2705721 T6596 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 2705722 T6596 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:53115/solr
[junit4] 2> 2705722 T6596 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 2705722 T6596
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2705724 T6596 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2705726 T6669 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@6efa7fb name:ZooKeeperConnection
Watcher:127.0.0.1:53115 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 2705728 T6596 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2705728 T6596 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2705735 T6596 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2705739 T6671 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@24fd23f5
name:ZooKeeperConnection Watcher:127.0.0.1:53115/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2705739 T6596 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2705751 T6596
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2706712 T6596 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53155_
[junit4] 2> 2706713 T6596 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:53155_
[junit4] 2> 2706723 T6596 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 2706734 T6596 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2706734 T6596 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 2708344 T6596 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 4
[junit4] 2> 2708345 T6596 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2708357 T6596 oejus.SslContextFactory.doStart Enabled
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3,
TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 2708360 T6596 oejs.AbstractConnector.doStart Started
[email protected]:53164
[junit4] 2> 2708365 T6596 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 2708366 T6596 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 2708366 T6596 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-006
[junit4] 2> 2708367 T6596 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-006\'
[junit4] 2> 2708414 T6596 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-006\solr.xml
[junit4] 2> 2708472 T6596 oasc.CoreContainer.<init> New CoreContainer
404108445
[junit4] 2> 2708472 T6596 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-006\]
[junit4] 2> 2708474 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 120000
[junit4] 2> 2708475 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to: null
[junit4] 2> 2708475 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 2708475 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 2708475 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 2708475 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 2708475 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 2708475 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 2708475 T6596 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 2708478 T6596 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 2708481 T6596 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2708481 T6596 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2708481 T6596 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 2708481 T6596 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:53115/solr
[junit4] 2> 2708481 T6596 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 2708481 T6596
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2708485 T6596 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2708485 T6684 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@6dc519b5
name:ZooKeeperConnection Watcher:127.0.0.1:53115 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2708486 T6596 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2708486 T6596 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2708491 T6596 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2708493 T6686 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1a3d7591
name:ZooKeeperConnection Watcher:127.0.0.1:53115/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2708493 T6596 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2708504 T6596
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2709395 T6596 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53164_
[junit4] 2> 2709396 T6596 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:53164_
[junit4] 2> 2709407 T6596 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 2709414 T6596 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2709415 T6596 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 2709461 T6633 oasha.CollectionsHandler.handleCreateAction
Creating Collection :
wt=javabin&version=2&numShards=2&collection.configName=conf1&replicationFactor=2&router.field=myOwnField&name=solrj_collection&action=CREATE
[junit4] 2> 2709463 T6642 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/collection-queue-work state:
SyncConnected type NodeChildrenChanged
[junit4] 2> 2709465 T6622 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> 2709467 T6689 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> 2709472 T6689 oasc.OverseerCollectionProcessor.createConfNode
creating collections conf node /collections/solrj_collection
[junit4] 2> 2709473 T6689 oascc.SolrZkClient.makePath makePath:
/collections/solrj_collection
[junit4] 2> 2709480 T6642 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 2709489 T6621
oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection:
solrj_collection
[junit4] 2> 2709489 T6621
oasc.Overseer$ClusterStateUpdater.createCollection Create collection
solrj_collection with shards [shard1, shard2]
[junit4] 2> 2709489 T6621
oasc.Overseer$ClusterStateUpdater.createCollection state version
solrj_collection 1
[junit4] 2> 2709495 T6642 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> 2709496 T6687 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> 2709496 T6672 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> 2709497 T6640 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> 2709497 T6657 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> 2709497 T6641 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> 2709569 T6689
oasc.OverseerCollectionProcessor.createCollection Creating SolrCores for new
collection solrj_collection, shardNames [shard1, shard2] , replicationFactor : 2
[junit4] 2> 2709569 T6689
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard1_replica1 as part of slice shard1 of collection
solrj_collection on 127.0.0.1:53164_
[junit4] 2> 2709572 T6689
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard1_replica2 as part of slice shard1 of collection
solrj_collection on 127.0.0.1:53137_
[junit4] 2> 2709576 T6689
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard2_replica1 as part of slice shard2 of collection
solrj_collection on 127.0.0.1:53125_
[junit4] 2> 2709587 T6689
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard2_replica2 as part of slice shard2 of collection
solrj_collection on 127.0.0.1:53146_
[junit4] 2> 2709627 T6681 oasha.CoreAdminHandler.handleCreateAction core
create command
wt=javabin&version=2&shard=shard1&qt=/admin/cores&numShards=2&collection.configName=conf1&name=solrj_collection_shard1_replica1&collection=solrj_collection&action=CREATE
[junit4] 2> 2709652 T6632 oasha.CoreAdminHandler.handleCreateAction core
create command
wt=javabin&version=2&shard=shard1&qt=/admin/cores&numShards=2&collection.configName=conf1&name=solrj_collection_shard1_replica2&collection=solrj_collection&action=CREATE
[junit4] 2> 2709664 T6616 oasha.CoreAdminHandler.handleCreateAction core
create command
wt=javabin&version=2&shard=shard2&qt=/admin/cores&numShards=2&collection.configName=conf1&name=solrj_collection_shard2_replica1&collection=solrj_collection&action=CREATE
[junit4] 2> 2709670 T6681 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica1 state=down collection=solrj_collection
[junit4] 2> 2709672 T6681 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 2709674 T6642 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 2709674 T6632 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica2 state=down collection=solrj_collection
[junit4] 2> 2709677 T6632 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 2709680 T6616 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica1 state=down collection=solrj_collection
[junit4] 2> 2709685 T6616 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 2709693 T6621 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "roles":null,
[junit4] 2> "core":"solrj_collection_shard1_replica1",
[junit4] 2> "base_url":"https://127.0.0.1:53164";,
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "node_name":"127.0.0.1:53164_",
[junit4] 2> "shard":"shard1",
[junit4] 2> "numShards":"2",
[junit4] 2> "collection":"solrj_collection"}
[junit4] 2> 2709702 T6648 oasha.CoreAdminHandler.handleCreateAction core
create command
wt=javabin&version=2&shard=shard2&qt=/admin/cores&numShards=2&collection.configName=conf1&name=solrj_collection_shard2_replica2&collection=solrj_collection&action=CREATE
[junit4] 2> 2709702 T6621 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "roles":null,
[junit4] 2> "core":"solrj_collection_shard1_replica2",
[junit4] 2> "base_url":"https://127.0.0.1:53137";,
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "node_name":"127.0.0.1:53137_",
[junit4] 2> "shard":"shard1",
[junit4] 2> "numShards":"2",
[junit4] 2> "collection":"solrj_collection"}
[junit4] 2> 2709708 T6642 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 2709709 T6648 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica2 state=down collection=solrj_collection
[junit4] 2> 2709709 T6648 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 2709710 T6621 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "roles":null,
[junit4] 2> "core":"solrj_collection_shard2_replica1",
[junit4] 2> "base_url":"https://127.0.0.1:53125";,
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "node_name":"127.0.0.1:53125_",
[junit4] 2> "shard":"shard2",
[junit4] 2> "numShards":"2",
[junit4] 2> "collection":"solrj_collection"}
[junit4] 2> 2709715 T6621 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "roles":null,
[junit4] 2> "core":"solrj_collection_shard2_replica2",
[junit4] 2> "base_url":"https://127.0.0.1:53146";,
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "node_name":"127.0.0.1:53146_",
[junit4] 2> "shard":"shard2",
[junit4] 2> "numShards":"2",
[junit4] 2> "collection":"solrj_collection"}
[junit4] 2> 2709719 T6642 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 2709721 T6687 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> 2709721 T6642 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> 2709721 T6672 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> 2709722 T6641 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> 2709723 T6640 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> 2709723 T6657 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> 2710558 T6681 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard1_replica1
[junit4] 2> 2710558 T6681 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 2710559 T6681 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 2710560 T6681 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 2710561 T6681 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 2710562 T6681 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-006\solrj_collection_shard1_replica1\'
[junit4] 2> 2710563 T6632 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard1_replica2
[junit4] 2> 2710563 T6632 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 2710565 T6632 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 2710566 T6632 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 2710569 T6632 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 2710571 T6632 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-003\solrj_collection_shard1_replica2\'
[junit4] 2> 2710571 T6616 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard2_replica1
[junit4] 2> 2710577 T6616 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 2710586 T6616 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 2710587 T6616 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 2710597 T6648 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard2_replica2
[junit4] 2> 2710597 T6648 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 2710600 T6616 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 2710600 T6616 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-002\solrj_collection_shard2_replica1\'
[junit4] 2> 2710602 T6648 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 2710603 T6648 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 2710614 T6648 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 2710615 T6648 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-004\solrj_collection_shard2_replica2\'
[junit4] 2> 2710656 T6681 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 2710716 T6681 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 2710723 T6616 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 2710734 T6681 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 2710744 T6632 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 2710749 T6681 oass.IndexSchema.readSchema
[solrj_collection_shard1_replica1] Schema name=test
[junit4] 2> 2710805 T6616 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 2710880 T6616 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 2710893 T6616 oass.IndexSchema.readSchema
[solrj_collection_shard2_replica1] Schema name=test
[junit4] 2> 2710950 T6648 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 2711015 T6632 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 2711093 T6632 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 2711101 T6632 oass.IndexSchema.readSchema
[solrj_collection_shard1_replica2] Schema name=test
[junit4] 2> 2711405 T6648 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 2711430 T6681 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 2711449 T6681 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 2711452 T6681 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2711514 T6616 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 2711521 T6616 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 2711525 T6616 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2711532 T6648 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 2711545 T6648 oass.IndexSchema.readSchema
[solrj_collection_shard2_replica2] Schema name=test
[junit4] 2> 2711714 T6632 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 2711721 T6632 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 2711724 T6632 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2711761 T6616 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2711767 T6681 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2711769 T6616 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2711775 T6681 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2711781 T6616 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 2711788 T6681 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 2711789 T6616
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 2711791 T6616
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 2711791 T6616 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 2711793 T6681
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 2711793 T6681
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 2711793 T6681 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 2711797 T6616
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 2711797 T6616
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 2711798 T6616 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard2_replica1' using configuration from collection
solrj_collection
[junit4] 2> 2711798 T6616 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2711798 T6616 oasc.SolrCore.<init>
[solrj_collection_shard2_replica1] Opening new SolrCore at
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-002\solrj_collection_shard2_replica1\,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-002\solrj_collection_shard2_replica1\data\
[junit4] 2> 2711798 T6616 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@12ce2dec
[junit4] 2> 2711800 T6616 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-002\solrj_collection_shard2_replica1\data\
[junit4] 2> 2711800 T6616 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-002\solrj_collection_shard2_replica1\data\index/
[junit4] 2> 2711800 T6616 oasc.SolrCore.initIndex WARN
[solrj_collection_shard2_replica1] Solr index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-002\solrj_collection_shard2_replica1\data\index'
doesn't exist. Creating new index...
[junit4] 2> 2711801 T6616 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-002\solrj_collection_shard2_replica1\data\index
[junit4] 2> 2711802 T6616 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=26,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=true, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.48865719148503317]
[junit4] 2> 2711803 T6616 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-37425423)),segFN=segments_1,generation=1}
[junit4] 2> 2711803 T6616 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 2711807 T6616 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 2711807 T6616 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 2711808 T6616 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 2711808 T6616 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 2711808 T6616 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 2711808 T6616 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 2711809 T6616 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 2711809 T6616 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 2711809 T6616 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 2711810 T6616 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2711810 T6616 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2711811 T6616 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2711811 T6616 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 2711812 T6616 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 2711812 T6616 oasc.RequestHandlers.initHandlersFromConfig
adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 2711812 T6616 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 2711813 T6616 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 2711813 T6616 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 2711814 T6616 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 2711814 T6616 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 2711797 T6681
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 2711818 T6681
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 2711818 T6681 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard1_replica1' using configuration from collection
solrj_collection
[junit4] 2> 2711818 T6681 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2711818 T6681 oasc.SolrCore.<init>
[solrj_collection_shard1_replica1] Opening new SolrCore at
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-006\solrj_collection_shard1_replica1\,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-006\solrj_collection_shard1_replica1\data\
[junit4] 2> 2711818 T6681 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@12ce2dec
[junit4] 2> 2711820 T6681 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-006\solrj_collection_shard1_replica1\data\
[junit4] 2> 2711820 T6681 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-006\solrj_collection_shard1_replica1\data\index/
[junit4] 2> 2711820 T6681 oasc.SolrCore.initIndex WARN
[solrj_collection_shard1_replica1] Solr index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-006\solrj_collection_shard1_replica1\data\index'
doesn't exist. Creating new index...
[junit4] 2> 2711821 T6681 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-9D82B774612A0B3A-001\tempDir-006\solrj_collection_shard1_replica1\data\index
[junit4] 2> 2711821 T6681 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=26,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=true, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.48865719148503317]
[junit4] 2> 2711822 T6681 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-35ada13d)),segFN=segments_1,generation=1}
[junit4] 2> 2711822 T6681 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 2711825 T6681 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 2711826 T6681 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 2711826 T6681 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 2711826 T6681 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 2711827 T6681 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 2711827 T6681 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 2711827 T6681 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 2711828 T6681 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 2711828 T6681 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 2711829 T6681 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2711830 T6681 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2711830 T6681 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2711830 T6681 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 2711830 T6681 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 2711830 T6681 oasc.RequestHandlers.initHandlersFromConfig
adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 2711830 T6681 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 2711831 T6681 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 2711832 T6681 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 2711832 T6681 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 2711833 T6681 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 2711836 T6632 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2711839 T6681 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2711842 T6681 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2711842 T6681 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2711845 T6681 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2711848 T6681 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 2711849 T6681 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 2711849 T6681 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1392308490,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 2711850 T6681 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-35ada13d)),segFN=segments_1,generation=1}
[junit4] 2> 2711850 T6681 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 2711851 T6681 oass.SolrIndexSearcher.<init> Opening
Searcher@14f7c2e[solrj_collection_shard1_replica1] main
[junit4] 2> 2711851 T6681 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 2711856 T6616 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2711858 T6616 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2711860 T6616 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2711862 T6616 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2711867 T6616 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 2711868 T6616 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 2711871 T6632 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2711873 T6616 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1392308490,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 2711873 T6681 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 2711874 T6681 oasr.ManagedResourceStorage.newStorageIO Setting
up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 2711876 T6616 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-37425423)),segFN=segments_1,generation=1}
[junit4] 2> 2711877 T6616 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 2711877 T6616 oass.SolrIndexSearcher.<init> Opening
Searcher@6c41079f[solrj_collection_shard2_replica1] main
[junit4] 2> 2711877 T6616 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 2711878 T6681
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 2711878 T6681 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 2711879 T6681 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2711881 T6681
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 2711881 T6681 oasr.ManagedResourceStorage.load Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2711896 T6632 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 2711898 T6681 oascc.SolrZkClient.makePath makePath:
/configs/conf1/_rest_managed.json
[junit4] 2> 2711900 T6616 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 2711900 T6616 oasr.ManagedResourceStorage.newStorageIO Setting
up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 2711914 T6632
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 2711914 T6632
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 2711915 T6632 oass.OpenExchangeRatesO
[...truncated too long message...]
CursorMarkWithoutUniqueKey, DeleteLastCustomShardedReplicaTest,
SolrCoreCheckLockOnStartupTest, HdfsWriteToMultipleCollectionsTest,
TestSurroundQueryParser, TestSchemaNameResource,
TestSerializedLuceneMatchVersion, TestSystemIdResolver, TestCollectionAPI,
ZkSolrClientTest, TestFaceting, TestSuggestSpellingConverter,
AnalyticsMergeStrategyTest, BJQParserTest, FileBasedSpellCheckerTest,
ZkControllerTest, TestNRTOpen, TestIntervalFaceting,
DistributedQueryElevationComponentTest, SharedFSAutoReplicaFailoverUtilsTest,
RollingRestartTest, TestSolrXml, TestInitParams, TestSolrDeletionPolicy1,
TestSchemaSimilarityResource, TestRecoveryHdfs, DateMathParserTest,
OutputWriterTest, WordBreakSolrSpellCheckerTest, TestPerFieldSimilarity,
DocValuesTest, ConvertedLegacyTest, TestChildDocTransformer,
TestExceedMaxTermLength, TestDocumentBuilder, TestIndexSearcher,
SpellCheckCollatorTest, TestComponentsName, AddBlockUpdateTest,
CoreAdminCreateDiscoverTest, CoreMergeIndexesAdminHandlerTest,
TestCollapseQParserPlugin, SolrInfoMBeanTest, MultiThreadedOCPTest,
SolrCoreTest, BlockCacheTest, AlternateDirectoryTest, TestZkChroot,
DistributedSuggestComponentTest, DeleteReplicaTest, TestCloudManagedSchema,
SyncSliceTest, SliceStateTest, HdfsDirectoryTest,
CurrencyFieldOpenExchangeTest, DocumentBuilderTest, BasicDistributedZkTest,
TimeZoneUtilsTest, TermsComponentTest, TestDistributedMissingSort,
CopyFieldTest, JsonLoaderTest, TestReplicationHandler,
BinaryUpdateRequestHandlerTest, TestCustomSort, UpdateParamsTest,
CacheHeaderTest, SpellPossibilityIteratorTest, BasicZkTest,
ResponseLogComponentTest, DistributedIntervalFacetingTest,
TestDistributedGrouping, UpdateRequestProcessorFactoryTest, ClusterStateTest,
TestAnalyzedSuggestions, SuggestComponentTest, TestImplicitCoreProperties,
CircularListTest, TestPartialUpdateDeduplication, StatsComponentTest,
TestQuerySenderListener, TestDynamicFieldResource, ClusterStateUpdateTest,
CurrencyFieldXmlFileTest, TestSolrXmlPersistor, ShardSplitTest,
SuggesterWFSTTest, DateFieldTest, StatelessScriptUpdateProcessorFactoryTest,
CoreAdminRequestStatusTest, SimpleFacetsTest, TestRequestStatusCollectionAPI,
TestStressReorder, XmlUpdateRequestHandlerTest,
TestSolrQueryParserDefaultOperatorResource, TestNoOpRegenerator,
DateRangeFieldTest, EchoParamsTest, TestDocBasedVersionConstraints,
MoreLikeThisHandlerTest, IndexSchemaTest, DistributedDebugComponentTest,
BlockDirectoryTest, ReturnFieldsTest, TestConfig, HighlighterConfigTest,
TestLRUCache, SynonymTokenizerTest, HighlighterTest, TestTolerantSearch,
AliasIntegrationTest, TestRandomMergePolicy, CursorPagingTest,
CustomCollectionTest, HdfsUnloadDistributedZkTest, TestOrdValues,
TestRemoteStreaming, HdfsLockFactoryTest, StressHdfsTest,
CachingDirectoryFactoryTest, AnalysisErrorHandlingTest,
ExternalFileFieldSortTest, TestBM25SimilarityFactory,
SpellingQueryConverterTest, TriLevelCompositeIdRoutingTest,
DistanceFunctionTest, PrimitiveFieldTypeTest, SOLR749Test,
TestSolrQueryParserResource, AsyncMigrateRouteKeyTest, RemoteQueryErrorTest,
CoreContainerCoreInitFailuresTest, TestSimpleQParserPlugin, NumericFieldsTest,
FieldAnalysisRequestHandlerTest, BasicDistributedZk2Test,
RegexBoostProcessorTest, SpatialFilterTest, TestDefaultSearchFieldResource,
TestIndexingPerformance, CollectionsAPIDistributedZkTest]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=CollectionsAPIDistributedZkTest -Dtests.seed=9D82B774612A0B3A
-Dtests.slow=true -Dtests.locale=ar -Dtests.timezone=America/Cayenne
-Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s | CollectionsAPIDistributedZkTest (suite) <<<
[junit4] > Throwable #1: java.lang.AssertionError: ERROR: SolrZkClient
opens=17 closes=16
[junit4] > at
__randomizedtesting.SeedInfo.seed([9D82B774612A0B3A]:0)
[junit4] > at
org.apache.solr.SolrTestCaseJ4.endTrackingZkClients(SolrTestCaseJ4.java:455)
[junit4] > at
org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:188)
[junit4] > at java.lang.Thread.run(Thread.java:745)Throwable #2:
com.carrotsearch.randomizedtesting.ThreadLeakError: 3 threads leaked from SUITE
scope at org.apache.solr.cloud.CollectionsAPIDistributedZkTest:
[junit4] > 1) Thread[id=6786, name=zkCallback-897-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=6765,
name=TEST-CollectionsAPIDistributedZkTest.testDistribSearch-seed#[9D82B774612A0B3A]-EventThread,
state=WAITING, group=TGRP-CollectionsAPIDistributedZkTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
[junit4] > at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:494)
[junit4] > 3) Thread[id=6764,
name=TEST-CollectionsAPIDistributedZkTest.testDistribSearch-seed#[9D82B774612A0B3A]-SendThread(127.0.0.1:53115),
state=TIMED_WAITING, group=TGRP-CollectionsAPIDistributedZkTest]
[junit4] > at java.lang.Thread.sleep(Native Method)
[junit4] > at
org.apache.zookeeper.client.StaticHostProvider.next(StaticHostProvider.java:101)
[junit4] > at
org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:940)
[junit4] > at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1003)
[junit4] > at
__randomizedtesting.SeedInfo.seed([9D82B774612A0B3A]:0)Throwable #3:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=6786, name=zkCallback-897-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=6764,
name=TEST-CollectionsAPIDistributedZkTest.testDistribSearch-seed#[9D82B774612A0B3A]-SendThread(127.0.0.1:53115),
state=TIMED_WAITING, group=TGRP-CollectionsAPIDistributedZkTest]
[junit4] > at java.lang.Thread.sleep(Native Method)
[junit4] > at
org.apache.zookeeper.client.StaticHostProvider.next(StaticHostProvider.java:101)
[junit4] > at
org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:940)
[junit4] > at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1003)
[junit4] > at
__randomizedtesting.SeedInfo.seed([9D82B774612A0B3A]:0)
[junit4] Completed in 80.92s, 1 test, 1 failure, 3 errors <<< FAILURES!
[...truncated 857 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:524: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:472: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:61: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\extra-targets.xml:39:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build.xml:189: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\common-build.xml:496:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1360:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:962:
There were test failures: 431 suites, 1778 tests, 3 suite-level errors, 1
error, 1109 ignored (17 assumptions)
Total time: 90 minutes 50 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.7.0_67
-XX:+UseCompressedOops -XX:+UseConcMarkSweepGC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
