Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.x/626/
3 tests failed.
REGRESSION:
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testDistribSearch
Error Message:
Error CREATEing SolrCore 'halfcollection_shard1_replica1': Unable to create
core [halfcollection_shard1_replica1] Caused by: null
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Error
CREATEing SolrCore 'halfcollection_shard1_replica1': Unable to create core
[halfcollection_shard1_replica1] Caused by: null
at
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:550)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:210)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:206)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testErrorHandling(CollectionsAPIDistributedZkTest.java:583)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.doTest(CollectionsAPIDistributedZkTest.java:205)
at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java: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: org.apache.solr.cloud.DeleteReplicaTest.testDistribSearch
Error Message:
No live SolrServers available to handle this
request:[https://127.0.0.1:40357/_/xl, https://127.0.0.1:40424/_/xl,
https://127.0.0.1:40441/_/xl, https://127.0.0.1:40415/_/xl,
https://127.0.0.1:40394/_/xl]
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available
to handle this request:[https://127.0.0.1:40357/_/xl,
https://127.0.0.1:40424/_/xl, https://127.0.0.1:40441/_/xl,
https://127.0.0.1:40415/_/xl, https://127.0.0.1:40394/_/xl]
at
__randomizedtesting.SeedInfo.seed([9899253F643C486:886F1C4B811CA4BA]:0)
at
org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:322)
at
org.apache.solr.client.solrj.impl.CloudSolrServer.sendRequest(CloudSolrServer.java:874)
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.DeleteReplicaTest.removeAndWaitForReplicaGone(DeleteReplicaTest.java:165)
at
org.apache.solr.cloud.DeleteReplicaTest.deleteLiveReplicaTest(DeleteReplicaTest.java:137)
at
org.apache.solr.cloud.DeleteReplicaTest.doTest(DeleteReplicaTest.java:88)
at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java: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)
Caused by:
org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Could not
remove replica : delLiveColl/shard2/core_node4
at
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:550)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:210)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:206)
at
org.apache.solr.client.solrj.impl.LBHttpSolrServer.doRequest(LBHttpSolrServer.java:343)
at
org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:304)
... 47 more
FAILED: org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.testDistribSearch
Error Message:
Error executing query
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Error executing query
at
__randomizedtesting.SeedInfo.seed([9899253F643C486:886F1C4B811CA4BA]:0)
at
org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:100)
at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:301)
at
org.apache.solr.cloud.CloudInspectUtil.compareResults(CloudInspectUtil.java:223)
at
org.apache.solr.cloud.CloudInspectUtil.compareResults(CloudInspectUtil.java:165)
at
org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.testIndexingBatchPerRequestWithHttpSolrServer(FullSolrCloudDistribCmdsTest.java:414)
at
org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.doTest(FullSolrCloudDistribCmdsTest.java:144)
at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java: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)
Caused by: org.apache.http.ParseException: Invalid content type:
at org.apache.http.entity.ContentType.parse(ContentType.java:233)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:496)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:210)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:206)
at
org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:91)
... 46 more
Build Log:
[...truncated 11438 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/init-core-data-001
[junit4] 2> 120594 T385 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(true) and clientAuth (false)
[junit4] 2> 120594 T385 oas.BaseDistributedSearchTestCase.initHostContext
Setting hostContext system property: /c_bf/
[junit4] 2> 120599 T385 oas.SolrTestCaseJ4.setUp ###Starting
testDistribSearch
[junit4] 2> 120600 T385 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 120601 T386 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 120700 T385 oasc.ZkTestServer.run start zk server on port:18712
[junit4] 2> 120701 T385
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 120702 T385 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 120705 T392 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@4f8e4d1 name:ZooKeeperConnection
Watcher:127.0.0.1:18712 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 120706 T385 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 120706 T385 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 120706 T385 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 120709 T385
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 120710 T385 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 120712 T394 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1ef38e7a
name:ZooKeeperConnection Watcher:127.0.0.1:18712/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 120712 T385 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 120712 T385 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 120717 T385 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 120722 T385 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 120726 T385 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 120729 T385 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 120732 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 120733 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 120739 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 120740 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 120744 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 120744 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 120748 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 120749 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 120753 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 120753 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 120757 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 120757 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 120761 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 120762 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 120765 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 120766 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 120770 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 120770 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 120774 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 120774 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 120778 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 120778 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> 120793 T385
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 120794 T385 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 120796 T396 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@2b2012c5
name:ZooKeeperConnection Watcher:127.0.0.1:18712/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 120796 T385 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 120797 T385 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> Using old style solr.xml
[junit4] 2> 120800 T385
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 120801 T385 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 120802 T398 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@2f8c6a5 name:ZooKeeperConnection
Watcher:127.0.0.1:18712 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 120802 T385 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 120803 T385 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 120803 T385 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 120820 T385
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 120821 T385 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 120822 T400 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@74aead4b
name:ZooKeeperConnection Watcher:127.0.0.1:18712/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 120822 T385 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 120823 T385 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 120825 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf2/solrconfig.xml
[junit4] 2> 120825 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf2/solrconfig.xml
[junit4] 2> 120829 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf2/schema.xml
[junit4] 2> 120830 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf2/schema.xml
[junit4] 2> 120833 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf2/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 120834 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf2/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 120837 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf2/stopwords.txt
[junit4] 2> 120838 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf2/stopwords.txt
[junit4] 2> 120841 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf2/protwords.txt
[junit4] 2> 120841 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf2/protwords.txt
[junit4] 2> 120845 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf2/currency.xml
[junit4] 2> 120845 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf2/currency.xml
[junit4] 2> 120848 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf2/open-exchange-rates.json
[junit4] 2> 120849 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf2/open-exchange-rates.json
[junit4] 2> 120852 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf2/mapping-ISOLatin1Accent.txt
[junit4] 2> 120853 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf2/mapping-ISOLatin1Accent.txt
[junit4] 2> 120856 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf2/old_synonyms.txt
[junit4] 2> 120856 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf2/old_synonyms.txt
[junit4] 2> 120859 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf2/synonyms.txt
[junit4] 2> 120860 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf2/synonyms.txt
[junit4] 2> 120863 T385 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/elevate.xml
to /configs/conf2/elevate.xml
[junit4] 2> 120864 T385 oascc.SolrZkClient.makePath makePath:
/configs/conf2/elevate.xml
[junit4] 2> 121989 T385 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 122056 T385 oejus.SslContextFactory.doStart Enabled Protocols
[SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1,
TLSv1.1, TLSv1.2]
[junit4] 2> 122059 T385 oejs.AbstractConnector.doStart Started
[email protected]:18718
[junit4] 2> 122062 T385 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 122063 T385 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 122063 T385 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-002
[junit4] 2> 122063 T385 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-002/'
[junit4] 2> 122093 T385 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-002/solr.xml
[junit4] 2> 122146 T385 oasc.CoreContainer.<init> New CoreContainer
1181974338
[junit4] 2> 122147 T385 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-002/]
[junit4] 2> 122148 T385 oashc.HttpShardHandlerFactory.getParameter Setting
socketTimeout to: 120000
[junit4] 2> 122148 T385 oashc.HttpShardHandlerFactory.getParameter Setting
urlScheme to: null
[junit4] 2> 122148 T385 oashc.HttpShardHandlerFactory.getParameter Setting
connTimeout to: 15000
[junit4] 2> 122148 T385 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnectionsPerHost to: 20
[junit4] 2> 122149 T385 oashc.HttpShardHandlerFactory.getParameter Setting
corePoolSize to: 0
[junit4] 2> 122149 T385 oashc.HttpShardHandlerFactory.getParameter Setting
maximumPoolSize to: 2147483647
[junit4] 2> 122149 T385 oashc.HttpShardHandlerFactory.getParameter Setting
maxThreadIdleTime to: 5
[junit4] 2> 122149 T385 oashc.HttpShardHandlerFactory.getParameter Setting
sizeOfQueue to: -1
[junit4] 2> 122150 T385 oashc.HttpShardHandlerFactory.getParameter Setting
fairnessPolicy to: false
[junit4] 2> 122153 T385 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 122155 T385 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 122155 T385 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 122156 T385 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 122156 T385 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:18712/solr
[junit4] 2> 122185 T385 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 122185 T385
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 122186 T385 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 122188 T411 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1edfa17c
name:ZooKeeperConnection Watcher:127.0.0.1:18712 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 122188 T385 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 122189 T385 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 122198 T385 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 122200 T413 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@4b270d33
name:ZooKeeperConnection Watcher:127.0.0.1:18712/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 122200 T385 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 122220 T385 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 122232 T385 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 122242 T385 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 122247 T385 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 122251 T385 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 122276 T385 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 122279 T385 oasc.ZkController.createEphemeralLiveNode Register
node as live in ZooKeeper:/live_nodes/127.0.0.1:18718_c_bf
[junit4] 2> 122287 T385 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:18718_c_bf
[junit4] 2> 122291 T385 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 122295 T385 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 122298 T385 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 122319 T385 oasc.OverseerElectionContext.runLeaderProcess I am
going to be the leader 127.0.0.1:18718_c_bf
[junit4] 2> 122320 T385 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 122322 T385 oasc.Overseer.start Overseer
(id=92481004425379846-127.0.0.1:18718_c_bf-n_0000000000) starting
[junit4] 2> 122351 T385 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 122388 T385 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 122409 T415 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 122410 T385 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 122413 T385 oascc.SolrZkClient.makePath makePath: /aliases.json
[junit4] 2> 122415 T385
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 122446 T414 oasc.Overseer$ClusterStateUpdater.run Starting to
work on the main queue
[junit4] 2> 122454 T385 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3
[junit4] 2> 122455 T385 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 122496 T385
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 122497 T385 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 122499 T419 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1c1469b3
name:ZooKeeperConnection Watcher:127.0.0.1:18712/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 122499 T385 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 122499 T385 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 122501 T385
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 122508 T385 oasc.ChaosMonkey.monkeyLog monkey: init - expire
sessions:false cause connection loss:false
[junit4] 2> 122508 T385 oasc.AbstractFullDistribZkTestBase.createJettys
Creating collection1 with stateFormat=2
[junit4] 2> 122509 T385
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 122510 T385 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 122511 T421 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@2bc6a19f
name:ZooKeeperConnection Watcher:127.0.0.1:18712/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 122511 T385 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 122511 T385 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 122530 T422 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 122546 T414 oasc.Overseer$ClusterStateUpdater.buildCollection
building a new collection: collection1
[junit4] 2> 122547 T414 oasc.Overseer$ClusterStateUpdater.createCollection
Create collection collection1 with shards [shard1, shard2]
[junit4] 2> 122573 T414 oasc.Overseer$ClusterStateUpdater.createCollection
state version collection1 2
[junit4] 2> 122582 T414 oasc.Overseer$ClusterStateUpdater.updateZkStates
going to create_collection /collections/collection1/state.json
[junit4] 2> 122584 T422 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 122584 T423 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 123770 T385 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 123778 T385 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 123787 T385 oejus.SslContextFactory.doStart Enabled Protocols
[SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1,
TLSv1.1, TLSv1.2]
[junit4] 2> 123790 T385 oejs.AbstractConnector.doStart Started
[email protected]:18723
[junit4] 2> 123794 T385 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 123794 T385 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 123795 T385 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-003
[junit4] 2> 123795 T385 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-003/'
[junit4] 2> 123840 T385 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-003/solr.xml
[junit4] 2> 123906 T385 oasc.CoreContainer.<init> New CoreContainer
1622824495
[junit4] 2> 123907 T385 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-003/]
[junit4] 2> 123907 T385 oashc.HttpShardHandlerFactory.getParameter Setting
socketTimeout to: 120000
[junit4] 2> 123908 T385 oashc.HttpShardHandlerFactory.getParameter Setting
urlScheme to: null
[junit4] 2> 123908 T385 oashc.HttpShardHandlerFactory.getParameter Setting
connTimeout to: 15000
[junit4] 2> 123908 T385 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnectionsPerHost to: 20
[junit4] 2> 123909 T385 oashc.HttpShardHandlerFactory.getParameter Setting
corePoolSize to: 0
[junit4] 2> 123909 T385 oashc.HttpShardHandlerFactory.getParameter Setting
maximumPoolSize to: 2147483647
[junit4] 2> 123909 T385 oashc.HttpShardHandlerFactory.getParameter Setting
maxThreadIdleTime to: 5
[junit4] 2> 123909 T385 oashc.HttpShardHandlerFactory.getParameter Setting
sizeOfQueue to: -1
[junit4] 2> 123910 T385 oashc.HttpShardHandlerFactory.getParameter Setting
fairnessPolicy to: false
[junit4] 2> 123912 T385 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 123914 T385 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 123914 T385 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 123915 T385 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 123915 T385 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:18712/solr
[junit4] 2> 123915 T385 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 123916 T385
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 123916 T385 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 123919 T434 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@c2eca9 name:ZooKeeperConnection
Watcher:127.0.0.1:18712 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 123919 T385 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 123920 T385 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 123922 T385 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 123924 T436 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@13444824
name:ZooKeeperConnection Watcher:127.0.0.1:18712/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 123924 T385 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 123934 T385
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 124942 T385 oasc.ZkController.createEphemeralLiveNode Register
node as live in ZooKeeper:/live_nodes/127.0.0.1:18723_c_bf
[junit4] 2> 124944 T385 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:18723_c_bf
[junit4] 2> 124950 T385 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 124961 T385 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3
[junit4] 2> 124962 T385 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 126289 T385 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 126290 T385 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 126299 T385 oejus.SslContextFactory.doStart Enabled Protocols
[SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1,
TLSv1.1, TLSv1.2]
[junit4] 2> 126302 T385 oejs.AbstractConnector.doStart Started
[email protected]:18726
[junit4] 2> 126306 T385 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 126307 T385 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 126307 T385 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-004
[junit4] 2> 126307 T385 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-004/'
[junit4] 2> 126351 T385 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-004/solr.xml
[junit4] 2> 126431 T385 oasc.CoreContainer.<init> New CoreContainer
335784909
[junit4] 2> 126431 T385 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-004/]
[junit4] 2> 126433 T385 oashc.HttpShardHandlerFactory.getParameter Setting
socketTimeout to: 120000
[junit4] 2> 126433 T385 oashc.HttpShardHandlerFactory.getParameter Setting
urlScheme to: null
[junit4] 2> 126433 T385 oashc.HttpShardHandlerFactory.getParameter Setting
connTimeout to: 15000
[junit4] 2> 126434 T385 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnectionsPerHost to: 20
[junit4] 2> 126434 T385 oashc.HttpShardHandlerFactory.getParameter Setting
corePoolSize to: 0
[junit4] 2> 126435 T385 oashc.HttpShardHandlerFactory.getParameter Setting
maximumPoolSize to: 2147483647
[junit4] 2> 126435 T385 oashc.HttpShardHandlerFactory.getParameter Setting
maxThreadIdleTime to: 5
[junit4] 2> 126435 T385 oashc.HttpShardHandlerFactory.getParameter Setting
sizeOfQueue to: -1
[junit4] 2> 126436 T385 oashc.HttpShardHandlerFactory.getParameter Setting
fairnessPolicy to: false
[junit4] 2> 126439 T385 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 126443 T385 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 126443 T385 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 126443 T385 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 126444 T385 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:18712/solr
[junit4] 2> 126444 T385 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 126445 T385
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 126446 T385 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 126447 T449 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@2a938278
name:ZooKeeperConnection Watcher:127.0.0.1:18712 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 126448 T385 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 126448 T385 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 126452 T385 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 126453 T451 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@32eea79d
name:ZooKeeperConnection Watcher:127.0.0.1:18712/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 126453 T385 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 126464 T385
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 127472 T385 oasc.ZkController.createEphemeralLiveNode Register
node as live in ZooKeeper:/live_nodes/127.0.0.1:18726_c_bf
[junit4] 2> 127474 T385 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:18726_c_bf
[junit4] 2> 127480 T385 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 127487 T385 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3
[junit4] 2> 127488 T385 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 128890 T385 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 3
[junit4] 2> 128891 T385 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 128897 T385 oejus.SslContextFactory.doStart Enabled Protocols
[SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1,
TLSv1.1, TLSv1.2]
[junit4] 2> 128900 T385 oejs.AbstractConnector.doStart Started
[email protected]:18729
[junit4] 2> 128902 T385 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 128902 T385 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 128903 T385 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-005
[junit4] 2> 128903 T385 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-005/'
[junit4] 2> 128932 T385 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-005/solr.xml
[junit4] 2> 128984 T385 oasc.CoreContainer.<init> New CoreContainer
588064669
[junit4] 2> 128984 T385 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-005/]
[junit4] 2> 128985 T385 oashc.HttpShardHandlerFactory.getParameter Setting
socketTimeout to: 120000
[junit4] 2> 128985 T385 oashc.HttpShardHandlerFactory.getParameter Setting
urlScheme to: null
[junit4] 2> 128986 T385 oashc.HttpShardHandlerFactory.getParameter Setting
connTimeout to: 15000
[junit4] 2> 128986 T385 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnectionsPerHost to: 20
[junit4] 2> 128986 T385 oashc.HttpShardHandlerFactory.getParameter Setting
corePoolSize to: 0
[junit4] 2> 128986 T385 oashc.HttpShardHandlerFactory.getParameter Setting
maximumPoolSize to: 2147483647
[junit4] 2> 128987 T385 oashc.HttpShardHandlerFactory.getParameter Setting
maxThreadIdleTime to: 5
[junit4] 2> 128987 T385 oashc.HttpShardHandlerFactory.getParameter Setting
sizeOfQueue to: -1
[junit4] 2> 128987 T385 oashc.HttpShardHandlerFactory.getParameter Setting
fairnessPolicy to: false
[junit4] 2> 128990 T385 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 128992 T385 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 128992 T385 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 128992 T385 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 128993 T385 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:18712/solr
[junit4] 2> 128993 T385 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 128993 T385
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 128994 T385 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 128996 T464 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@fb8f30f name:ZooKeeperConnection
Watcher:127.0.0.1:18712 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 128997 T385 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 128997 T385 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 129000 T385 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 129001 T466 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@29bf9224
name:ZooKeeperConnection Watcher:127.0.0.1:18712/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 129001 T385 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 129010 T385
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 130018 T385 oasc.ZkController.createEphemeralLiveNode Register
node as live in ZooKeeper:/live_nodes/127.0.0.1:18729_c_bf
[junit4] 2> 130020 T385 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:18729_c_bf
[junit4] 2> 130026 T385 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 130032 T385 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3
[junit4] 2> 130033 T385 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 131315 T385 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 4
[junit4] 2> 131316 T385 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 131322 T385 oejus.SslContextFactory.doStart Enabled Protocols
[SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1,
TLSv1.1, TLSv1.2]
[junit4] 2> 131324 T385 oejs.AbstractConnector.doStart Started
[email protected]:18734
[junit4] 2> 131327 T385 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 131327 T385 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 131327 T385 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-006
[junit4] 2> 131328 T385 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-006/'
[junit4] 2> 131359 T385 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-006/solr.xml
[junit4] 2> 131418 T385 oasc.CoreContainer.<init> New CoreContainer
1169690021
[junit4] 2> 131419 T385 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-006/]
[junit4] 2> 131419 T385 oashc.HttpShardHandlerFactory.getParameter Setting
socketTimeout to: 120000
[junit4] 2> 131420 T385 oashc.HttpShardHandlerFactory.getParameter Setting
urlScheme to: null
[junit4] 2> 131420 T385 oashc.HttpShardHandlerFactory.getParameter Setting
connTimeout to: 15000
[junit4] 2> 131420 T385 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnectionsPerHost to: 20
[junit4] 2> 131421 T385 oashc.HttpShardHandlerFactory.getParameter Setting
corePoolSize to: 0
[junit4] 2> 131421 T385 oashc.HttpShardHandlerFactory.getParameter Setting
maximumPoolSize to: 2147483647
[junit4] 2> 131421 T385 oashc.HttpShardHandlerFactory.getParameter Setting
maxThreadIdleTime to: 5
[junit4] 2> 131421 T385 oashc.HttpShardHandlerFactory.getParameter Setting
sizeOfQueue to: -1
[junit4] 2> 131422 T385 oashc.HttpShardHandlerFactory.getParameter Setting
fairnessPolicy to: false
[junit4] 2> 131424 T385 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 131426 T385 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 131427 T385 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 131427 T385 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 131427 T385 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:18712/solr
[junit4] 2> 131428 T385 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 131428 T385
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 131429 T385 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 131430 T479 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@ef1bc73 name:ZooKeeperConnection
Watcher:127.0.0.1:18712 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 131431 T385 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 131431 T385 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 131433 T385 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 131434 T481 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@4ba532c0
name:ZooKeeperConnection Watcher:127.0.0.1:18712/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 131434 T385 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 131441 T385
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 132448 T385 oasc.ZkController.createEphemeralLiveNode Register
node as live in ZooKeeper:/live_nodes/127.0.0.1:18734_c_bf
[junit4] 2> 132450 T385 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:18734_c_bf
[junit4] 2> 132456 T385 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 132463 T385 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3
[junit4] 2> 132463 T385 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 132778 T426 oasha.CollectionsHandler.handleCreateAction
Creating Collection :
wt=javabin&router.field=myOwnField&numShards=2&version=2&replicationFactor=2&name=solrj_collection&collection.configName=conf1&action=CREATE
[junit4] 2> 132781 T422 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/collection-queue-work state:
SyncConnected type NodeChildrenChanged
[junit4] 2> 132783 T415 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> 132791 T485 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> 132798 T485 oasc.OverseerCollectionProcessor.createConfNode
creating collections conf node /collections/solrj_collection
[junit4] 2> 132799 T485 oascc.SolrZkClient.makePath makePath:
/collections/solrj_collection
[junit4] 2> 132805 T422 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 132811 T414 oasc.Overseer$ClusterStateUpdater.buildCollection
building a new collection: solrj_collection
[junit4] 2> 132811 T414 oasc.Overseer$ClusterStateUpdater.createCollection
Create collection solrj_collection with shards [shard1, shard2]
[junit4] 2> 132812 T414 oasc.Overseer$ClusterStateUpdater.createCollection
state version solrj_collection 1
[junit4] 2> 132817 T482 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> 132817 T437 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> 132817 T452 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> 132817 T423 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> 132817 T422 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> 132817 T467 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> 132905 T485 oasc.OverseerCollectionProcessor.createCollection
Creating SolrCores for new collection solrj_collection, shardNames [shard1,
shard2] , replicationFactor : 2
[junit4] 2> 132906 T485 oasc.OverseerCollectionProcessor.createCollection
Creating shard solrj_collection_shard1_replica1 as part of slice shard1 of
collection solrj_collection on 127.0.0.1:18718_c_bf
[junit4] 2> 132917 T485 oasc.OverseerCollectionProcessor.createCollection
Creating shard solrj_collection_shard1_replica2 as part of slice shard1 of
collection solrj_collection on 127.0.0.1:18729_c_bf
[junit4] 2> 132919 T485 oasc.OverseerCollectionProcessor.createCollection
Creating shard solrj_collection_shard2_replica1 as part of slice shard2 of
collection solrj_collection on 127.0.0.1:18723_c_bf
[junit4] 2> 132922 T485 oasc.OverseerCollectionProcessor.createCollection
Creating shard solrj_collection_shard2_replica2 as part of slice shard2 of
collection solrj_collection on 127.0.0.1:18734_c_bf
[junit4] 2> 133073 T407 oasha.CoreAdminHandler.handleCreateAction core
create command
wt=javabin&numShards=2&version=2&name=solrj_collection_shard1_replica1&qt=/admin/cores&shard=shard1&collection.configName=conf1&collection=solrj_collection&action=CREATE
[junit4] 2> 133073 T456 oasha.CoreAdminHandler.handleCreateAction core
create command
wt=javabin&numShards=2&version=2&name=solrj_collection_shard1_replica2&qt=/admin/cores&shard=shard1&collection.configName=conf1&collection=solrj_collection&action=CREATE
[junit4] 2> 133073 T427 oasha.CoreAdminHandler.handleCreateAction core
create command
wt=javabin&numShards=2&version=2&name=solrj_collection_shard2_replica1&qt=/admin/cores&shard=shard2&collection.configName=conf1&collection=solrj_collection&action=CREATE
[junit4] 2> 133073 T471 oasha.CoreAdminHandler.handleCreateAction core
create command
wt=javabin&numShards=2&version=2&name=solrj_collection_shard2_replica2&qt=/admin/cores&shard=shard2&collection.configName=conf1&collection=solrj_collection&action=CREATE
[junit4] 2> 133095 T427 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica1 state=down collection=solrj_collection
[junit4] 2> 133095 T407 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica1 state=down collection=solrj_collection
[junit4] 2> 133095 T471 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica2 state=down collection=solrj_collection
[junit4] 2> 133095 T456 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica2 state=down collection=solrj_collection
[junit4] 2> 133104 T422 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 133105 T407 oasc.ZkController.waitForCoreNodeName look for our
core node name
[junit4] 2> 133105 T456 oasc.ZkController.waitForCoreNodeName look for our
core node name
[junit4] 2> 133105 T471 oasc.ZkController.waitForCoreNodeName look for our
core node name
[junit4] 2> 133105 T427 oasc.ZkController.waitForCoreNodeName look for our
core node name
[junit4] 2> 133137 T414 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "numShards":"2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:18718_c_bf",
[junit4] 2> "operation":"state",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"solrj_collection_shard1_replica1",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:18718/c_bf"}
[junit4] 2> 133151 T414 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "numShards":"2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:18734_c_bf",
[junit4] 2> "operation":"state",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"solrj_collection_shard2_replica2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:18734/c_bf"}
[junit4] 2> 133155 T422 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 133157 T414 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "numShards":"2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:18729_c_bf",
[junit4] 2> "operation":"state",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"solrj_collection_shard1_replica2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:18729/c_bf"}
[junit4] 2> 133162 T414 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "numShards":"2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:18723_c_bf",
[junit4] 2> "operation":"state",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"solrj_collection_shard2_replica1",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:18723/c_bf"}
[junit4] 2> 133165 T422 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 133168 T467 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> 133168 T452 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> 133168 T437 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> 133168 T422 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> 133168 T423 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> 133168 T482 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> 134106 T407 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard1_replica1
[junit4] 2> 134106 T407 oasc.ZkController.createCollectionZkNode Check for
collection zkNode:solrj_collection
[junit4] 2> 134106 T471 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard2_replica2
[junit4] 2> 134106 T456 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard1_replica2
[junit4] 2> 134107 T427 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard2_replica1
[junit4] 2> 134107 T456 oasc.ZkController.createCollectionZkNode Check for
collection zkNode:solrj_collection
[junit4] 2> 134107 T471 oasc.ZkController.createCollectionZkNode Check for
collection zkNode:solrj_collection
[junit4] 2> 134109 T456 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 134107 T407 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 134109 T471 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 134109 T456 oascc.ZkStateReader.readConfigName Load collection
config from:/collections/solrj_collection
[junit4] 2> 134108 T427 oasc.ZkController.createCollectionZkNode Check for
collection zkNode:solrj_collection
[junit4] 2> 134110 T471 oascc.ZkStateReader.readConfigName Load collection
config from:/collections/solrj_collection
[junit4] 2> 134110 T407 oascc.ZkStateReader.readConfigName Load collection
config from:/collections/solrj_collection
[junit4] 2> 134111 T456 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 134111 T427 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 134112 T456 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-005/solrj_collection_shard1_replica2/'
[junit4] 2> 134112 T471 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 134113 T407 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 134112 T427 oascc.ZkStateReader.readConfigName Load collection
config from:/collections/solrj_collection
[junit4] 2> 134114 T407 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-002/solrj_collection_shard1_replica1/'
[junit4] 2> 134113 T471 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-006/solrj_collection_shard2_replica2/'
[junit4] 2> 134115 T427 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 134115 T427 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-003/solrj_collection_shard2_replica1/'
[junit4] 2> 134270 T456 oasc.SolrConfig.<init> Using Lucene MatchVersion:
5.0.0
[junit4] 2> 134270 T407 oasc.SolrConfig.<init> Using Lucene MatchVersion:
5.0.0
[junit4] 2> 134271 T427 oasc.SolrConfig.<init> Using Lucene MatchVersion:
5.0.0
[junit4] 2> 134271 T471 oasc.SolrConfig.<init> Using Lucene MatchVersion:
5.0.0
[junit4] 2> 134348 T456 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 134349 T407 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 134349 T471 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 134349 T427 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 134350 T456 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 134351 T407 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 134351 T471 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 134352 T427 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 134363 T456 oass.IndexSchema.readSchema
[solrj_collection_shard1_replica2] Schema name=test
[junit4] 2> 134364 T471 oass.IndexSchema.readSchema
[solrj_collection_shard2_replica2] Schema name=test
[junit4] 2> 134364 T427 oass.IndexSchema.readSchema
[solrj_collection_shard2_replica1] Schema name=test
[junit4] 2> 134365 T407 oass.IndexSchema.readSchema
[solrj_collection_shard1_replica1] Schema name=test
[junit4] 2> 134869 T427 oass.OpenExchangeRatesOrgProvider.init Initialized
with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 134884 T427 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 134889 T427 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 134896 T407 oass.OpenExchangeRatesOrgProvider.init Initialized
with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 134901 T456 oass.OpenExchangeRatesOrgProvider.init Initialized
with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 134907 T407 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 134907 T471 oass.OpenExchangeRatesOrgProvider.init Initialized
with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 134912 T407 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 134912 T456 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 134917 T456 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 134922 T471 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 134928 T471 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 134961 T427 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 134969 T427 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 134976 T427 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 134977 T456 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 134977 T407 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 134978 T427
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 134979 T427
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 134980 T427 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 134981 T427
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 134982 T427
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 134982 T427 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard2_replica1' using configuration from collection
solrj_collection
[junit4] 2> 134983 T427 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 134983 T427 oasc.SolrCore.<init>
[solrj_collection_shard2_replica1] Opening new SolrCore at
../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-003/solrj_collection_shard2_replica1/,
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-003/solrj_collection_shard2_replica1/data/
[junit4] 2> 134984 T456 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 134984 T427 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@d4cc64d
[junit4] 2> 134985 T407 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 134985 T471 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 134989 T427 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-003/solrj_collection_shard2_replica1/data
[junit4] 2> 134990 T427 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-003/solrj_collection_shard2_replica1/data/index/
[junit4] 2> 134991 T456 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 134991 T427 oasc.SolrCore.initIndex WARN
[solrj_collection_shard2_replica1] Solr index directory
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-003/solrj_collection_shard2_replica1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 134992 T407 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 134992 T427 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-003/solrj_collection_shard2_replica1/data/index
[junit4] 2> 134992 T456
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 134993 T427 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=28, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=0.9306640625,
floorSegmentMB=2.015625, forceMergeDeletesPctAllowed=14.642572363799598,
segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.23251524909355148
[junit4] 2> 134993 T471 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 134993 T407
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 134993 T456
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 134994 T407
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 134994 T427 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=BaseDirectoryWrapper(RAMDirectory(id=lucene-717f0d2d)),segFN=segments_1,generation=1}
[junit4] 2> 134995 T407 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 134995 T456 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 134996 T427 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 134997 T407
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 134998 T407
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 134998 T456
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 134999 T407 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard1_replica1' using configuration from collection
solrj_collection
[junit4] 2> 135000 T471 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 134999 T456
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 135000 T407 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 135001 T471
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 135001 T456 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard1_replica2' using configuration from collection
solrj_collection
[junit4] 2> 135002 T471
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 135002 T407 oasc.SolrCore.<init>
[solrj_collection_shard1_replica1] Opening new SolrCore at
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-002/solrj_collection_shard1_replica1/,
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-002/solrj_collection_shard1_replica1/data/
[junit4] 2> 135003 T471 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 135002 T456 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 135003 T407 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@d4cc64d
[junit4] 2> 135004 T456 oasc.SolrCore.<init>
[solrj_collection_shard1_replica2] Opening new SolrCore at
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-005/solrj_collection_shard1_replica2/,
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-005/solrj_collection_shard1_replica2/data/
[junit4] 2> 135005 T427 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 135005 T471
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 135005 T456 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@d4cc64d
[junit4] 2> 135006 T471
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 135007 T471 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard2_replica2' using configuration from collection
solrj_collection
[junit4] 2> 135008 T407 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-002/solrj_collection_shard1_replica1/data
[junit4] 2> 135008 T471 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 135009 T471 oasc.SolrCore.<init>
[solrj_collection_shard2_replica2] Opening new SolrCore at
../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-006/solrj_collection_shard2_replica2/,
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-006/solrj_collection_shard2_replica2/data/
[junit4] 2> 135010 T407 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-002/solrj_collection_shard1_replica1/data/index/
[junit4] 2> 135010 T471 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@d4cc64d
[junit4] 2> 135010 T456 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-005/solrj_collection_shard1_replica2/data
[junit4] 2> 135010 T407 oasc.SolrCore.initIndex WARN
[solrj_collection_shard1_replica1] Solr index directory
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-002/solrj_collection_shard1_replica1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 135013 T407 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-9899253F643C486-001/tempDir-002/solrj_collection_shard1_replica1/data/index
[junit4] 2> 135013 T456 oasc.SolrCore.getNewIndexDir New index dire
[...truncated too long message...]
86-001/tempDir-006/delLiveColl_shard1_replica2/data
[CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.cloud.DeleteReplicaTest-9899253F643C486-001/tempDir-006/delLiveColl_shard1_replica2/data;done=false>>]
[junit4] 2> 2166465 T772909 oasc.CachingDirectoryFactory.close Closing
directory:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.cloud.DeleteReplicaTest-9899253F643C486-001/tempDir-006/delLiveColl_shard1_replica2/data
[junit4] 2> 2166466 T772909 oasc.Overseer.close Overseer
(id=92481123640082446-127.0.0.1:40441__%2Fxl-n_0000000004) closing
[junit4] 2> 2166467 T773077 oasc.Overseer$ClusterStateUpdater.run Overseer
Loop exiting : 127.0.0.1:40441__%2Fxl
[junit4] 2> 2166470 T773080
oasc.Overseer$ClusterStateUpdater.checkIfIamStillLeader ERROR could not read
the data org.apache.zookeeper.KeeperException$SessionExpiredException:
KeeperErrorCode = Session expired for /overseer_elect/leader
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1155)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:347)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:344)
[junit4] 2> at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:61)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:344)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.checkIfIamStillLeader(Overseer.java:383)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.access$300(Overseer.java:126)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater$1.run(Overseer.java:333)
[junit4] 2>
[junit4] 2> 2166470 T773002 oascc.ZkStateReader$3.process WARN ZooKeeper
watch triggered, but Solr cannot talk to ZK
[junit4] 2> 2166472 T772909 oejsh.ContextHandler.doStop stopped
o.e.j.s.ServletContextHandler{/_/xl,null}
[junit4] 2> 2171468 T772909 oas.SolrTestCaseJ4.tearDown ###Ending
testDistribSearch
[junit4] 2> 2171471 T772909 oasc.ZkTestServer.send4LetterWord connecting
to 127.0.0.1:40351 40351
[junit4] 2> 2171615 T772910 oasc.ZkTestServer.send4LetterWord connecting
to 127.0.0.1:40351 40351
[junit4] 2> NOTE: download the large Jenkins line-docs file by running
'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=DeleteReplicaTest
-Dtests.method=testDistribSearch -Dtests.seed=9899253F643C486
-Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true
-Dtests.linedocsfile=/home/jenkins/lucene-data/enwiki.random.lines.txt
-Dtests.locale=hu -Dtests.timezone=US/Alaska -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 229s J1 | DeleteReplicaTest.testDistribSearch <<<
[junit4] > Throwable #1:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available
to handle this request:[https://127.0.0.1:40357/_/xl,
https://127.0.0.1:40424/_/xl, https://127.0.0.1:40441/_/xl,
https://127.0.0.1:40415/_/xl, https://127.0.0.1:40394/_/xl]
[junit4] > at
__randomizedtesting.SeedInfo.seed([9899253F643C486:886F1C4B811CA4BA]:0)
[junit4] > at
org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:322)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrServer.sendRequest(CloudSolrServer.java:874)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrServer.requestWithRetryOnStaleState(CloudSolrServer.java:658)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrServer.request(CloudSolrServer.java:601)
[junit4] > at
org.apache.solr.cloud.DeleteReplicaTest.removeAndWaitForReplicaGone(DeleteReplicaTest.java:165)
[junit4] > at
org.apache.solr.cloud.DeleteReplicaTest.deleteLiveReplicaTest(DeleteReplicaTest.java:137)
[junit4] > at
org.apache.solr.cloud.DeleteReplicaTest.doTest(DeleteReplicaTest.java:88)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > Caused by:
org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Could not
remove replica : delLiveColl/shard2/core_node4
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:550)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:210)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:206)
[junit4] > at
org.apache.solr.client.solrj.impl.LBHttpSolrServer.doRequest(LBHttpSolrServer.java:343)
[junit4] > at
org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:304)
[junit4] > ... 47 more
[junit4] 2> 2171640 T772909 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.cloud.DeleteReplicaTest-9899253F643C486-001
[junit4] 2> 228551 T772908 ccr.ThreadLeakControl.checkThreadLeaks WARNING
Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Lucene410: {}, docValues:{},
sim=DefaultSimilarity, locale=hu, timezone=US/Alaska
[junit4] 2> NOTE: FreeBSD 9.1-RELEASE-p3 amd64/Oracle Corporation 1.7.0_65
(64-bit)/cpus=16,threads=1,free=259134392,total=442499072
[junit4] 2> NOTE: All tests run in this JVM:
[SignatureUpdateProcessorFactoryTest, CurrencyFieldOpenExchangeTest,
TestDistributedMissingSort, SolrRequestParserTest, TestRawResponseWriter,
DistributedSuggestComponentTest, DistributedQueryComponentCustomSortTest,
PathHierarchyTokenizerFactoryTest, TestDefaultSearchFieldResource,
TestZkChroot, SpatialFilterTest, TestStressVersions, TestCodecSupport,
SampleTest, ZkControllerTest, RemoteQueryErrorTest, SolrIndexConfigTest,
FastVectorHighlighterTest, NotRequiredUniqueKeyTest, TestGroupingSearch,
BasicZkTest, RankQueryTest, TestSweetSpotSimilarityFactory,
TestReloadAndDeleteDocs, LukeRequestHandlerTest, OpenCloseCoreStressTest,
TestLeaderElectionZkExpiry, DistribCursorPagingTest, RequiredFieldsTest,
TestSystemIdResolver, TestFastOutputStream, ChangedSchemaMergeTest,
DistributedFacetPivotLargeTest, ExternalFileFieldSortTest,
HdfsBasicDistributedZkTest, SortByFunctionTest,
DirectUpdateHandlerOptimizeTest, MigrateRouteKeyTest,
DirectSolrSpellCheckerTest, TestCloudSchemaless, CursorMarkTest,
TestComponentsName, SolrCoreCheckLockOnStartupTest, ExternalCollectionsTest,
TestSolrXmlPersistor, CoreAdminRequestStatusTest, TestBM25SimilarityFactory,
OverseerStatusTest, TestDocumentBuilder, DateFieldTest, TestReload,
TestFiltering, BasicFunctionalityTest, OverseerCollectionProcessorTest,
ShowFileRequestHandlerTest, DistributedQueryElevationComponentTest,
TestFoldingMultitermQuery, SuggesterTest, NoCacheHeaderTest,
TestAtomicUpdateErrorCases, TestSolrDeletionPolicy1, SolrInfoMBeanTest,
XsltUpdateRequestHandlerTest, IndexBasedSpellCheckerTest,
StandardRequestHandlerTest, TestQueryTypes, TermsComponentTest,
TestIndexingPerformance, TestSolrQueryParser, LoggingHandlerTest,
TestJmxIntegration, UpdateRequestProcessorFactoryTest, TestCSVResponseWriter,
TestAnalyzedSuggestions, JsonLoaderTest, PingRequestHandlerTest,
HighlighterConfigTest, UpdateParamsTest, CopyFieldTest, TestStressRecovery,
PrimUtilsTest, DOMUtilTest, ClusterStateTest, ZkNodePropsTest, UUIDFieldTest,
CircularListTest, CursorPagingTest, AsyncMigrateRouteKeyTest,
DeleteLastCustomShardedReplicaTest, DeleteReplicaTest]
[junit4] Completed on J1 in 229.34s, 1 test, 1 error <<< FAILURES!
[...truncated 394 lines...]
BUILD FAILED
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:498:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:471:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:60:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/extra-targets.xml:39:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build.xml:189:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/common-build.xml:496:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:1358:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:961:
There were test failures: 429 suites, 1772 tests, 3 errors, 55 ignored (11
assumptions)
Total time: 173 minutes 10 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-NightlyTests-5.x #622
Archived 5 artifacts
Archive block size is 32768
Received 0 blocks and 458222560 bytes
Compression is 0.0%
Took 1 min 15 sec
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
