Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-MacOSX/1939/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseG1GC
4 tests failed.
FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testDistribSearch
Error Message:
Captured an uncaught exception in thread: Thread[id=1552, name=Thread-516,
state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=1552, name=Thread-516, state=RUNNABLE,
group=TGRP-CollectionsAPIDistributedZkTest]
at
__randomizedtesting.SeedInfo.seed([76C18CE6CA7387D3:F72702FEBD2CE7EF]:0)
Caused by:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:49493: Could not find collection :
awholynewstresscollection_collection1_0
at __randomizedtesting.SeedInfo.seed([76C18CE6CA7387D3]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:558)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:214)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:210)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:370)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1015)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:793)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:736)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:921)
FAILED:
org.apache.solr.cloud.DistribDocExpirationUpdateProcessorTest.testDistribSearch
Error Message:
There are still nodes recoverying - waited for 30 seconds
Stack Trace:
java.lang.AssertionError: There are still nodes recoverying - waited for 30
seconds
at
__randomizedtesting.SeedInfo.seed([76C18CE6CA7387D3:F72702FEBD2CE7EF]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:178)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:839)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForThingsToLevelOut(AbstractFullDistribZkTestBase.java:1458)
at
org.apache.solr.cloud.DistribDocExpirationUpdateProcessorTest.doTest(DistribDocExpirationUpdateProcessorTest.java:69)
at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:878)
at sun.reflect.GeneratedMethodAccessor49.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:483)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.DistribDocExpirationUpdateProcessorTest
Error Message:
Some resources were not closed, shutdown, or released.
Stack Trace:
java.lang.AssertionError: Some resources were not closed, shutdown, or released.
at __randomizedtesting.SeedInfo.seed([76C18CE6CA7387D3]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:213)
at sun.reflect.GeneratedMethodAccessor33.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:483)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:790)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
FAILED: org.apache.solr.core.TestDynamicLoading.testDistribSearch
Error Message:
Could not successfully add blob after 150 attempts. Expecting 2 items. time
elapsed 16 522 output for url is { "responseHeader":{ "status":0,
"QTime":0}, "response":{ "numFound":1, "start":0, "docs":[{
"id":"test/1", "md5":"4c1d582258fba7480918ee17c7ed4350",
"blobName":"test", "version":1,
"timestamp":"2015-01-19T17:17:10.335Z", "size":5365}]}}
Stack Trace:
java.lang.AssertionError: Could not successfully add blob after 150 attempts.
Expecting 2 items. time elapsed 16 522 output for url is {
"responseHeader":{
"status":0,
"QTime":0},
"response":{
"numFound":1,
"start":0,
"docs":[{
"id":"test/1",
"md5":"4c1d582258fba7480918ee17c7ed4350",
"blobName":"test",
"version":1,
"timestamp":"2015-01-19T17:17:10.335Z",
"size":5365}]}}
at
__randomizedtesting.SeedInfo.seed([76C18CE6CA7387D3:F72702FEBD2CE7EF]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.handler.TestBlobHandler.postAndCheck(TestBlobHandler.java:150)
at
org.apache.solr.core.TestDynamicLoading.dynamicLoading(TestDynamicLoading.java:115)
at
org.apache.solr.core.TestDynamicLoading.doTest(TestDynamicLoading.java:71)
at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:878)
at sun.reflect.GeneratedMethodAccessor96.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:483)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 8972 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/init-core-data-001
[junit4] 2> 303974 T1286 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(false) and clientAuth (false)
[junit4] 2> 303974 T1286 oas.BaseDistributedSearchTestCase.initHostContext
Setting hostContext system property: /
[junit4] 2> 303978 T1286 oas.SolrTestCaseJ4.setUp ###Starting
testDistribSearch
[junit4] 2> 303980 T1286 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 303982 T1287 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 304083 T1286 oasc.ZkTestServer.run start zk server on
port:49488
[junit4] 2> 304083 T1286
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 304087 T1286 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 304100 T1294 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@160c648 name:ZooKeeperConnection
Watcher:127.0.0.1:49488 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 304101 T1286 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 304102 T1286 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 304102 T1286 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 304138 T1286
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 304139 T1286 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 304144 T1297 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@2529eb04
name:ZooKeeperConnection Watcher:127.0.0.1:49488/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 304145 T1286 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 304146 T1286 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 304146 T1286 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 304158 T1286 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 304168 T1286 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 304185 T1286 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 304193 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 304193 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 304207 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 304208 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 304239 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 304240 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 304244 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 304246 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 304254 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 304255 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 304261 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 304262 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 304267 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 304268 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 304275 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 304277 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 304283 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 304284 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 304291 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 304293 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 304300 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 304301 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> 304318 T1286
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 304325 T1286 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 304330 T1300 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@431e1608
name:ZooKeeperConnection Watcher:127.0.0.1:49488 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 304330 T1286 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 304331 T1286 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 304331 T1286 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 304344 T1286
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 304357 T1303 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@f48fb8e name:ZooKeeperConnection
Watcher:127.0.0.1:49488/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 304358 T1286 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 304358 T1286 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 304358 T1286 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 304361 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf2/solrconfig.xml
[junit4] 2> 304364 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf2/solrconfig.xml
[junit4] 2> 304399 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf2/schema.xml
[junit4] 2> 304400 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf2/schema.xml
[junit4] 2> 304453 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf2/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 304454 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf2/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 304463 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf2/stopwords.txt
[junit4] 2> 304463 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf2/stopwords.txt
[junit4] 2> 304476 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf2/protwords.txt
[junit4] 2> 304476 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf2/protwords.txt
[junit4] 2> 304483 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf2/currency.xml
[junit4] 2> 304485 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf2/currency.xml
[junit4] 2> 304492 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf2/open-exchange-rates.json
[junit4] 2> 304494 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf2/open-exchange-rates.json
[junit4] 2> 304502 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf2/mapping-ISOLatin1Accent.txt
[junit4] 2> 304503 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf2/mapping-ISOLatin1Accent.txt
[junit4] 2> 304511 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf2/old_synonyms.txt
[junit4] 2> 304512 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf2/old_synonyms.txt
[junit4] 2> 304519 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf2/synonyms.txt
[junit4] 2> 304521 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf2/synonyms.txt
[junit4] 2> 304527 T1286 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/elevate.xml
to /configs/conf2/elevate.xml
[junit4] 2> 304528 T1286 oascc.SolrZkClient.makePath makePath:
/configs/conf2/elevate.xml
[junit4] 2> 307271 T1286 oas.SolrTestCaseJ4.writeCoreProperties Writing
core.properties file to
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/control-001/cores/collection1
[junit4] 2> 307281 T1286 oejs.Server.doStart jetty-9.2.6.v20141205
[junit4] 2> 307290 T1286 oejsh.ContextHandler.doStart Started
o.e.j.s.ServletContextHandler@40726276{/,null,AVAILABLE}
[junit4] 2> 307330 T1286 oejs.AbstractConnector.doStart Started
ServerConnector@a459232{HTTP/1.1}{127.0.0.1:49493}
[junit4] 2> 307331 T1286 oejs.Server.doStart Started @311666ms
[junit4] 2> 307332 T1286 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@4554617c
[junit4] 2> 307333 T1286 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 307334 T1286 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/control-001
[junit4] 2> 307335 T1286 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/control-001/'
[junit4] 2> 307403 T1286 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/control-001/solr.xml
[junit4] 2> 307420 T1286 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/control-001/cores
[junit4] 2> 307421 T1286 oasc.CoreContainer.<init> New CoreContainer
1699090065
[junit4] 2> 307421 T1286 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/control-001/]
[junit4] 2> 307422 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 307422 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 307423 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 307423 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 307424 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 307424 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 307425 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 307425 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 307425 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 307426 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 307426 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting useRetries to: false
[junit4] 2> 307427 T1286 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 307427 T1286 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 307427 T1286 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 307428 T1286 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 307429 T1286 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:49488/solr
[junit4] 2> 307429 T1286 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 307429 T1286
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 307431 T1286 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 307438 T1317 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3ff788d7
name:ZooKeeperConnection Watcher:127.0.0.1:49488 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 307440 T1286 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 307441 T1286 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 307454 T1286 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 307459 T1320 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3afd3061
name:ZooKeeperConnection Watcher:127.0.0.1:49488/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 307459 T1286 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 307467 T1286 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 307478 T1286 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 307486 T1286 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 307505 T1286 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 307520 T1286 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 307536 T1286 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 307545 T1286 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49493_
[junit4] 2> 307550 T1286 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:49493_
[junit4] 2> 307559 T1286 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 307568 T1286 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 307574 T1286 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 307583 T1286 oasc.OverseerElectionContext.runLeaderProcess I
am going to be the leader 127.0.0.1:49493_
[junit4] 2> 307584 T1286 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 307592 T1286 oasc.Overseer.start Overseer
(id=93171416006524933-127.0.0.1:49493_-n_0000000000) starting
[junit4] 2> 307603 T1286 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 307656 T1286 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=10000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 307659 T1322 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 307698 T1286 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 307713 T1286 oascc.SolrZkClient.makePath makePath:
/aliases.json
[junit4] 2> 307723 T1286
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 307744 T1286 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/control-001/cores
[junit4] 2> 307746 T1321 oasc.Overseer$ClusterStateUpdater.run Starting to
work on the main queue
[junit4] 2> 307748 T1286 oasc.CorePropertiesLocator.discoverUnder Found
core collection1 in
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/control-001/cores/collection1/
[junit4] 2> 307748 T1286 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 307756 T1324 oasc.ZkController.publish publishing
core=collection1 state=down collection=control_collection
[junit4] 2> 307757 T1324 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 307759 T1320 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 307761 T1324 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 307773 T1321 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 0, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49493";,
[junit4] 2> "node_name":"127.0.0.1:49493_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 307776 T1321 oasco.ReplicaMutator.updateState Update state
numShards=1 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49493";,
[junit4] 2> "node_name":"127.0.0.1:49493_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 307777 T1321 oasco.ClusterStateMutator.createCollection
building a new cName: control_collection
[junit4] 2> 307778 T1321 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard1
[junit4] 2> 307783 T1320 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> 308763 T1324 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for collection1
[junit4] 2> 308763 T1324 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:control_collection
[junit4] 2> 308765 T1324 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 308766 T1324 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/control_collection
[junit4] 2> 308769 T1324 oascc.ZkStateReader.readConfigName
path=/collections/control_collection configName=conf1 specified config exists
in ZooKeeper
[junit4] 2> 308770 T1324 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/control-001/cores/collection1/'
[junit4] 2> 308810 T1324 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 308818 T1324 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 308833 T1324 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 308842 T1324 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 308862 T1324 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 308866 T1324 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 308874 T1324 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 309083 T1324 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 309095 T1324 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 309098 T1324 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 309137 T1324 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 309143 T1324 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 309149 T1324 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 309151 T1324
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 309153 T1324
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 309153 T1324 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 309157 T1324
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 309157 T1324
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 309158 T1324 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection control_collection
[junit4] 2> 309158 T1324 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 309159 T1324 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/control-001/cores/collection1/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/control-001/cores/collection1/data/
[junit4] 2> 309159 T1324 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6f746891
[junit4] 2> 309163 T1324 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/control-001/cores/collection1/data
[junit4] 2> 309164 T1324 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/control-001/cores/collection1/data/index/
[junit4] 2> 309164 T1324 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/control-001/cores/collection1/data/index' doesn't exist.
Creating new index...
[junit4] 2> 309165 T1324 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/control-001/cores/collection1/data/index
[junit4] 2> 309166 T1324 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=11, maxMergeAtOnceExplicit=32, maxMergedSegmentMB=55.521484375,
floorSegmentMB=1.8173828125, forceMergeDeletesPctAllowed=13.970981614949915,
segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 309168 T1324 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@3f60a8a5
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51821ae1),segFN=segments_1,generation=1}
[junit4] 2> 309168 T1324 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 309185 T1324 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 309187 T1324 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 309188 T1324 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 309188 T1324 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 309189 T1324 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 309189 T1324 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 309191 T1324 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 309192 T1324 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 309192 T1324 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 309195 T1324 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 309195 T1324 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 309195 T1324 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 309196 T1324 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 309197 T1324 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 309197 T1324 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 309198 T1324 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 309199 T1324 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 309199 T1324 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 309202 T1324 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 309203 T1324 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 309203 T1324 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 309204 T1324 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 309205 T1324 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 309206 T1324 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 309206 T1324 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 309207 T1324 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 309208 T1324 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 309222 T1324 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 309226 T1324 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 309229 T1324 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 309233 T1324 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 309235 T1324 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 309238 T1324 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 309238 T1324 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 309239 T1324 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=11,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6713511840285746]
[junit4] 2> 309240 T1324 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@3f60a8a5
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51821ae1),segFN=segments_1,generation=1}
[junit4] 2> 309241 T1324 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 309241 T1324 oass.SolrIndexSearcher.<init> Opening
Searcher@59df44cb[collection1] main
[junit4] 2> 309242 T1324 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/control_collection
[junit4] 2> 309247 T1324 oascc.ZkStateReader.readConfigName
path=/collections/control_collection configName=conf1 specified config exists
in ZooKeeper
[junit4] 2> 309248 T1324 oasr.ManagedResourceStorage.newStorageIO Setting
up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 309250 T1324
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 309251 T1324 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 309251 T1324 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 309253 T1324
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 309254 T1324 oasr.ManagedResourceStorage.load Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 309254 T1324 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 309254 T1324 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 309256 T1324 oasc.CoreContainer.registerCore registering core:
collection1
[junit4] 2> 309256 T1325 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@59df44cb[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 309258 T1328 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:49493 collection:control_collection
shard:shard1
[junit4] 2> 309259 T1286 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 309260 T1286 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 309261 T1328 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leader_elect/shard1/election
[junit4] 2> 309261 T1286
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 309264 T1286 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 309271 T1331 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@12931d85
name:ZooKeeperConnection Watcher:127.0.0.1:49488/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 309271 T1286 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 309273 T1286 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 309283 T1328 oasc.ShardLeaderElectionContext.runLeaderProcess
Running the leader process for shard shard1
[junit4] 2> 309290 T1320 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 309292 T1328
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 309292 T1328 oasc.ShardLeaderElectionContext.runLeaderProcess
I may be the new leader - try and sync
[junit4] 2> 309295 T1286
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> ASYNC NEW_CORE C188 name=collection1
org.apache.solr.core.SolrCore@7e05a280 url=http://127.0.0.1:49493/collection1
node=127.0.0.1:49493_ C188_STATE=coll:control_collection core:collection1
props:{core=collection1, base_url=http://127.0.0.1:49493,
node_name=127.0.0.1:49493_, state=down}
[junit4] 2> 309297 T1328 C188 P49493 oasc.SyncStrategy.sync Sync replicas
to http://127.0.0.1:49493/collection1/
[junit4] 2> 309298 T1328 C188 P49493 oasc.SyncStrategy.syncReplicas Sync
Success - now sync replicas to me
[junit4] 2> 309299 T1328 C188 P49493 oasc.SyncStrategy.syncToMe
http://127.0.0.1:49493/collection1/ has no replicas
[junit4] 2> 309299 T1328 oasc.ShardLeaderElectionContext.runLeaderProcess
I am the new leader: http://127.0.0.1:49493/collection1/ shard1
[junit4] 2> 309299 T1328 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leaders/shard1
[junit4] 2> 309303 T1321 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection"} current state
version: 1
[junit4] 2> 309310 T1320 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> 309310 T1331 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> 309318 T1286 oasc.ChaosMonkey.monkeyLog monkey: init - expire
sessions:false cause connection loss:false
[junit4] 2> 309319 T1286 oasc.AbstractFullDistribZkTestBase.createJettys
Creating collection1 with stateFormat=2
[junit4] 2> 309319 T1286
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 309321 T1286 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 309330 T1334 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@6be97480
name:ZooKeeperConnection Watcher:127.0.0.1:49488/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 309331 T1286 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 309334 T1286 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 309368 T1288 oazs.NIOServerCnxn.doIO WARN caught end of stream
exception EndOfStreamException: Unable to read additional data from client
sessionid 0x14b02e8c24a0007, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 309391 T1321 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 2, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "base_url":"http://127.0.0.1:49493";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 2
[junit4] 2> 309417 T1335 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 309425 T1321 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"create",
[junit4] 2> "name":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "stateFormat":2} current state version: 2
[junit4] 2> 309425 T1321 oasco.ClusterStateMutator.createCollection
building a new cName: collection1
[junit4] 2> 309428 T1331 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> 309445 T1335 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 309551 T1321 oasco.ZkStateWriter.writePendingUpdates going to
create_collection /collections/collection1/state.json
[junit4] 2> 309556 T1331 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> 309612 T1328 oasc.ZkController.register We are
http://127.0.0.1:49493/collection1/ and leader is
http://127.0.0.1:49493/collection1/
[junit4] 2> 309612 T1328 oasc.ZkController.register No LogReplay needed
for core=collection1 baseURL=http://127.0.0.1:49493
[junit4] 2> 309613 T1328 oasc.ZkController.checkRecovery I am the leader,
no recovery necessary
[junit4] 2> 309613 T1328 oasc.ZkController.publish publishing
core=collection1 state=active collection=control_collection
[junit4] 2> 309614 T1328 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 309625 T1320 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 309651 T1321 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49493";,
[junit4] 2> "node_name":"127.0.0.1:49493_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 4
[junit4] 2> 309675 T1321 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49493";,
[junit4] 2> "node_name":"127.0.0.1:49493_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 309788 T1320 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> 309788 T1331 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> 311890 T1286 oas.SolrTestCaseJ4.writeCoreProperties Writing
core.properties file to
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-1-001/cores/collection1
[junit4] 2> 311894 T1286 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 311897 T1286 oejs.Server.doStart jetty-9.2.6.v20141205
[junit4] 2> 311909 T1286 oejsh.ContextHandler.doStart Started
o.e.j.s.ServletContextHandler@3e1bedb3{/,null,AVAILABLE}
[junit4] 2> 311910 T1286 oejs.AbstractConnector.doStart Started
ServerConnector@3aa9e65e{HTTP/1.1}{127.0.0.1:49498}
[junit4] 2> 311910 T1286 oejs.Server.doStart Started @316245ms
[junit4] 2> 311911 T1286 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@4554617c
[junit4] 2> 311913 T1286 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 311914 T1286 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-1-001
[junit4] 2> 311914 T1286 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-1-001/'
[junit4] 2> 312020 T1286 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-1-001/solr.xml
[junit4] 2> 312039 T1286 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-1-001/cores
[junit4] 2> 312040 T1286 oasc.CoreContainer.<init> New CoreContainer
525250341
[junit4] 2> 312040 T1286 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-1-001/]
[junit4] 2> 312041 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 312042 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 312043 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 312044 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 312044 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 312045 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 312045 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 312046 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 312046 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 312047 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 312047 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting useRetries to: false
[junit4] 2> 312049 T1286 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 312049 T1286 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 312050 T1286 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 312050 T1286 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 312051 T1286 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:49488/solr
[junit4] 2> 312052 T1286 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 312052 T1286
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 312056 T1286 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 312068 T1349 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5ce364a8
name:ZooKeeperConnection Watcher:127.0.0.1:49488 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 312070 T1286 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 312070 T1286 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 312084 T1286 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 312092 T1352 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@6640f53 name:ZooKeeperConnection
Watcher:127.0.0.1:49488/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 312093 T1286 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 312119 T1286
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 313144 T1286 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49498_
[junit4] 2> 313148 T1286 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:49498_
[junit4] 2> 313163 T1286 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 313176 T1286 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-1-001/cores
[junit4] 2> 313178 T1286 oasc.CorePropertiesLocator.discoverUnder Found
core collection1 in
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-1-001/cores/collection1/
[junit4] 2> 313179 T1286 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 313191 T1353 oasc.ZkController.publish publishing
core=collection1 state=down collection=collection1
[junit4] 2> 313191 T1353 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 313196 T1320 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 313200 T1353 oasc.ZkController.preRegister Registering watch
for external collection collection1
[junit4] 2> 313201 T1353 oascc.ZkStateReader.addZkWatch addZkWatch
collection1
[junit4] 2> 313201 T1321 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49498";,
[junit4] 2> "node_name":"127.0.0.1:49498_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"} current state version: 5
[junit4] 2> 313204 T1353 oascc.ZkStateReader.addZkWatch Updating
collection state at /collections/collection1/state.json from ZooKeeper...
[junit4] 2> 313204 T1321 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49498";,
[junit4] 2> "node_name":"127.0.0.1:49498_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"}
[junit4] 2> 313205 T1321 oasco.ReplicaMutator.updateState Collection
already exists with numShards=2
[junit4] 2> 313205 T1321 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard2
[junit4] 2> 313218 T1321 oasco.ZkStateWriter.writePendingUpdates going to
update_collection /collections/collection1/state.json version: 0
[junit4] 2> 313219 T1353 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 0
[junit4] 2> 313219 T1353 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 313222 T1352 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 313225 T1352 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 1
[junit4] 2> 314221 T1353 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for collection1
[junit4] 2> 314222 T1353 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:collection1
[junit4] 2> 314224 T1353 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 314225 T1353 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 314228 T1353 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 314228 T1353 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-1-001/cores/collection1/'
[junit4] 2> 314264 T1353 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 314270 T1353 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 314291 T1353 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 314300 T1353 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 314316 T1353 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 314321 T1353 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 314329 T1353 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 314548 T1353 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 314555 T1353 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 314557 T1353 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 314604 T1353 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 314618 T1353 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 314625 T1353 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 314629 T1353
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 314630 T1353
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 314630 T1353 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 314633 T1353
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 314633 T1353
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 314633 T1353 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection collection1
[junit4] 2> 314634 T1353 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 314634 T1353 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-1-001/cores/collection1/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-1-001/cores/collection1/data/
[junit4] 2> 314635 T1353 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6f746891
[junit4] 2> 314636 T1353 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-1-001/cores/collection1/data
[junit4] 2> 314636 T1353 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-1-001/cores/collection1/data/index/
[junit4] 2> 314636 T1353 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-1-001/cores/collection1/data/index' doesn't exist.
Creating new index...
[junit4] 2> 314637 T1353 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-1-001/cores/collection1/data/index
[junit4] 2> 314638 T1353 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=11, maxMergeAtOnceExplicit=32, maxMergedSegmentMB=55.521484375,
floorSegmentMB=1.8173828125, forceMergeDeletesPctAllowed=13.970981614949915,
segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 314639 T1353 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@5e88a413
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@642d72af),segFN=segments_1,generation=1}
[junit4] 2> 314639 T1353 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 314646 T1353 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 314646 T1353 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 314647 T1353 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 314647 T1353 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 314647 T1353 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 314648 T1353 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 314648 T1353 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 314649 T1353 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 314649 T1353 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 314650 T1353 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 314650 T1353 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 314651 T1353 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 314652 T1353 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 314654 T1353 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 314655 T1353 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 314657 T1353 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 314658 T1353 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 314659 T1353 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 314661 T1353 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 314662 T1353 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 314663 T1353 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 314663 T1353 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 314664 T1353 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 314665 T1353 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 314665 T1353 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 314666 T1353 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 314667 T1353 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 314676 T1353 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 314679 T1353 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 314681 T1353 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 314683 T1353 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 314683 T1353 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 314687 T1353 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 314687 T1353 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 314689 T1353 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=11,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6713511840285746]
[junit4] 2> 314690 T1353 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@5e88a413
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@642d72af),segFN=segments_1,generation=1}
[junit4] 2> 314690 T1353 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 314690 T1353 oass.SolrIndexSearcher.<init> Opening
Searcher@4d62d93c[collection1] main
[junit4] 2> 314691 T1353 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 314695 T1353 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 314696 T1353 oasr.ManagedResourceStorage.newStorageIO Setting
up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 314698 T1353
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 314698 T1353 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 314699 T1353 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 314701 T1353
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 314701 T1353 oasr.ManagedResourceStorage.load Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 314702 T1353 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 314703 T1353 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 314704 T1353 oasc.CoreContainer.registerCore registering core:
collection1
[junit4] 2> 314709 T1354 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@4d62d93c[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 314711 T1357 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:49498 collection:collection1
shard:shard2
[junit4] 2> 314714 T1286 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 314714 T1286 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 314719 T1357 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leader_elect/shard2/election
[junit4] 2> 314732 T1357 oasc.ShardLeaderElectionContext.runLeaderProcess
Running the leader process for shard shard2
[junit4] 2> 314740 T1320 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 314757 T1321 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1"} current state version: 5
[junit4] 2> 314758 T1357
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 314758 T1357 oasc.ShardLeaderElectionContext.runLeaderProcess
I may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C189 name=collection1
org.apache.solr.core.SolrCore@6e0361fa url=http://127.0.0.1:49498/collection1
node=127.0.0.1:49498_ C189_STATE=coll:collection1 core:collection1
props:{core=collection1, base_url=http://127.0.0.1:49498,
node_name=127.0.0.1:49498_, state=down}
[junit4] 2> 314759 T1357 C189 P49498 oasc.SyncStrategy.sync Sync replicas
to http://127.0.0.1:49498/collection1/
[junit4] 2> 314759 T1357 C189 P49498 oasc.SyncStrategy.syncReplicas Sync
Success - now sync replicas to me
[junit4] 2> 314760 T1357 C189 P49498 oasc.SyncStrategy.syncToMe
http://127.0.0.1:49498/collection1/ has no replicas
[junit4] 2> 314761 T1357 oasc.ShardLeaderElectionContext.runLeaderProcess
I am the new leader: http://127.0.0.1:49498/collection1/ shard2
[junit4] 2> 314762 T1357 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leaders/shard2
[junit4] 2> 314768 T1321 oasco.ZkStateWriter.writePendingUpdates going to
update_collection /collections/collection1/state.json version: 1
[junit4] 2> 314775 T1352 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 314788 T1352 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 2
[junit4] 2> 314817 T1321 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1:49498";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 5
[junit4] 2> 314823 T1321 oasco.ZkStateWriter.writePendingUpdates going to
update_collection /collections/collection1/state.json version: 2
[junit4] 2> 314827 T1352 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 314834 T1352 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 3
[junit4] 2> 314835 T1320 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 314850 T1357 oasc.ZkController.register We are
http://127.0.0.1:49498/collection1/ and leader is
http://127.0.0.1:49498/collection1/
[junit4] 2> 314851 T1357 oasc.ZkController.register No LogReplay needed
for core=collection1 baseURL=http://127.0.0.1:49498
[junit4] 2> 314851 T1357 oasc.ZkController.checkRecovery I am the leader,
no recovery necessary
[junit4] 2> 314851 T1357 oasc.ZkController.publish publishing
core=collection1 state=active collection=collection1
[junit4] 2> 314852 T1357 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 314859 T1320 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 314863 T1321 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49498";,
[junit4] 2> "node_name":"127.0.0.1:49498_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"} current state version: 5
[junit4] 2> 314865 T1321 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49498";,
[junit4] 2> "node_name":"127.0.0.1:49498_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"}
[junit4] 2> 314871 T1321 oasco.ZkStateWriter.writePendingUpdates going to
update_collection /collections/collection1/state.json version: 3
[junit4] 2> 314877 T1352 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 314889 T1357 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 4
[junit4] 2> 314890 T1352 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 4
[junit4] 2> 317174 T1286 oas.SolrTestCaseJ4.writeCoreProperties Writing
core.properties file to
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-2-001/cores/collection1
[junit4] 2> 317180 T1286 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 317182 T1286 oejs.Server.doStart jetty-9.2.6.v20141205
[junit4] 2> 317187 T1286 oejsh.ContextHandler.doStart Started
o.e.j.s.ServletContextHandler@72192c57{/,null,AVAILABLE}
[junit4] 2> 317189 T1286 oejs.AbstractConnector.doStart Started
ServerConnector@56a43790{HTTP/1.1}{127.0.0.1:49501}
[junit4] 2> 317190 T1286 oejs.Server.doStart Started @321525ms
[junit4] 2> 317191 T1286 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@4554617c
[junit4] 2> 317192 T1286 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 317193 T1286 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-2-001
[junit4] 2> 317193 T1286 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-2-001/'
[junit4] 2> 317264 T1286 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-2-001/solr.xml
[junit4] 2> 317289 T1286 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-2-001/cores
[junit4] 2> 317291 T1286 oasc.CoreContainer.<init> New CoreContainer
1649393448
[junit4] 2> 317291 T1286 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest
76C18CE6CA7387D3-001/shard-2-001/]
[junit4] 2> 317292 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 317293 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 317293 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 317293 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 317295 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 317297 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 317299 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 317299 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 317300 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 317307 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 317308 T1286 oashc.HttpShardHandlerFactory.getParameter
Setting useRetries to: false
[junit4] 2> 317309 T1286 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 317310 T1286 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 317311 T1286 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 317317 T1286 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 317318 T1286 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:49488/solr
[junit4] 2> 317318 T1286 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 317318 T1286
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 317327 T1286 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 317331 T1371 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@11ee6899
name:ZooKeeperConnection Watcher:127.0.0.
[...truncated too long message...]
nFieldsTest, DocValuesTest, TestChildDocTransformer,
TestRequestStatusCollectionAPI, TestCollationFieldDocValues,
TermsComponentTest, DistributedExpandComponentTest, TestFunctionQuery,
TestClusterStateMutator, SOLR749Test, TestElisionMultitermQuery,
DistributedFacetPivotSmallAdvancedTest,
OutOfBoxZkACLAndCredentialsProvidersTest, TestFreeTextSuggestions,
CircularListTest, TestSortingResponseWriter, HdfsRecoveryZkTest,
CollectionsAPIDistributedZkTest, DeleteReplicaTest,
TermVectorComponentDistributedTest, ClusterStateTest, CustomCollectionTest,
TestRebalanceLeaders, DocValuesMultiTest, DocValuesMissingTest,
TestManagedStopFilterFactory, TestQueryTypes, TestUtils, ShardRoutingTest,
TestLazyCores, ConvertedLegacyTest, TestPhraseSuggestions, TestLRUStatsCache,
TestSolr4Spatial, DistributedSuggestComponentTest, BasicZkTest,
DirectUpdateHandlerTest, TestCodecSupport, TestCollectionAPI,
VMParamsZkACLAndCredentialsProvidersTest, BasicDistributedZkTest,
TestIndexSearcher, BasicFunctionalityTest, SolrIndexConfigTest, SampleTest,
FileUtilsTest, UniqFieldsUpdateProcessorFactoryTest,
DistributedDebugComponentTest, TestDocBasedVersionConstraints, ShardSplitTest,
TestStressVersions, TestMiniSolrCloudCluster, SpellCheckComponentTest,
SimplePostToolTest, UUIDFieldTest, TestMergePolicyConfig, NoCacheHeaderTest,
TestSchemaManager, TestInitQParser, CoreAdminRequestStatusTest,
SolrPluginUtilsTest, TestIndexingPerformance, TestDefaultStatsCache,
TestFieldCollectionResource, HdfsLockFactoryTest, BadComponentTest,
OutputWriterTest, TestLRUCache, StatsComponentTest,
OverseerCollectionProcessorTest, SimpleCollectionCreateDeleteTest,
TestSolrDeletionPolicy1, XsltUpdateRequestHandlerTest, MBeansHandlerTest,
TestClassNameShortening, HdfsDirectoryTest, DistributedTermsComponentTest,
TestManagedResourceStorage, ConnectionManagerTest,
TestSerializedLuceneMatchVersion, TestBadConfig, ChangedSchemaMergeTest,
SpatialFilterTest, TestSchemaSimilarityResource, TestNRTOpen,
TestNoOpRegenerator, TestExactStatsCache, TestPerFieldSimilarity,
TestTolerantSearch, HdfsSyncSliceTest, AnalyticsMergeStrategyTest,
DistributedFacetPivotLongTailTest, TestRealTimeGet, TestShortCircuitedRequests,
DocExpirationUpdateProcessorFactoryTest, TestOrdValues, TestCoreContainer,
DistributedQueueTest, TestAddFieldRealTimeGet, TestCloudSchemaless,
TestFuzzyAnalyzedSuggestions, MergeStrategyTest, BlockCacheTest,
TestHashPartitioner, TestFieldTypeCollectionResource, HttpPartitionTest,
RemoteQueryErrorTest, TestWordDelimiterFilterFactory, TestRecoveryHdfs,
DistributedQueryComponentCustomSortTest, TestRandomDVFaceting,
ZkSolrClientTest, TestPartialUpdateDeduplication,
TestSweetSpotSimilarityFactory, TestFileDictionaryLookup, AssignTest,
TestInitParams, TestComplexPhraseQParserPlugin, TestCloudInspectUtil,
DistributedQueryComponentOptimizationTest, RankQueryTest, TestSchemaResource,
ExitableDirectoryReaderTest, BadIndexSchemaTest, HighlighterTest,
MultiTermTest, SynonymTokenizerTest, TestSolrQueryParser, SolrCoreTest,
JSONWriterTest, TestHighlightDedupGrouping, ParsingFieldUpdateProcessorsTest,
PeerSyncTest, TestRawResponseWriter, BlockDirectoryTest,
TestReloadAndDeleteDocs, DistribDocExpirationUpdateProcessorTest,
FileBasedSpellCheckerTest, TestCursorMarkWithoutUniqueKey, TestZkChroot,
DistributedFacetPivotSmallTest, CachingDirectoryFactoryTest,
TestImplicitCoreProperties, MinimalSchemaTest, TestDynamicFieldResource,
DeleteShardTest, BasicDistributedZk2Test, TestReversedWildcardFilterFactory,
SolrXmlInZkTest, OpenCloseCoreStressTest, ScriptEngineTest,
IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestManagedResource,
ExternalCollectionsTest, SuggestComponentTest, TestMissingGroups,
TestRandomMergePolicy, TestSearchPerf, TestBlendedInfixSuggestions,
ChaosMonkeyNothingIsSafeTest, HdfsCollectionsAPIDistributedZkTest,
TestComponentsName, TestJoin, EnumFieldTest, SoftAutoCommitTest,
TestJmxMonitoredMap, TestRemoteStreaming, PreAnalyzedFieldTest,
DocumentAnalysisRequestHandlerTest, TestFastOutputStream,
StandardRequestHandlerTest, FieldAnalysisRequestHandlerTest,
SpellPossibilityIteratorTest, TestConfigOverlay, XmlUpdateRequestHandlerTest,
SharedFSAutoReplicaFailoverUtilsTest, MultiThreadedOCPTest,
TestFoldingMultitermQuery, DistributedQueryElevationComponentTest,
OverseerRolesTest, TestCloudManagedSchemaConcurrent, InfoHandlerTest,
AnalysisErrorHandlingTest, TestBinaryResponseWriter, TermVectorComponentTest,
EchoParamsTest, HdfsDirectoryFactoryTest, FastVectorHighlighterTest,
TestFieldResource, BinaryUpdateRequestHandlerTest, TestAnalyzedSuggestions,
DistributedFacetPivotLargeTest, TestReRankQParserPlugin, TestFastWriter,
SystemInfoHandlerTest, DistribCursorPagingTest, SyncSliceTest, TestBinaryField,
TestStressReorder, SolrCmdDistributorTest, FacetPivotSmallTest,
NumericFieldsTest, IndexSchemaTest, ChaosMonkeySafeLeaderTest,
UnloadDistributedZkTest, OverseerTest, LeaderElectionIntegrationTest,
RecoveryZkTest, FullSolrCloudDistribCmdsTest, TestReplicationHandler,
ClusterStateUpdateTest, TestRandomFaceting, LeaderElectionTest, ZkCLITest,
ShardRoutingCustomTest, TestDistributedSearch, AutoCommitTest,
TestDistributedGrouping, TestFaceting, DistributedSpellCheckComponentTest,
ZkControllerTest, TestReload, HardAutoCommitTest, TestRangeQuery,
SimpleFacetsTest, TestGroupingSearch, QueryElevationComponentTest, TestSort,
TestFiltering, ShowFileRequestHandlerTest, CurrencyFieldOpenExchangeTest,
CurrencyFieldXmlFileTest, SolrIndexSplitterTest, TestCoreDiscovery,
SignatureUpdateProcessorFactoryTest, TestExtendedDismaxParser,
SpellCheckCollatorTest, SuggesterFSTTest, SolrRequestParserTest, SuggesterTest,
TestStressLucene, TestTrie, SuggesterWFSTTest, TestCSVLoader,
WordBreakSolrSpellCheckerTest, SchemaVersionSpecificBehaviorTest,
SolrCoreCheckLockOnStartupTest, TestPseudoReturnFields, TestUpdate,
FieldMutatingUpdateProcessorTest, TestAtomicUpdateErrorCases,
QueryEqualityTest, DirectUpdateHandlerOptimizeTest,
DefaultValueUpdateProcessorTest, StatelessScriptUpdateProcessorFactoryTest,
SortByFunctionTest, DistanceFunctionTest, SolrInfoMBeanTest,
DebugComponentTest, CacheHeaderTest, IndexBasedSpellCheckerTest,
TestSurroundQueryParser, DisMaxRequestHandlerTest, TestQueryUtils,
TestWriterPerf, DirectSolrSpellCheckerTest, PrimitiveFieldTypeTest,
TestOmitPositions, RequestHandlersTest, DocumentBuilderTest,
TestValueSourceCache, PathHierarchyTokenizerFactoryTest,
MoreLikeThisHandlerTest, RequiredFieldsTest, TestArbitraryIndexDir,
LoggingHandlerTest, RegexBoostProcessorTest, TestJmxIntegration,
TestCollationField, UpdateRequestProcessorFactoryTest, QueryParsingTest,
JsonLoaderTest, TestPHPSerializedResponseWriter, PingRequestHandlerTest,
CSVRequestHandlerTest, TestLFUCache, HighlighterConfigTest,
TestQuerySenderListener, UpdateParamsTest, AlternateDirectoryTest,
TestSolrIndexConfig, TestQuerySenderNoQuery, CopyFieldTest,
ResponseLogComponentTest, TestStressRecovery, TestSolrDeletionPolicy2,
TestConfig, ExternalFileFieldSortTest, TestSolrCoreProperties,
TestPostingsSolrHighlighter, DirectSolrConnectionTest,
NotRequiredUniqueKeyTest, TestLuceneMatchVersion, TestCharFilters,
TestXIncludeConfig, TestDFRSimilarityFactory,
TestLMJelinekMercerSimilarityFactory, TestIBSimilarityFactory,
TestBM25SimilarityFactory, TestDefaultSimilarityFactory,
LegacyHTMLStripCharFilterTest, TimeZoneUtilsTest, ResourceLoaderTest,
OpenExchangeRatesOrgProviderTest, PluginInfoTest, TestFastLRUCache,
DateMathParserTest, TestSystemIdResolver, PrimUtilsTest,
TestSuggestSpellingConverter, DateFieldTest, SpellingQueryConverterTest,
DOMUtilTest, RAMDirectoryFactoryTest, TestSolrJ, TestDocumentBuilder,
ZkNodePropsTest, SliceStateTest, TestRTGBase, CursorPagingTest,
DistributedIntervalFacetingTest, SolrTestCaseJ4Test,
TestDistributedMissingSort, AliasIntegrationTest, AsyncMigrateRouteKeyTest,
CloudExitableDirectoryReaderTest, CollectionsAPIAsyncDistributedZkTest,
DeleteInactiveReplicaTest, LeaderInitiatedRecoveryOnCommitTest,
MigrateRouteKeyTest, OverriddenZkACLAndCredentialsProvidersTest,
OverseerStatusTest, ReplicationFactorTest, RollingRestartTest,
SSLMigrationTest, SaslZkACLProviderTest, SharedFSAutoReplicaFailoverTest,
TestCloudPivotFacet, TestDistribDocBasedVersion, TestLeaderElectionZkExpiry,
TestReplicaProperties, TriLevelCompositeIdRoutingTest,
HdfsBasicDistributedZk2Test, HdfsBasicDistributedZkTest,
HdfsChaosMonkeySafeLeaderTest, HdfsUnloadDistributedZkTest,
HdfsWriteToMultipleCollectionsTest, StressHdfsTest, ZkStateWriterTest,
TestConfigSets, TestDynamicLoading]
[junit4] Completed in 55.36s, 2 tests, 1 failure <<< FAILURES!
[...truncated 205 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:519: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:467: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:61: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/extra-targets.xml:39: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build.xml:187: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/common-build.xml:510:
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:1348:
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:956:
There were test failures: 460 suites, 1850 tests, 1 suite-level error, 1 error,
2 failures, 51 ignored (19 assumptions)
Total time: 138 minutes 12 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.8.0
-XX:-UseCompressedOops -XX:+UseG1GC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
