Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.x/641/
1 tests failed.
REGRESSION:
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testDistribSearch
Error Message:
Error CREATEing SolrCore 'halfcollection_shard1_replica1': Unable to create
core [halfcollection_shard1_replica1] Caused by: Could not get shard id for
core: halfcollection_shard1_replica1
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Error
CREATEing SolrCore 'halfcollection_shard1_replica1': Unable to create core
[halfcollection_shard1_replica1] Caused by: Could not get shard id for core:
halfcollection_shard1_replica1
at
__randomizedtesting.SeedInfo.seed([5799FE829ADA6E0D:D67F709AED850E31]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:570)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:215)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:211)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testErrorHandling(CollectionsAPIDistributedZkTest.java:583)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.doTest(CollectionsAPIDistributedZkTest.java:205)
at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 13013 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/init-core-data-001
[junit4] 2> 3265327 T15465 oas.SolrTestCaseJ4.buildSSLConfig Randomized
ssl (true) and clientAuth (false)
[junit4] 2> 3265327 T15465
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system
property: /
[junit4] 2> 3265332 T15465 oas.SolrTestCaseJ4.setUp ###Starting
testDistribSearch
[junit4] 2> 3265332 T15465 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 3265333 T15466 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 3265433 T15465 oasc.ZkTestServer.run start zk server on
port:46225
[junit4] 2> 3265434 T15465
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3265435 T15465 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3265438 T15472 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@6e8ffb52
name:ZooKeeperConnection Watcher:127.0.0.1:46225 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3265439 T15465 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3265439 T15465 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3265439 T15465 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 3265441 T15465
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3265443 T15465 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3265444 T15474 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@19858ba8
name:ZooKeeperConnection Watcher:127.0.0.1:46225/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3265444 T15465 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3265444 T15465 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3265444 T15465 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 3265446 T15465 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 3265447 T15465 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 3265457 T15465 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 3265459 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 3265460 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 3265463 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 3265463 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 3265567 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 3265568 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 3265570 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 3265570 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 3265573 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 3265573 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 3265575 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 3265576 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 3265578 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 3265579 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 3265580 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 3265581 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 3265583 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 3265584 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 3265586 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 3265586 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 3265588 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 3265589 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> 3265591 T15465
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3265592 T15465 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3265593 T15476 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@7304dd6e
name:ZooKeeperConnection Watcher:127.0.0.1:46225/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3265593 T15465 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3265593 T15465 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> Using new style solr.xml
[junit4] 2> 3265595 T15465
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3265596 T15465 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3265596 T15478 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@2017a599
name:ZooKeeperConnection Watcher:127.0.0.1:46225 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3265597 T15465 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3265597 T15465 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3265597 T15465 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 3265599 T15465
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3265599 T15465 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3265600 T15480 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@49eefee0
name:ZooKeeperConnection Watcher:127.0.0.1:46225/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3265600 T15465 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3265601 T15465 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3265603 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf2/solrconfig.xml
[junit4] 2> 3265604 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf2/solrconfig.xml
[junit4] 2> 3265606 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf2/schema.xml
[junit4] 2> 3265607 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf2/schema.xml
[junit4] 2> 3265709 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf2/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 3265710 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf2/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 3265712 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf2/stopwords.txt
[junit4] 2> 3265713 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf2/stopwords.txt
[junit4] 2> 3265714 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf2/protwords.txt
[junit4] 2> 3265715 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf2/protwords.txt
[junit4] 2> 3265716 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf2/currency.xml
[junit4] 2> 3265717 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf2/currency.xml
[junit4] 2> 3265718 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf2/open-exchange-rates.json
[junit4] 2> 3265719 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf2/open-exchange-rates.json
[junit4] 2> 3265720 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf2/mapping-ISOLatin1Accent.txt
[junit4] 2> 3265721 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf2/mapping-ISOLatin1Accent.txt
[junit4] 2> 3265722 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf2/old_synonyms.txt
[junit4] 2> 3265723 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf2/old_synonyms.txt
[junit4] 2> 3265724 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf2/synonyms.txt
[junit4] 2> 3265725 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf2/synonyms.txt
[junit4] 2> 3265727 T15465 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/elevate.xml
to /configs/conf2/elevate.xml
[junit4] 2> 3265728 T15465 oascc.SolrZkClient.makePath makePath:
/configs/conf2/elevate.xml
[junit4] 2> 3267131 T15465 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3267135 T15465 oejus.SslContextFactory.doStart Enabled
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3,
TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 3267138 T15465 oejs.AbstractConnector.doStart Started
[email protected]:46235
[junit4] 2> 3267140 T15465 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 3267140 T15465 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 3267141 T15465 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-002
[junit4] 2> 3267141 T15465 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-002/'
[junit4] 2> 3267176 T15465 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-002/solr.xml
[junit4] 2> 3267226 T15465 oasc.CorePropertiesLocator.<init>
Config-defined core root directory:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-002
[junit4] 2> 3267227 T15465 oasc.CoreContainer.<init> New CoreContainer
1424706609
[junit4] 2> 3267227 T15465 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-002/]
[junit4] 2> 3267228 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 3267228 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 3267229 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 3267229 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 3267229 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 3267229 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 3267230 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 3267230 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 3267230 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 3267232 T15465 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 3267234 T15465 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3267234 T15465 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3267234 T15465 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3267234 T15465 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:46225/solr
[junit4] 2> 3267235 T15465 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 3267235 T15465
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3267236 T15465 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3267237 T15491 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1992b42e
name:ZooKeeperConnection Watcher:127.0.0.1:46225 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3267238 T15465 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3267238 T15465 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3267239 T15465 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3267240 T15493 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@2d82c10c
name:ZooKeeperConnection Watcher:127.0.0.1:46225/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3267240 T15465 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3267241 T15465 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 3267242 T15465 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 3267244 T15465 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 3267245 T15465 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 3267246 T15465 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 3267248 T15465 oascc.SolrZkClient.makePath makePath:
/live_nodes
[junit4] 2> 3267249 T15465 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46235_
[junit4] 2> 3267249 T15465 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:46235_
[junit4] 2> 3267250 T15465 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 3267251 T15465 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 3267252 T15465 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 3267253 T15465 oasc.OverseerElectionContext.runLeaderProcess I
am going to be the leader 127.0.0.1:46235_
[junit4] 2> 3267254 T15465 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 3267255 T15465 oasc.Overseer.start Overseer
(id=92576438018179078-127.0.0.1:46235_-n_0000000000) starting
[junit4] 2> 3267256 T15465 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 3267260 T15465 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=10000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 3267260 T15495 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 3267262 T15465 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 3267263 T15465 oascc.SolrZkClient.makePath makePath:
/aliases.json
[junit4] 2> 3267263 T15465
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3267265 T15494 oasc.Overseer$ClusterStateUpdater.run Starting
to work on the main queue
[junit4] 2> 3267267 T15465 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-002
[junit4] 2> 3267269 T15465 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-002/conf/
[junit4] 2> 3268065 T15465 oasc.CorePropertiesLocator.discover Found 1
core definitions
[junit4] 2> 3268066 T15465 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3
[junit4] 2> 3268066 T15465 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 3268070 T15465
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3268071 T15465 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3268072 T15499 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@77dd2f9b
name:ZooKeeperConnection Watcher:127.0.0.1:46225/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3268072 T15465 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3268072 T15465 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3268073 T15465
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3268075 T15465 oasc.ChaosMonkey.monkeyLog monkey: init -
expire sessions:false cause connection loss:false
[junit4] 2> 3268075 T15465 oasc.AbstractFullDistribZkTestBase.createJettys
Creating collection1 with stateFormat=2
[junit4] 2> 3268075 T15465
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3268075 T15465 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3268076 T15501 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@6fe2212a
name:ZooKeeperConnection Watcher:127.0.0.1:46225/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3268076 T15465 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3268077 T15465 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3268078 T15502 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 3268080 T15494
oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection:
collection1
[junit4] 2> 3268080 T15494
oasc.Overseer$ClusterStateUpdater.createCollection Create collection
collection1 with shards [shard1, shard2]
[junit4] 2> 3268080 T15494
oasc.Overseer$ClusterStateUpdater.createCollection state version collection1 2
[junit4] 2> 3268081 T15494
oasc.Overseer$ClusterStateUpdater.updateZkStates going to create_collection
/collections/collection1/state.json
[junit4] 2> 3268082 T15502 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> 3268082 T15503 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> 3269162 T15465 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 3269163 T15465 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3269167 T15465 oejus.SslContextFactory.doStart Enabled
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3,
TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 3269168 T15465 oejs.AbstractConnector.doStart Started
[email protected]:46242
[junit4] 2> 3269171 T15465 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 3269171 T15465 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 3269171 T15465 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-003
[junit4] 2> 3269171 T15465 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-003/'
[junit4] 2> 3269211 T15465 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-003/solr.xml
[junit4] 2> 3269268 T15465 oasc.CorePropertiesLocator.<init>
Config-defined core root directory:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-003
[junit4] 2> 3269269 T15465 oasc.CoreContainer.<init> New CoreContainer
330549257
[junit4] 2> 3269269 T15465 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-003/]
[junit4] 2> 3269270 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 3269270 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 3269270 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 3269271 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 3269271 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 3269271 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 3269271 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 3269272 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 3269272 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 3269274 T15465 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 3269276 T15465 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3269276 T15465 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3269276 T15465 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3269276 T15465 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:46225/solr
[junit4] 2> 3269277 T15465 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 3269277 T15465
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3269278 T15465 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3269279 T15514 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3d822ce8
name:ZooKeeperConnection Watcher:127.0.0.1:46225 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3269280 T15465 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3269280 T15465 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3269281 T15465 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3269282 T15516 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3950aabb
name:ZooKeeperConnection Watcher:127.0.0.1:46225/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3269282 T15465 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3269286 T15465
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3270290 T15465 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46242_
[junit4] 2> 3270291 T15465 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:46242_
[junit4] 2> 3270294 T15465 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 3270298 T15465 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-003
[junit4] 2> 3270301 T15465 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-003/conf/
[junit4] 2> 3271509 T15465 oasc.CorePropertiesLocator.discover Found 1
core definitions
[junit4] 2> 3271510 T15465 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3
[junit4] 2> 3271510 T15465 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 3272651 T15465 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 3272651 T15465 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3272655 T15465 oejus.SslContextFactory.doStart Enabled
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3,
TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 3272657 T15465 oejs.AbstractConnector.doStart Started
[email protected]:46251
[junit4] 2> 3272659 T15465 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 3272659 T15465 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 3272660 T15465 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-004
[junit4] 2> 3272660 T15465 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-004/'
[junit4] 2> 3272707 T15465 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-004/solr.xml
[junit4] 2> 3272762 T15465 oasc.CorePropertiesLocator.<init>
Config-defined core root directory:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-004
[junit4] 2> 3272762 T15465 oasc.CoreContainer.<init> New CoreContainer
1089793979
[junit4] 2> 3272762 T15465 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-004/]
[junit4] 2> 3272763 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 3272764 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 3272764 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 3272764 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 3272764 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 3272765 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 3272765 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 3272765 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 3272765 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 3272767 T15465 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 3272769 T15465 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3272769 T15465 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3272770 T15465 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3272770 T15465 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:46225/solr
[junit4] 2> 3272770 T15465 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 3272771 T15465
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3272771 T15465 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3272773 T15529 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@4526c435
name:ZooKeeperConnection Watcher:127.0.0.1:46225 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3272774 T15465 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3272774 T15465 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3272776 T15465 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3272777 T15531 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@727381d3
name:ZooKeeperConnection Watcher:127.0.0.1:46225/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3272778 T15465 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3272783 T15465
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3273787 T15465 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46251_
[junit4] 2> 3273788 T15465 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:46251_
[junit4] 2> 3273792 T15465 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 3273796 T15465 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-004
[junit4] 2> 3275037 T15465 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-004/conf/
[junit4] 2> 3275040 T15465 oasc.CorePropertiesLocator.discover Found 1
core definitions
[junit4] 2> 3275041 T15465 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3
[junit4] 2> 3275041 T15465 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 3276431 T15465 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 3
[junit4] 2> 3276431 T15465 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3276437 T15465 oejus.SslContextFactory.doStart Enabled
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3,
TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 3276439 T15465 oejs.AbstractConnector.doStart Started
[email protected]:46260
[junit4] 2> 3276442 T15465 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 3276442 T15465 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 3276443 T15465 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-005
[junit4] 2> 3276443 T15465 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-005/'
[junit4] 2> 3276543 T15465 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-005/solr.xml
[junit4] 2> 3276610 T15465 oasc.CorePropertiesLocator.<init>
Config-defined core root directory:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-005
[junit4] 2> 3276610 T15465 oasc.CoreContainer.<init> New CoreContainer
1479745280
[junit4] 2> 3276611 T15465 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-005/]
[junit4] 2> 3276612 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 3276612 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 3276613 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 3276613 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 3276613 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 3276614 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 3276614 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 3276614 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 3276615 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 3276618 T15465 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 3276620 T15465 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3276620 T15465 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3276621 T15465 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3276621 T15465 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:46225/solr
[junit4] 2> 3276621 T15465 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 3276622 T15465
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3276623 T15465 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3276624 T15544 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@731c287c
name:ZooKeeperConnection Watcher:127.0.0.1:46225 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3276625 T15465 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3276626 T15465 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3276628 T15465 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3276629 T15546 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@2fb2f99d
name:ZooKeeperConnection Watcher:127.0.0.1:46225/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3276629 T15465 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3276633 T15465
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3277638 T15465 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46260_
[junit4] 2> 3277640 T15465 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:46260_
[junit4] 2> 3277645 T15465 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 3277651 T15465 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-005
[junit4] 2> 3280909 T15465 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-005/conf/
[junit4] 2> 3281462 T15465 oasc.CorePropertiesLocator.discover Found 1
core definitions
[junit4] 2> 3281463 T15465 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3
[junit4] 2> 3281464 T15465 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 3285320 T15465 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 4
[junit4] 2> 3285321 T15465 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3285328 T15465 oejus.SslContextFactory.doStart Enabled
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3,
TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 3285330 T15465 oejs.AbstractConnector.doStart Started
[email protected]:46275
[junit4] 2> 3285336 T15465 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 3285336 T15465 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 3285337 T15465 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-006
[junit4] 2> 3285338 T15465 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-006/'
[junit4] 2> 3285460 T15465 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-006/solr.xml
[junit4] 2> 3285648 T15465 oasc.CorePropertiesLocator.<init>
Config-defined core root directory:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-006
[junit4] 2> 3285649 T15465 oasc.CoreContainer.<init> New CoreContainer
915844226
[junit4] 2> 3285650 T15465 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-006/]
[junit4] 2> 3285653 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 3285653 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 3285654 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 3285654 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 3285655 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 3285655 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 3285656 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 3285657 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 3285657 T15465 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 3285662 T15465 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 3285665 T15465 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3285666 T15465 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3285667 T15465 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3285667 T15465 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:46225/solr
[junit4] 2> 3285668 T15465 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 3285668 T15465
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3285670 T15465 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3285671 T15559 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@17cbc79a
name:ZooKeeperConnection Watcher:127.0.0.1:46225 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3285672 T15465 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3285673 T15465 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3285675 T15465 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3285676 T15561 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@6752a30f
name:ZooKeeperConnection Watcher:127.0.0.1:46225/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3285677 T15465 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3285683 T15465
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3286689 T15465 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46275_
[junit4] 2> 3286691 T15465 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:46275_
[junit4] 2> 3286696 T15465 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 3286703 T15465 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-006
[junit4] 2> 3287299 T15465 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-006/conf/
[junit4] 2> 3291162 T15465 oasc.CorePropertiesLocator.discover Found 1
core definitions
[junit4] 2> 3291165 T15465 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3
[junit4] 2> 3291165 T15465 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 3291332 T15508 oasha.CollectionsHandler.handleCreateAction
Creating Collection :
wt=javabin&version=2&numShards=2&router.field=myOwnField&name=solrj_collection&action=CREATE&collection.configName=conf1&replicationFactor=2
[junit4] 2> 3291334 T15502 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/collection-queue-work state:
SyncConnected type NodeChildrenChanged
[junit4] 2> 3291335 T15495 oasc.OverseerCollectionProcessor.run Overseer
Collection Processor: Get the message
id:/overseer/collection-queue-work/qn-0000000000 message:{
[junit4] 2> "operation":"create",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"solrj_collection",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"conf1",
[junit4] 2> "numShards":"2",
[junit4] 2> "router.field":"myOwnField"}
[junit4] 2> 3291337 T15565 oasc.OverseerCollectionProcessor.processMessage
WARN OverseerCollectionProcessor.processMessage : create , {
[junit4] 2> "operation":"create",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"solrj_collection",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"conf1",
[junit4] 2> "numShards":"2",
[junit4] 2> "router.field":"myOwnField"}
[junit4] 2> 3291339 T15565 oasc.OverseerCollectionProcessor.createConfNode
creating collections conf node /collections/solrj_collection
[junit4] 2> 3291340 T15565 oascc.SolrZkClient.makePath makePath:
/collections/solrj_collection
[junit4] 2> 3291344 T15502 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 3291348 T15494
oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection:
solrj_collection
[junit4] 2> 3291348 T15494
oasc.Overseer$ClusterStateUpdater.createCollection Create collection
solrj_collection with shards [shard1, shard2]
[junit4] 2> 3291349 T15494
oasc.Overseer$ClusterStateUpdater.createCollection state version
solrj_collection 1
[junit4] 2> 3291352 T15562 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3291352 T15517 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3291352 T15502 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3291352 T15547 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3291352 T15532 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3291353 T15503 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3291444 T15565
oasc.OverseerCollectionProcessor.createCollection Creating SolrCores for new
collection solrj_collection, shardNames [shard1, shard2] , replicationFactor : 2
[junit4] 2> 3291445 T15565
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard1_replica1 as part of slice shard1 of collection
solrj_collection on 127.0.0.1:46251_
[junit4] 2> 3291447 T15565
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard1_replica2 as part of slice shard1 of collection
solrj_collection on 127.0.0.1:46260_
[junit4] 2> 3291448 T15565
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard2_replica1 as part of slice shard2 of collection
solrj_collection on 127.0.0.1:46235_
[junit4] 2> 3291454 T15565
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard2_replica2 as part of slice shard2 of collection
solrj_collection on 127.0.0.1:46242_
[junit4] 2> 3291595 T15521 oasha.CoreAdminHandler.handleCreateAction core
create command
wt=javabin&version=2&numShards=2&name=solrj_collection_shard1_replica1&action=CREATE&shard=shard1&collection=solrj_collection&collection.configName=conf1&qt=/admin/cores
[junit4] 2> 3291597 T15536 oasha.CoreAdminHandler.handleCreateAction core
create command
wt=javabin&version=2&numShards=2&name=solrj_collection_shard1_replica2&action=CREATE&shard=shard1&collection=solrj_collection&collection.configName=conf1&qt=/admin/cores
[junit4] 2> 3291599 T15507 oasha.CoreAdminHandler.handleCreateAction core
create command
wt=javabin&version=2&numShards=2&name=solrj_collection_shard2_replica2&action=CREATE&shard=shard2&collection=solrj_collection&collection.configName=conf1&qt=/admin/cores
[junit4] 2> 3291601 T15484 oasha.CoreAdminHandler.handleCreateAction core
create command
wt=javabin&version=2&numShards=2&name=solrj_collection_shard2_replica1&action=CREATE&shard=shard2&collection=solrj_collection&collection.configName=conf1&qt=/admin/cores
[junit4] 2> 3291603 T15521 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica1 state=down collection=solrj_collection
[junit4] 2> 3291604 T15536 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica2 state=down collection=solrj_collection
[junit4] 2> 3291604 T15521 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 3291604 T15502 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 3291604 T15507 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica2 state=down collection=solrj_collection
[junit4] 2> 3291605 T15536 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 3291606 T15484 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica1 state=down collection=solrj_collection
[junit4] 2> 3291606 T15507 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 3291607 T15484 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 3291608 T15494 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "core":"solrj_collection_shard1_replica1",
[junit4] 2> "numShards":"2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:46251";,
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "node_name":"127.0.0.1:46251_",
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down"}
[junit4] 2> 3291611 T15494 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "core":"solrj_collection_shard1_replica2",
[junit4] 2> "numShards":"2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:46260";,
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "node_name":"127.0.0.1:46260_",
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down"}
[junit4] 2> 3291614 T15502 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 3291615 T15494 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "core":"solrj_collection_shard2_replica2",
[junit4] 2> "numShards":"2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:46242";,
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "shard":"shard2",
[junit4] 2> "node_name":"127.0.0.1:46242_",
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down"}
[junit4] 2> 3291618 T15494 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "core":"solrj_collection_shard2_replica1",
[junit4] 2> "numShards":"2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:46235";,
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "shard":"shard2",
[junit4] 2> "node_name":"127.0.0.1:46235_",
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down"}
[junit4] 2> 3291621 T15502 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 3291623 T15502 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3291623 T15517 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3291623 T15562 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3291623 T15532 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3291623 T15503 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3291623 T15547 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3292605 T15521 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for solrj_collection_shard1_replica1
[junit4] 2> 3292606 T15521 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 3292606 T15536 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for solrj_collection_shard1_replica2
[junit4] 2> 3292607 T15521 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 3292607 T15484 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for solrj_collection_shard2_replica1
[junit4] 2> 3292607 T15507 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for solrj_collection_shard2_replica2
[junit4] 2> 3292607 T15536 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 3292609 T15507 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 3292610 T15536 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 3292610 T15507 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 3292608 T15484 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 3292608 T15521 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 3292612 T15484 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 3292611 T15507 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 3292611 T15536 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 3292613 T15521 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 3292613 T15484 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 3292615 T15536 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 3292614 T15521 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-004/solrj_collection_shard1_replica1/'
[junit4] 2> 3292614 T15507 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 3292616 T15484 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 3292616 T15536 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-005/solrj_collection_shard1_replica2/'
[junit4] 2> 3292617 T15484 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-002/solrj_collection_shard2_replica1/'
[junit4] 2> 3292617 T15507 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-003/solrj_collection_shard2_replica2/'
[junit4] 2> 3293498 T15521 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 3293500 T15536 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 3293501 T15507 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 3293505 T15484 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 3293602 T15521 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 3293605 T15507 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 3293611 T15484 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 3293612 T15536 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 3293613 T15484 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 3293637 T15484 oass.IndexSchema.readSchema
[solrj_collection_shard2_replica1] Schema name=test
[junit4] 2> 3293706 T15521 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 3293708 T15507 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 3293715 T15536 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 3293731 T15521 oass.IndexSchema.readSchema
[solrj_collection_shard1_replica1] Schema name=test
[junit4] 2> 3293732 T15507 oass.IndexSchema.readSchema
[solrj_collection_shard2_replica2] Schema name=test
[junit4] 2> 3293739 T15536 oass.IndexSchema.readSchema
[solrj_collection_shard1_replica2] Schema name=test
[junit4] 2> 3294554 T15484 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3294592 T15484 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 3294598 T15484 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3294616 T15507 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3294623 T15484 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3294628 T15507 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 3294630 T15521 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3294631 T15484 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3294634 T15507 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3294642 T15484 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3294643 T15521 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 3294643 T15484
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3294646 T15484
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3294647 T15484 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3294648 T15536 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3294649 T15484
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3294649 T15484
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3294650 T15484 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard2_replica1' using configuration from collection
solrj_collection
[junit4] 2> 3294651 T15484 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3294651 T15484 oasc.SolrCore.<init>
[solrj_collection_shard2_replica1] Opening new SolrCore at
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-002/solrj_collection_shard2_replica1/,
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-002/solrj_collection_shard2_replica1/data/
[junit4] 2> 3294652 T15521 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3294652 T15484 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2e7dc31c
[junit4] 2> 3294666 T15507 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3294666 T15484 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-002/solrj_collection_shard2_replica1/data
[junit4] 2> 3294670 T15484 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-002/solrj_collection_shard2_replica1/data/index/
[junit4] 2> 3294671 T15484 oasc.SolrCore.initIndex WARN
[solrj_collection_shard2_replica1] Solr index directory
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-002/solrj_collection_shard2_replica1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 3294671 T15536 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 3294677 T15484 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-002/solrj_collection_shard2_replica1/data/index
[junit4] 2> 3294677 T15507 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3294678 T15484 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@2de4f8c3
[junit4] 2> 3294678 T15536 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3294683 T15521 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3294688 T15507 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3294691 T15507
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3294692 T15507
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3294692 T15507 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3294693 T15521 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3294695 T15507
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3294695 T15507
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3294696 T15507 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard2_replica2' using configuration from collection
solrj_collection
[junit4] 2> 3294696 T15507 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3294697 T15507 oasc.SolrCore.<init>
[solrj_collection_shard2_replica2] Opening new SolrCore at
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-003/solrj_collection_shard2_replica2/,
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-003/solrj_collection_shard2_replica2/data/
[junit4] 2> 3294698 T15507 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2e7dc31c
[junit4] 2> 3294706 T15507 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-003/solrj_collection_shard2_replica2/data
[junit4] 2> 3294707 T15521 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3294709 T15536 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3294709 T15507 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-003/solrj_collection_shard2_replica2/data/index/
[junit4] 2> 3294710 T15521
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3294710 T15507 oasc.SolrCore.initIndex WARN
[solrj_collection_shard2_replica2] Solr index directory
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-003/solrj_collection_shard2_replica2/data/index'
doesn't exist. Creating new index...
[junit4] 2> 3294711 T15521
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3294712 T15521 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3294713 T15521
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3294714 T15521
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3294714 T15521 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard1_replica1' using configuration from collection
solrj_collection
[junit4] 2> 3294715 T15521 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3294715 T15507 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-003/solrj_collection_shard2_replica2/data/index
[junit4] 2> 3294716 T15521 oasc.SolrCore.<init>
[solrj_collection_shard1_replica1] Opening new SolrCore at
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-004/solrj_collection_shard1_replica1/,
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-004/solrj_collection_shard1_replica1/data/
[junit4] 2> 3294716 T15507 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@3d84a2d7
[junit4] 2> 3294717 T15521 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2e7dc31c
[junit4] 2> 3294718 T15536 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3294727 T15521 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-004/solrj_collection_shard1_replica1/data
[junit4] 2> 3294727 T15484 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(MMapDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/index-MMapDirectory-001
lockFactory=NativeFSLockFactory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/index-MMapDirectory-001),segFN=segments_1,generation=1}
[junit4] 2> 3294728 T15484 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 3294729 T15521 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-004/solrj_collection_shard1_replica1/data/index/
[junit4] 2> 3294729 T15521 oasc.SolrCore.initIndex WARN
[solrj_collection_shard1_replica1] Solr index directory
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-004/solrj_collection_shard1_replica1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 3294730 T15536 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3294731 T15536
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3294731 T15536
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3294731 T15536 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3294732 T15521 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-004/solrj_collection_shard1_replica1/data/index
[junit4] 2> 3294733 T15536
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3294733 T15521 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@481fa21
[junit4] 2> 3294733 T15536
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3294734 T15536 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard1_replica2' using configuration from collection
solrj_collection
[junit4] 2> 3294735 T15536 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3294735 T15536 oasc.SolrCore.<init>
[solrj_collection_shard1_replica2] Opening new SolrCore at
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-005/solrj_collection_shard1_replica2/,
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-005/solrj_collection_shard1_replica2/data/
[junit4] 2> 3294736 T15536 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2e7dc31c
[junit4] 2> 3294737 T15484 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 3294737 T15484 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 3294738 T15484 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe"
[junit4] 2> 3294739 T15484 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 3294739 T15484 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"stored_sig"
[junit4] 2> 3294739 T15536 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-005/solrj_collection_shard1_replica2/data
[junit4] 2> 3294740 T15484 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3294741 T15484 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3294741 T15536 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-005/solrj_collection_shard1_replica2/data/index/
[junit4] 2> 3294741 T15484 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 3294742 T15536 oasc.SolrCore.initIndex WARN
[solrj_collection_shard1_replica2] Solr index directory
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-005/solrj_collection_shard1_replica2/data/index'
doesn't exist. Creating new index...
[junit4] 2> 3294742 T15484 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3294744 T15484 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3294744 T15484 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3294745 T15484 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3294745 T15536 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001/tempDir-005/solrj_collection_shard1_replica2/data/index
[junit4] 2> 3294746 T15484 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 3294746 T15536 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@2b40a90f
[junit4] 2> 3294747 T15484 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 3294747 T15484 oasc.RequestHandlers.initHandlersFromConfig
adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 3294748 T15484 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 3294749 T15484 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 3294749 T15484 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 3294750 T15484 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 3294751 T15484 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 3294765 T15507 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(MMapDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistribut
[...truncated too long message...]
ava:1419)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:137)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:455)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:229)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
[junit4] 2> at
org.eclipse.jetty.server.handler.GzipHandler.handle(GzipHandler.java:301)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1077)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:384)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1009)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
[junit4] 2> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
[junit4] 2> at
org.eclipse.jetty.server.Server.handle(Server.java:368)
[junit4] 2> at
org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:489)
[junit4] 2> at
org.eclipse.jetty.server.BlockingHttpConnection.handleRequest(BlockingHttpConnection.java:53)
[junit4] 2> at
org.eclipse.jetty.server.AbstractHttpConnection.content(AbstractHttpConnection.java:953)
[junit4] 2> at
org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.content(AbstractHttpConnection.java:1014)
[junit4] 2> at
org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:861)
[junit4] 2> at
org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:240)
[junit4] 2> at
org.eclipse.jetty.server.BlockingHttpConnection.handle(BlockingHttpConnection.java:72)
[junit4] 2> at
org.eclipse.jetty.server.bio.SocketConnector$ConnectorEndPoint.run(SocketConnector.java:264)
[junit4] 2> at
org.eclipse.jetty.server.ssl.SslSocketConnector$SslConnectorEndPoint.run(SslSocketConnector.java:670)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> Caused by: org.apache.solr.common.SolrException: No
registered leader was found after waiting for 1560000ms , collection:
awholynewstresscollection_collection1_2 slice: shard2
[junit4] 2> at
org.apache.solr.common.cloud.ZkStateReader.getLeaderRetry(ZkStateReader.java:642)
[junit4] 2> at
org.apache.solr.common.cloud.ZkStateReader.getLeaderUrl(ZkStateReader.java:616)
[junit4] 2> at
org.apache.solr.cloud.ZkController.getLeader(ZkController.java:903)
[junit4] 2> ... 40 more
[junit4] 2>
[junit4] 2> 4143308 T16344 oass.SolrDispatchFilter.handleAdminRequest
[admin] webapp=null path=/admin/cores
params={wt=javabin&version=2&numShards=3&name=awholynewstresscollection_collection1_2_shard2_replica3&action=CREATE&shard=shard2&collection=awholynewstresscollection_collection1_2&collection.configName=conf1&qt=/admin/cores}
status=0 QTime=755507
[junit4] 2> 4144770 T17326 oascc.ZkStateReader$3.process WARN ZooKeeper
watch triggered, but Solr cannot talk to ZK
[junit4] 2> 4144772 T15465 oejsh.ContextHandler.doStop stopped
o.e.j.s.ServletContextHandler{/,null}
[junit4] 2> 4149492 T15465 oas.SolrTestCaseJ4.tearDown ###Ending
testDistribSearch
[junit4] 2> 4149495 T15465 oasc.ZkTestServer.send4LetterWord connecting to
127.0.0.1:46225 46225
[junit4] 2> 4149840 T15891 oasc.ZkTestServer.send4LetterWord connecting to
127.0.0.1:46225 46225
[junit4] 2> NOTE: download the large Jenkins line-docs file by running
'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=CollectionsAPIDistributedZkTest -Dtests.method=testDistribSearch
-Dtests.seed=5799FE829ADA6E0D -Dtests.multiplier=2 -Dtests.nightly=true
-Dtests.slow=true
-Dtests.linedocsfile=/home/jenkins/lucene-data/enwiki.random.lines.txt
-Dtests.locale=ar_OM -Dtests.timezone=US/Samoa -Dtests.file.encoding=US-ASCII
[junit4] ERROR 885s J3 |
CollectionsAPIDistributedZkTest.testDistribSearch <<<
[junit4] > Throwable #1:
org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Error
CREATEing SolrCore 'halfcollection_shard1_replica1': Unable to create core
[halfcollection_shard1_replica1] Caused by: Could not get shard id for core:
halfcollection_shard1_replica1
[junit4] > at
__randomizedtesting.SeedInfo.seed([5799FE829ADA6E0D:D67F709AED850E31]:0)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:570)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:215)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:211)
[junit4] > at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testErrorHandling(CollectionsAPIDistributedZkTest.java:583)
[junit4] > at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.doTest(CollectionsAPIDistributedZkTest.java:205)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 4149858 T15465 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-5799FE829ADA6E0D-001
[junit4] 2> 884538 T15464 ccr.ThreadLeakControl.checkThreadLeaks WARNING
Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50):
{intDefault=PostingsFormat(name=Memory doPackFST= false),
multiDefault=PostingsFormat(name=Asserting),
id=PostingsFormat(name=Lucene41WithOrds), timestamp=PostingsFormat(name=Memory
doPackFST= false), other_tl1=PostingsFormat(name=Memory doPackFST= false),
_version_=PostingsFormat(name=Memory doPackFST= false),
a_i1=PostingsFormat(name=Memory doPackFST= false),
range_facet_l=PostingsFormat(name=Memory doPackFST= false),
text=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene41(blocksize=128))),
a_t=PostingsFormat(name=Memory doPackFST= false)},
docValues:{timestamp=DocValuesFormat(name=Asserting)}, sim=DefaultSimilarity,
locale=ar_OM, timezone=US/Samoa
[junit4] 2> NOTE: FreeBSD 9.1-RELEASE-p3 amd64/Oracle Corporation 1.7.0_65
(64-bit)/cpus=16,threads=1,free=153524912,total=479199232
[junit4] 2> NOTE: All tests run in this JVM: [DOMUtilTest,
DocValuesMultiTest, HdfsRecoveryZkTest, TestDynamicFieldResource,
TestMergePolicyConfig, LeaderFailoverAfterPartitionTest, RollingRestartTest,
TimeZoneUtilsTest, TestConfigSets, TestReRankQParserPlugin, CursorMarkTest,
TestCSVResponseWriter, TestLMJelinekMercerSimilarityFactory,
CoreContainerCoreInitFailuresTest, LeaderElectionTest, TestDistributedGrouping,
OutputWriterTest, ResponseLogComponentTest, TestPhraseSuggestions,
SliceStateTest, WordBreakSolrSpellCheckerTest, TestFastWriter,
SearchHandlerTest, TestDocSet, SolrIndexSplitterTest,
IndexBasedSpellCheckerTest, OverriddenZkACLAndCredentialsProvidersTest,
UUIDFieldTest, TestCloudManagedSchemaConcurrent,
TermVectorComponentDistributedTest, LoggingHandlerTest, ZkCLITest,
SSLMigrationTest, DeleteInactiveReplicaTest, TestModifyConfFiles,
HdfsDirectoryTest, TestSort, DistributedTermsComponentTest,
AsyncMigrateRouteKeyTest, InfoHandlerTest, SolrTestCaseJ4Test,
DocumentAnalysisRequestHandlerTest, SpellPossibilityIteratorTest,
HdfsLockFactoryTest, SOLR749Test, DocExpirationUpdateProcessorFactoryTest,
BadIndexSchemaTest, TestImplicitCoreProperties, RequestHandlersTest,
CollectionsAPIDistributedZkTest]
[junit4] Completed on J3 in 885.34s, 1 test, 1 error <<< FAILURES!
[...truncated 22 lines...]
BUILD FAILED
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:531:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:472:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:61:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/extra-targets.xml:39:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build.xml:189:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/common-build.xml:496:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:1360:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:962:
There were test failures: 436 suites, 1784 tests, 1 error, 54 ignored (10
assumptions)
Total time: 189 minutes 31 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-NightlyTests-5.x #638
Archived 5 artifacts
Archive block size is 32768
Received 0 blocks and 465925290 bytes
Compression is 0.0%
Took 1 min 20 sec
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
