Build: https://builds.apache.org/job/Lucene-Solr-Tests-5.x-Java7/2959/

1 tests failed.
REGRESSION:  org.apache.solr.cloud.OverseerRolesTest.test

Error Message:
KeeperErrorCode = Session expired for /live_nodes

Stack Trace:
org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = 
Session expired for /live_nodes
        at 
__randomizedtesting.SeedInfo.seed([27C370908FCB708A:AF974F4A21371D72]:0)
        at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
        at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
        at org.apache.zookeeper.ZooKeeper.getChildren(ZooKeeper.java:1472)
        at 
org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:328)
        at 
org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:325)
        at 
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:61)
        at 
org.apache.solr.common.cloud.SolrZkClient.getChildren(SolrZkClient.java:325)
        at 
org.apache.solr.common.cloud.ZkStateReader.updateClusterState(ZkStateReader.java:517)
        at 
org.apache.solr.common.cloud.ZkStateReader.updateClusterState(ZkStateReader.java:255)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:146)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:133)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:128)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:877)
        at 
org.apache.solr.cloud.OverseerRolesTest.testOverseerRole(OverseerRolesTest.java:129)
        at 
org.apache.solr.cloud.OverseerRolesTest.test(OverseerRolesTest.java:90)
        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:1627)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:960)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:935)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        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:845)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 9492 lines...]
   [junit4] Suite: org.apache.solr.cloud.OverseerRolesTest
   [junit4]   2> Creating dataDir: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/init-core-data-001
   [junit4]   2> 308779 T949 oas.BaseDistributedSearchTestCase.initHostContext 
Setting hostContext system property: /x_rmd/
   [junit4]   2> 308786 T949 oasc.ZkTestServer.run STARTING ZK TEST SERVER
   [junit4]   2> 308786 T950 oasc.ZkTestServer$2$1.setClientPort client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 308787 T950 oasc.ZkTestServer$ZKServerMain.runFromConfig 
Starting server
   [junit4]   2> 308886 T949 oasc.ZkTestServer.run start zk server on port:11370
   [junit4]   2> 308887 T949 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 308888 T949 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 308893 T957 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@7b04f29e 
name:ZooKeeperConnection Watcher:127.0.0.1:11370 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 308893 T949 oascc.ConnectionManager.waitForConnected Client is 
connected to ZooKeeper
   [junit4]   2> 308894 T949 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 308894 T949 oascc.SolrZkClient.makePath makePath: /solr
   [junit4]   2> 308898 T949 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 308898 T949 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 308900 T960 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@20b0175b 
name:ZooKeeperConnection Watcher:127.0.0.1:11370/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 308900 T949 oascc.ConnectionManager.waitForConnected Client is 
connected to ZooKeeper
   [junit4]   2> 308900 T949 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 308901 T949 oascc.SolrZkClient.makePath makePath: 
/collections/collection1
   [junit4]   2> 308905 T949 oascc.SolrZkClient.makePath makePath: 
/collections/collection1/shards
   [junit4]   2> 308907 T949 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection
   [junit4]   2> 308908 T949 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection/shards
   [junit4]   2> 308910 T949 oasc.AbstractZkTestCase.putConfig put 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 308911 T949 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/solrconfig.xml
   [junit4]   2> 308914 T949 oasc.AbstractZkTestCase.putConfig put 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 308914 T949 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/schema.xml
   [junit4]   2> 309017 T949 oasc.AbstractZkTestCase.putConfig put 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 309018 T949 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 309019 T949 oasc.AbstractZkTestCase.putConfig put 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 309019 T949 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/stopwords.txt
   [junit4]   2> 309021 T949 oasc.AbstractZkTestCase.putConfig put 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 309022 T949 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/protwords.txt
   [junit4]   2> 309023 T949 oasc.AbstractZkTestCase.putConfig put 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 309024 T949 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/currency.xml
   [junit4]   2> 309025 T949 oasc.AbstractZkTestCase.putConfig put 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 309025 T949 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/enumsConfig.xml
   [junit4]   2> 309027 T949 oasc.AbstractZkTestCase.putConfig put 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 309027 T949 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/open-exchange-rates.json
   [junit4]   2> 309028 T949 oasc.AbstractZkTestCase.putConfig put 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 309029 T949 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 309030 T949 oasc.AbstractZkTestCase.putConfig put 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 309031 T949 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/old_synonyms.txt
   [junit4]   2> 309032 T949 oasc.AbstractZkTestCase.putConfig put 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 309032 T949 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/synonyms.txt
   [junit4]   2> 310400 T949 oas.SolrTestCaseJ4.writeCoreProperties Writing 
core.properties file to 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/control-001/cores/collection1
   [junit4]   2> 310403 T949 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 310406 T949 oejs.AbstractConnector.doStart Started 
[email protected]:11377
   [junit4]   2> 310406 T949 oascse.JettySolrRunner$1.lifeCycleStarted Jetty 
properties: 
{solr.data.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/tempDir-001/control/data, hostContext=/x_rmd, 
hostPort=11377, 
coreRootDirectory=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/control-001/cores}
   [junit4]   2> 310407 T949 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@1e66a917
   [junit4]   2> 310408 T949 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/control-001/'
   [junit4]   2> 310452 T949 oasc.SolrXmlConfig.fromFile Loading container 
configuration from 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/control-001/solr.xml
   [junit4]   2> 310503 T949 oasc.CorePropertiesLocator.<init> Config-defined 
core root directory: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/control-001/cores
   [junit4]   2> 310503 T949 oasc.CoreContainer.<init> New CoreContainer 
1484607939
   [junit4]   2> 310503 T949 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/control-001/]
   [junit4]   2> 310504 T949 oasc.CoreContainer.load loading shared library: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/control-001/lib
   [junit4]   2> 310505 T949 oasc.SolrResourceLoader.addToClassLoader WARN 
Can't find (or read) directory to add to classloader: lib (resolved as: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/control-001/lib).
   [junit4]   2> 310517 T949 oashc.HttpShardHandlerFactory.init created with 
socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 
20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 
2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : 
false,useRetries : false,
   [junit4]   2> 310524 T949 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 310525 T949 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 310525 T949 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 310525 T949 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 310525 T949 oasc.ZkContainer.initZooKeeper Zookeeper 
client=127.0.0.1:11370/solr
   [junit4]   2> 310526 T949 oasc.ZkController.checkChrootPath zkHost includes 
chroot
   [junit4]   2> 310526 T949 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 310527 T949 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 310530 T972 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@4eb5916 name:ZooKeeperConnection 
Watcher:127.0.0.1:11370 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 310531 T949 oascc.ConnectionManager.waitForConnected Client is 
connected to ZooKeeper
   [junit4]   2> 310532 T949 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 310534 T949 N:127.0.0.1:11377_x_rmd 
oascc.ConnectionManager.waitForConnected Waiting for client to connect to 
ZooKeeper
   [junit4]   2> 310536 T975 N:127.0.0.1:11377_x_rmd 
oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@14e87f3c 
name:ZooKeeperConnection Watcher:127.0.0.1:11370/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 310537 T949 N:127.0.0.1:11377_x_rmd 
oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 310540 T949 N:127.0.0.1:11377_x_rmd 
oascc.SolrZkClient.makePath makePath: /overseer/queue
   [junit4]   2> 310542 T949 N:127.0.0.1:11377_x_rmd 
oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work
   [junit4]   2> 310545 T949 N:127.0.0.1:11377_x_rmd 
oascc.SolrZkClient.makePath makePath: /overseer/collection-map-running
   [junit4]   2> 310547 T949 N:127.0.0.1:11377_x_rmd 
oascc.SolrZkClient.makePath makePath: /overseer/collection-map-completed
   [junit4]   2> 310550 T949 N:127.0.0.1:11377_x_rmd 
oascc.SolrZkClient.makePath makePath: /overseer/collection-map-failure
   [junit4]   2> 310552 T949 N:127.0.0.1:11377_x_rmd 
oascc.SolrZkClient.makePath makePath: /live_nodes
   [junit4]   2> 310554 T949 N:127.0.0.1:11377_x_rmd 
oascc.SolrZkClient.makePath makePath: /aliases.json
   [junit4]   2> 310556 T949 N:127.0.0.1:11377_x_rmd 
oascc.SolrZkClient.makePath makePath: /clusterstate.json
   [junit4]   2> 310557 T949 N:127.0.0.1:11377_x_rmd 
oasc.ZkController.createEphemeralLiveNode Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:11377_x_rmd
   [junit4]   2> 310558 T949 N:127.0.0.1:11377_x_rmd 
oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:11377_x_rmd
   [junit4]   2> 310560 T949 N:127.0.0.1:11377_x_rmd 
oascc.SolrZkClient.makePath makePath: /overseer_elect
   [junit4]   2> 310562 T949 N:127.0.0.1:11377_x_rmd 
oascc.SolrZkClient.makePath makePath: /overseer_elect/election
   [junit4]   2> 310563 T949 N:127.0.0.1:11377_x_rmd oasc.Overseer.close 
Overseer (id=null) closing
   [junit4]   2> 310565 T949 N:127.0.0.1:11377_x_rmd 
oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 
127.0.0.1:11377_x_rmd
   [junit4]   2> 310566 T949 N:127.0.0.1:11377_x_rmd 
oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
   [junit4]   2> 310568 T949 N:127.0.0.1:11377_x_rmd oasc.Overseer.start 
Overseer (id=93665190338822147-127.0.0.1:11377_x_rmd-n_0000000000) starting
   [junit4]   2> 310570 T949 N:127.0.0.1:11377_x_rmd 
oascc.SolrZkClient.makePath makePath: /overseer/queue-work
   [junit4]   2> 310577 T949 N:127.0.0.1:11377_x_rmd 
oasc.OverseerAutoReplicaFailoverThread.<init> Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=10000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 310577 T977 N:127.0.0.1:11377_x_rmd 
oasc.OverseerCollectionProcessor.run Process current queue of collection 
creations
   [junit4]   2> 310577 T949 N:127.0.0.1:11377_x_rmd 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 310578 T976 N:127.0.0.1:11377_x_rmd 
oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
   [junit4]   2> 310583 T949 N:127.0.0.1:11377_x_rmd 
oasc.CorePropertiesLocator.discover Looking for core definitions underneath 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/control-001/cores
   [junit4]   2> 310587 T949 N:127.0.0.1:11377_x_rmd oasc.CoreDescriptor.<init> 
CORE DESCRIPTOR: {collection=control_collection, name=collection1, 
dataDir=data/, 
instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/control-001/cores/collection1, transient=false, 
schema=schema.xml, loadOnStartup=true, config=solrconfig.xml, 
absoluteInstDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/control-001/cores/collection1/, shard=, coreNodeName=}
   [junit4]   2> 310587 T949 N:127.0.0.1:11377_x_rmd 
oasc.CorePropertiesLocator.discoverUnder Found core collection1 in 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/control-001/cores/collection1/
   [junit4]   2> 310588 T949 N:127.0.0.1:11377_x_rmd 
oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 310590 T979 N:127.0.0.1:11377_x_rmd C:control_collection 
c:collection1 oasc.ZkController.publish publishing core=collection1 state=down 
collection=control_collection
   [junit4]   2> 310590 T979 N:127.0.0.1:11377_x_rmd C:control_collection 
c:collection1 oasc.ZkController.publish numShards not found on descriptor - 
reading it from system property
   [junit4]   2> 310591 T979 N:127.0.0.1:11377_x_rmd 
oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 310591 T975 N:127.0.0.1:11377_x_rmd 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 310592 T976 N:127.0.0.1:11377_x_rmd 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "state":"down",
   [junit4]   2>          "numShards":"1",
   [junit4]   2>          "shard":null,
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "base_url":"http://127.0.0.1:11377/x_rmd";,
   [junit4]   2>          "node_name":"127.0.0.1:11377_x_rmd"} current state 
version: 0
   [junit4]   2> 310593 T976 N:127.0.0.1:11377_x_rmd 
oasco.ReplicaMutator.updateState Update state numShards=1 message={
   [junit4]   2>          "state":"down",
   [junit4]   2>          "numShards":"1",
   [junit4]   2>          "shard":null,
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "base_url":"http://127.0.0.1:11377/x_rmd";,
   [junit4]   2>          "node_name":"127.0.0.1:11377_x_rmd"}
   [junit4]   2> 310593 T976 N:127.0.0.1:11377_x_rmd 
oasco.ClusterStateMutator.createCollection building a new cName: 
control_collection
   [junit4]   2> 310593 T976 N:127.0.0.1:11377_x_rmd 
oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard1
   [junit4]   2> 310594 T975 N:127.0.0.1:11377_x_rmd 
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> 311591 T979 N:127.0.0.1:11377_x_rmd 
oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for 
collection1
   [junit4]   2> 311592 T979 N:127.0.0.1:11377_x_rmd 
oasc.ZkController.createCollectionZkNode Check for collection 
zkNode:control_collection
   [junit4]   2> 311593 T979 N:127.0.0.1:11377_x_rmd 
oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 311593 T979 N:127.0.0.1:11377_x_rmd 
oascc.ZkStateReader.readConfigName Load collection config 
from:/collections/control_collection
   [junit4]   2> 311594 T979 N:127.0.0.1:11377_x_rmd 
oascc.ZkStateReader.readConfigName path=/collections/control_collection 
configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 311594 T979 N:127.0.0.1:11377_x_rmd 
oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/control-001/cores/collection1/'
   [junit4]   2> 311614 T979 N:127.0.0.1:11377_x_rmd 
oasc.ZkController.watchZKConfDir watch zkdir /configs/conf1
   [junit4]   2> 311617 T979 N:127.0.0.1:11377_x_rmd oasc.Config.<init> loaded 
config solrconfig.xml with version 0 
   [junit4]   2> 311629 T979 N:127.0.0.1:11377_x_rmd 
oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 311652 T979 N:127.0.0.1:11377_x_rmd oasc.SolrConfig.<init> 
Using Lucene MatchVersion: 5.2.0
   [junit4]   2> 311703 T979 N:127.0.0.1:11377_x_rmd oasc.SolrConfig.<init> 
Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 311804 T979 N:127.0.0.1:11377_x_rmd 
oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
   [junit4]   2> 311815 T979 N:127.0.0.1:11377_x_rmd 
oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 312240 T979 N:127.0.0.1:11377_x_rmd 
oass.OpenExchangeRatesOrgProvider.init Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 312257 T979 N:127.0.0.1:11377_x_rmd 
oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 312260 T979 N:127.0.0.1:11377_x_rmd 
oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 312272 T979 N:127.0.0.1:11377_x_rmd 
oass.FileExchangeRateProvider.reload Reloading exchange rates from file 
currency.xml
   [junit4]   2> 312277 T979 N:127.0.0.1:11377_x_rmd 
oass.FileExchangeRateProvider.reload Reloading exchange rates from file 
currency.xml
   [junit4]   2> 312282 T979 N:127.0.0.1:11377_x_rmd 
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 312282 T979 N:127.0.0.1:11377_x_rmd 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 312283 T979 N:127.0.0.1:11377_x_rmd 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 312283 T979 N:127.0.0.1:11377_x_rmd 
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 312284 T979 N:127.0.0.1:11377_x_rmd 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 312284 T979 N:127.0.0.1:11377_x_rmd 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 312284 T979 N:127.0.0.1:11377_x_rmd oasc.CoreContainer.create 
Creating SolrCore 'collection1' using configuration from collection 
control_collection
   [junit4]   2> 312284 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 312285 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasc.SolrCore.<init> [collection1] Opening new SolrCore at 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/control-001/cores/collection1/, 
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/control-001/cores/collection1/data/
   [junit4]   2> 312285 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to 
JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4caa1b37
   [junit4]   2> 312286 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasc.CachingDirectoryFactory.get return new directory for 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/control-001/cores/collection1/data
   [junit4]   2> 312286 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasc.SolrCore.getNewIndexDir New index directory detected: old=null 
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/control-001/cores/collection1/data/index/
   [junit4]   2> 312287 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasc.SolrCore.initIndex WARN [collection1] Solr index directory 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/control-001/cores/collection1/data/index' doesn't exist. 
Creating new index...
   [junit4]   2> 312287 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasc.CachingDirectoryFactory.get return new directory for 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/control-001/cores/collection1/data/index
   [junit4]   2> 312288 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.36215582828012904]
   [junit4]   2> 312289 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@34236216 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7efcad17),segFN=segments_1,generation=1}
   [junit4]   2> 312289 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 312296 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"nodistrib"
   [junit4]   2> 312296 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 312296 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 312297 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 312297 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 312297 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"distrib-dup-test-chain-explicit"
   [junit4]   2> 312298 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 312298 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 312298 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined 
as default, creating implicit default
   [junit4]   2> 312322 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 312325 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 312327 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 312329 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 312335 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasc.RequestHandlers.initHandlersFromConfig Registered paths: 
/update/json,/update/csv,/admin/threads,/admin/plugins,standard,/admin/properties,/config,/get,/replication,/admin/luke,/update/json/docs,/admin/segments,/admin/file,/admin/mbeans,/schema,/admin/ping,/admin/logging,/admin/system,/update
   [junit4]   2> 312337 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasc.SolrCore.initStatsCache Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 312339 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasu.UpdateHandler.<init> Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 312340 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10
   [junit4]   2> 312342 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 312342 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 312343 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=38, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.45179975226088087]
   [junit4]   2> 312343 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@34236216 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7efcad17),segFN=segments_1,generation=1}
   [junit4]   2> 312344 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 312344 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oass.SolrIndexSearcher.<init> Opening Searcher@4e44a078[collection1] main
   [junit4]   2> 312344 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oascc.ZkStateReader.readConfigName Load collection config 
from:/collections/control_collection
   [junit4]   2> 312345 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oascc.ZkStateReader.readConfigName path=/collections/control_collection 
configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 312346 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for 
the RestManager with znodeBase: /configs/conf1
   [junit4]   2> 312346 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured 
ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 312346 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasr.RestManager.init Initializing RestManager with initArgs: {}
   [junit4]   2> 312347 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasr.ManagedResourceStorage.load Reading _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 312347 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found 
for znode /configs/conf1/_rest_managed.json
   [junit4]   2> 312348 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 312348 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 312348 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 312349 T979 N:127.0.0.1:11377_x_rmd c:collection1 
oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 312349 T980 N:127.0.0.1:11377_x_rmd c:collection1 
oasc.SolrCore.registerSearcher [collection1] Registered new searcher 
Searcher@4e44a078[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 312350 T983 N:127.0.0.1:11377_x_rmd C:control_collection 
S:shard1 c:collection1 oasc.ZkController.register Register replica - 
core:collection1 address:http://127.0.0.1:11377/x_rmd 
collection:control_collection shard:shard1
   [junit4]   2> 312350 T949 N:127.0.0.1:11377_x_rmd 
oass.SolrDispatchFilter.init 
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0
   [junit4]   2> 312351 T949 N:127.0.0.1:11377_x_rmd 
oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 312352 T983 N:127.0.0.1:11377_x_rmd C:control_collection 
S:shard1 c:collection1 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection/leader_elect/shard1/election
   [junit4]   2> 312354 T949 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 312354 T949 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 312356 T986 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@8122a60 name:ZooKeeperConnection 
Watcher:127.0.0.1:11370/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 312357 T949 oascc.ConnectionManager.waitForConnected Client is 
connected to ZooKeeper
   [junit4]   2> 312357 T949 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 312358 T949 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 312360 T983 N:127.0.0.1:11377_x_rmd C:control_collection 
S:shard1 c:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess Running 
the leader process for shard shard1
   [junit4]   2> 312362 T975 N:127.0.0.1:11377_x_rmd 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 312362 T949 oasc.ChaosMonkey.monkeyLog monkey: init - expire 
sessions:false cause connection loss:false
   [junit4]   2> 312363 T983 N:127.0.0.1:11377_x_rmd C:control_collection 
S:shard1 c:collection1 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp 
Enough replicas found to continue.
   [junit4]   2> 312364 T976 N:127.0.0.1:11377_x_rmd 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "operation":"leader",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"control_collection"} current state 
version: 1
   [junit4]   2> 312364 T983 N:127.0.0.1:11377_x_rmd C:control_collection 
S:shard1 c:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I may 
be the new leader - try and sync
   [junit4]   2> ASYNC  NEW_CORE C277 name=collection1 
org.apache.solr.core.SolrCore@620a8105 
url=http://127.0.0.1:11377/x_rmd/collection1 node=127.0.0.1:11377_x_rmd 
C277_STATE=coll:control_collection core:collection1 props:{state=down, 
core=collection1, base_url=http://127.0.0.1:11377/x_rmd, 
node_name=127.0.0.1:11377_x_rmd}
   [junit4]   2> 312364 T983 N:127.0.0.1:11377_x_rmd C:control_collection 
S:shard1 c:collection1 C277 oasc.SyncStrategy.sync Sync replicas to 
http://127.0.0.1:11377/x_rmd/collection1/
   [junit4]   2> 312365 T983 N:127.0.0.1:11377_x_rmd C:control_collection 
S:shard1 c:collection1 C277 oasc.SyncStrategy.syncReplicas Sync Success - now 
sync replicas to me
   [junit4]   2> 312365 T983 N:127.0.0.1:11377_x_rmd C:control_collection 
S:shard1 c:collection1 C277 oasc.SyncStrategy.syncToMe 
http://127.0.0.1:11377/x_rmd/collection1/ has no replicas
   [junit4]   2> 312365 T983 N:127.0.0.1:11377_x_rmd C:control_collection 
S:shard1 c:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I am 
the new leader: http://127.0.0.1:11377/x_rmd/collection1/ shard1
   [junit4]   2> 312366 T975 N:127.0.0.1:11377_x_rmd 
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> 312366 T986 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> 312366 T983 N:127.0.0.1:11377_x_rmd C:control_collection 
S:shard1 c:collection1 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection/leaders/shard1
   [junit4]   2> 312372 T975 N:127.0.0.1:11377_x_rmd 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 312373 T976 N:127.0.0.1:11377_x_rmd 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "operation":"leader",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "base_url":"http://127.0.0.1:11377/x_rmd";,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "state":"active"} current state version: 2
   [junit4]   2> 312477 T986 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> 312478 T975 N:127.0.0.1:11377_x_rmd 
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> 312525 T983 N:127.0.0.1:11377_x_rmd C:control_collection 
S:shard1 c:collection1 oasc.ZkController.register We are 
http://127.0.0.1:11377/x_rmd/collection1/ and leader is 
http://127.0.0.1:11377/x_rmd/collection1/
   [junit4]   2> 312526 T983 N:127.0.0.1:11377_x_rmd C:control_collection 
S:shard1 c:collection1 oasc.ZkController.register No LogReplay needed for 
core=collection1 baseURL=http://127.0.0.1:11377/x_rmd
   [junit4]   2> 312526 T983 N:127.0.0.1:11377_x_rmd C:control_collection 
S:shard1 c:collection1 oasc.ZkController.checkRecovery I am the leader, no 
recovery necessary
   [junit4]   2> 312527 T983 N:127.0.0.1:11377_x_rmd C:control_collection 
S:shard1 c:collection1 oasc.ZkController.publish publishing core=collection1 
state=active collection=control_collection
   [junit4]   2> 312527 T983 N:127.0.0.1:11377_x_rmd C:control_collection 
S:shard1 c:collection1 oasc.ZkController.publish numShards not found on 
descriptor - reading it from system property
   [junit4]   2> 312529 T975 N:127.0.0.1:11377_x_rmd 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 312530 T976 N:127.0.0.1:11377_x_rmd 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "state":"active",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "base_url":"http://127.0.0.1:11377/x_rmd";,
   [junit4]   2>          "node_name":"127.0.0.1:11377_x_rmd"} current state 
version: 3
   [junit4]   2> 312531 T976 N:127.0.0.1:11377_x_rmd 
oasco.ReplicaMutator.updateState Update state numShards=2 message={
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "state":"active",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "base_url":"http://127.0.0.1:11377/x_rmd";,
   [junit4]   2>          "node_name":"127.0.0.1:11377_x_rmd"}
   [junit4]   2> 312634 T986 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> 312634 T975 N:127.0.0.1:11377_x_rmd 
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> 313559 T949 oas.SolrTestCaseJ4.writeCoreProperties Writing 
core.properties file to 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001/cores/collection1
   [junit4]   2> 313561 T949 oasc.AbstractFullDistribZkTestBase.createJettys 
create jetty 1 in directory 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001
   [junit4]   2> 313562 T949 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 313564 T949 oejs.AbstractConnector.doStart Started 
[email protected]:11383
   [junit4]   2> 313565 T949 oascse.JettySolrRunner$1.lifeCycleStarted Jetty 
properties: {solrconfig=solrconfig.xml, 
coreRootDirectory=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001/cores, hostPort=11383, 
solr.data.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/tempDir-001/jetty1, hostContext=/x_rmd}
   [junit4]   2> 313565 T949 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@1e66a917
   [junit4]   2> 313565 T949 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001/'
   [junit4]   2> 313598 T949 oasc.SolrXmlConfig.fromFile Loading container 
configuration from 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001/solr.xml
   [junit4]   2> 313640 T949 oasc.CorePropertiesLocator.<init> Config-defined 
core root directory: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001/cores
   [junit4]   2> 313640 T949 oasc.CoreContainer.<init> New CoreContainer 
533406697
   [junit4]   2> 313641 T949 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001/]
   [junit4]   2> 313641 T949 oasc.CoreContainer.load loading shared library: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001/lib
   [junit4]   2> 313642 T949 oasc.SolrResourceLoader.addToClassLoader WARN 
Can't find (or read) directory to add to classloader: lib (resolved as: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001/lib).
   [junit4]   2> 313654 T949 oashc.HttpShardHandlerFactory.init created with 
socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 
20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 
2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : 
false,useRetries : false,
   [junit4]   2> 313658 T949 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 313659 T949 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 313659 T949 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 313660 T949 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 313660 T949 oasc.ZkContainer.initZooKeeper Zookeeper 
client=127.0.0.1:11370/solr
   [junit4]   2> 313660 T949 oasc.ZkController.checkChrootPath zkHost includes 
chroot
   [junit4]   2> 313660 T949 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 313661 T949 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 313663 T998 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@695c3bd3 
name:ZooKeeperConnection Watcher:127.0.0.1:11370 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 313663 T949 oascc.ConnectionManager.waitForConnected Client is 
connected to ZooKeeper
   [junit4]   2> 313664 T949 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 313667 T949 N:127.0.0.1:11383_x_rmd 
oascc.ConnectionManager.waitForConnected Waiting for client to connect to 
ZooKeeper
   [junit4]   2> 313668 T1001 N:127.0.0.1:11383_x_rmd 
oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@4c63d1df 
name:ZooKeeperConnection Watcher:127.0.0.1:11370/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 313668 T949 N:127.0.0.1:11383_x_rmd 
oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 313673 T949 N:127.0.0.1:11383_x_rmd 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 314678 T949 N:127.0.0.1:11383_x_rmd 
oasc.ZkController.createEphemeralLiveNode Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:11383_x_rmd
   [junit4]   2> 314679 T949 N:127.0.0.1:11383_x_rmd 
oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:11383_x_rmd
   [junit4]   2> 314683 T949 N:127.0.0.1:11383_x_rmd oasc.Overseer.close 
Overseer (id=null) closing
   [junit4]   2> 314686 T949 N:127.0.0.1:11383_x_rmd 
oasc.CorePropertiesLocator.discover Looking for core definitions underneath 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001/cores
   [junit4]   2> 314690 T949 N:127.0.0.1:11383_x_rmd oasc.CoreDescriptor.<init> 
CORE DESCRIPTOR: {dataDir=data/, config=solrconfig.xml, 
absoluteInstDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001/cores/collection1/, loadOnStartup=true, 
instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001/cores/collection1, collection=collection1, 
name=collection1, shard=, schema=schema.xml, transient=false, coreNodeName=}
   [junit4]   2> 314690 T949 N:127.0.0.1:11383_x_rmd 
oasc.CorePropertiesLocator.discoverUnder Found core collection1 in 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001/cores/collection1/
   [junit4]   2> 314691 T949 N:127.0.0.1:11383_x_rmd 
oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 314693 T1002 N:127.0.0.1:11383_x_rmd C:collection1 
c:collection1 oasc.ZkController.publish publishing core=collection1 state=down 
collection=collection1
   [junit4]   2> 314693 T1002 N:127.0.0.1:11383_x_rmd C:collection1 
c:collection1 oasc.ZkController.publish numShards not found on descriptor - 
reading it from system property
   [junit4]   2> 314694 T1002 N:127.0.0.1:11383_x_rmd 
oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 314694 T975 N:127.0.0.1:11377_x_rmd 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 314695 T976 N:127.0.0.1:11377_x_rmd 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "state":"down",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "shard":null,
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "base_url":"http://127.0.0.1:11383/x_rmd";,
   [junit4]   2>          "node_name":"127.0.0.1:11383_x_rmd"} current state 
version: 4
   [junit4]   2> 314696 T976 N:127.0.0.1:11377_x_rmd 
oasco.ReplicaMutator.updateState Update state numShards=2 message={
   [junit4]   2>          "state":"down",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "shard":null,
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "base_url":"http://127.0.0.1:11383/x_rmd";,
   [junit4]   2>          "node_name":"127.0.0.1:11383_x_rmd"}
   [junit4]   2> 314696 T976 N:127.0.0.1:11377_x_rmd 
oasco.ClusterStateMutator.createCollection building a new cName: collection1
   [junit4]   2> 314697 T976 N:127.0.0.1:11377_x_rmd 
oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard1
   [junit4]   2> 314698 T986 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 314698 T975 N:127.0.0.1:11377_x_rmd 
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 314698 T1001 N:127.0.0.1:11383_x_rmd 
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 315694 T1002 N:127.0.0.1:11383_x_rmd 
oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for 
collection1
   [junit4]   2> 315695 T1002 N:127.0.0.1:11383_x_rmd 
oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
   [junit4]   2> 315696 T1002 N:127.0.0.1:11383_x_rmd 
oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 315696 T1002 N:127.0.0.1:11383_x_rmd 
oascc.ZkStateReader.readConfigName Load collection config 
from:/collections/collection1
   [junit4]   2> 315697 T1002 N:127.0.0.1:11383_x_rmd 
oascc.ZkStateReader.readConfigName path=/collections/collection1 
configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 315697 T1002 N:127.0.0.1:11383_x_rmd 
oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001/cores/collection1/'
   [junit4]   2> 315716 T1002 N:127.0.0.1:11383_x_rmd 
oasc.ZkController.watchZKConfDir watch zkdir /configs/conf1
   [junit4]   2> 315719 T1002 N:127.0.0.1:11383_x_rmd oasc.Config.<init> loaded 
config solrconfig.xml with version 0 
   [junit4]   2> 315732 T1002 N:127.0.0.1:11383_x_rmd 
oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 315755 T1002 N:127.0.0.1:11383_x_rmd oasc.SolrConfig.<init> 
Using Lucene MatchVersion: 5.2.0
   [junit4]   2> 315807 T1002 N:127.0.0.1:11383_x_rmd oasc.SolrConfig.<init> 
Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 315908 T1002 N:127.0.0.1:11383_x_rmd 
oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
   [junit4]   2> 315920 T1002 N:127.0.0.1:11383_x_rmd 
oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 316343 T1002 N:127.0.0.1:11383_x_rmd 
oass.OpenExchangeRatesOrgProvider.init Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 316362 T1002 N:127.0.0.1:11383_x_rmd 
oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 316377 T1002 N:127.0.0.1:11383_x_rmd 
oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 316390 T1002 N:127.0.0.1:11383_x_rmd 
oass.FileExchangeRateProvider.reload Reloading exchange rates from file 
currency.xml
   [junit4]   2> 316396 T1002 N:127.0.0.1:11383_x_rmd 
oass.FileExchangeRateProvider.reload Reloading exchange rates from file 
currency.xml
   [junit4]   2> 316402 T1002 N:127.0.0.1:11383_x_rmd 
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 316404 T1002 N:127.0.0.1:11383_x_rmd 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 316404 T1002 N:127.0.0.1:11383_x_rmd 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 316404 T1002 N:127.0.0.1:11383_x_rmd 
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 316406 T1002 N:127.0.0.1:11383_x_rmd 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 316406 T1002 N:127.0.0.1:11383_x_rmd 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 316406 T1002 N:127.0.0.1:11383_x_rmd oasc.CoreContainer.create 
Creating SolrCore 'collection1' using configuration from collection collection1
   [junit4]   2> 316407 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 316407 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasc.SolrCore.<init> [collection1] Opening new SolrCore at 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001/cores/collection1/, 
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001/cores/collection1/data/
   [junit4]   2> 316407 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to 
JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4caa1b37
   [junit4]   2> 316408 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasc.CachingDirectoryFactory.get return new directory for 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001/cores/collection1/data
   [junit4]   2> 316409 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasc.SolrCore.getNewIndexDir New index directory detected: old=null 
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001/cores/collection1/data/index/
   [junit4]   2> 316409 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasc.SolrCore.initIndex WARN [collection1] Solr index directory 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001/cores/collection1/data/index' doesn't exist. 
Creating new index...
   [junit4]   2> 316410 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasc.CachingDirectoryFactory.get return new directory for 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-1-001/cores/collection1/data/index
   [junit4]   2> 316410 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.36215582828012904]
   [junit4]   2> 316411 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@46b553a8 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2a875edc),segFN=segments_1,generation=1}
   [junit4]   2> 316411 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 316419 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"nodistrib"
   [junit4]   2> 316419 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 316420 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 316420 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 316420 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 316420 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"distrib-dup-test-chain-explicit"
   [junit4]   2> 316421 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 316421 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 316421 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined 
as default, creating implicit default
   [junit4]   2> 316442 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 316445 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 316448 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 316450 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 316459 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasc.RequestHandlers.initHandlersFromConfig Registered paths: 
/update/json,/update/csv,/admin/threads,/admin/plugins,standard,/admin/properties,/config,/get,/replication,/admin/luke,/update/json/docs,/admin/segments,/admin/file,/admin/mbeans,/schema,/admin/ping,/admin/logging,/admin/system,/update
   [junit4]   2> 316461 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasc.SolrCore.initStatsCache Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 316463 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasu.UpdateHandler.<init> Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 316463 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10
   [junit4]   2> 316465 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 316466 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 316467 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=38, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.45179975226088087]
   [junit4]   2> 316468 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@46b553a8 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2a875edc),segFN=segments_1,generation=1}
   [junit4]   2> 316468 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 316468 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oass.SolrIndexSearcher.<init> Opening Searcher@3fe74576[collection1] main
   [junit4]   2> 316469 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oascc.ZkStateReader.readConfigName Load collection config 
from:/collections/collection1
   [junit4]   2> 316470 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oascc.ZkStateReader.readConfigName path=/collections/collection1 
configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 316470 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for 
the RestManager with znodeBase: /configs/conf1
   [junit4]   2> 316470 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured 
ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 316471 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasr.RestManager.init Initializing RestManager with initArgs: {}
   [junit4]   2> 316471 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasr.ManagedResourceStorage.load Reading _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 316471 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found 
for znode /configs/conf1/_rest_managed.json
   [junit4]   2> 316472 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 316472 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 316472 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 316473 T1003 N:127.0.0.1:11383_x_rmd c:collection1 
oasc.SolrCore.registerSearcher [collection1] Registered new searcher 
Searcher@3fe74576[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 316474 T1002 N:127.0.0.1:11383_x_rmd c:collection1 
oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 316475 T1006 N:127.0.0.1:11383_x_rmd C:collection1 S:shard1 
c:collection1 oasc.ZkController.register Register replica - core:collection1 
address:http://127.0.0.1:11383/x_rmd collection:collection1 shard:shard1
   [junit4]   2> 316476 T949 N:127.0.0.1:11383_x_rmd 
oass.SolrDispatchFilter.init 
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0
   [junit4]   2> 316476 T949 N:127.0.0.1:11383_x_rmd 
oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 316476 T1006 N:127.0.0.1:11383_x_rmd C:collection1 S:shard1 
c:collection1 oascc.SolrZkClient.makePath makePath: 
/collections/collection1/leader_elect/shard1/election
   [junit4]   2> 316481 T1006 N:127.0.0.1:11383_x_rmd C:collection1 S:shard1 
c:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess Running the 
leader process for shard shard1
   [junit4]   2> 316483 T975 N:127.0.0.1:11377_x_rmd 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 316483 T1006 N:127.0.0.1:11383_x_rmd C:collection1 S:shard1 
c:collection1 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough 
replicas found to continue.
   [junit4]   2> 316484 T1006 N:127.0.0.1:11383_x_rmd C:collection1 S:shard1 
c:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new 
leader - try and sync
   [junit4]   2> ASYNC  NEW_CORE C278 name=collection1 
org.apache.solr.core.SolrCore@711d7a83 
url=http://127.0.0.1:11383/x_rmd/collection1 node=127.0.0.1:11383_x_rmd 
C278_STATE=coll:collection1 core:collection1 props:{state=down, 
core=collection1, base_url=http://127.0.0.1:11383/x_rmd, 
node_name=127.0.0.1:11383_x_rmd}
   [junit4]   2> 316484 T1006 N:127.0.0.1:11383_x_rmd C:collection1 S:shard1 
c:collection1 C278 oasc.SyncStrategy.sync Sync replicas to 
http://127.0.0.1:11383/x_rmd/collection1/
   [junit4]   2> 316484 T1006 N:127.0.0.1:11383_x_rmd C:collection1 S:shard1 
c:collection1 C278 oasc.SyncStrategy.syncReplicas Sync Success - now sync 
replicas to me
   [junit4]   2> 316484 T976 N:127.0.0.1:11377_x_rmd 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "operation":"leader",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"collection1"} current state version: 5
   [junit4]   2> 316484 T1006 N:127.0.0.1:11383_x_rmd C:collection1 S:shard1 
c:collection1 C278 oasc.SyncStrategy.syncToMe 
http://127.0.0.1:11383/x_rmd/collection1/ has no replicas
   [junit4]   2> 316485 T1006 N:127.0.0.1:11383_x_rmd C:collection1 S:shard1 
c:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new 
leader: http://127.0.0.1:11383/x_rmd/collection1/ shard1
   [junit4]   2> 316485 T1006 N:127.0.0.1:11383_x_rmd C:collection1 S:shard1 
c:collection1 oascc.SolrZkClient.makePath makePath: 
/collections/collection1/leaders/shard1
   [junit4]   2> 316486 T975 N:127.0.0.1:11377_x_rmd 
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 316486 T1001 N:127.0.0.1:11383_x_rmd 
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 316486 T986 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 316493 T975 N:127.0.0.1:11377_x_rmd 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 316494 T976 N:127.0.0.1:11377_x_rmd 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "operation":"leader",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "base_url":"http://127.0.0.1:11383/x_rmd";,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "state":"active"} current state version: 6
   [junit4]   2> 316598 T975 N:127.0.0.1:11377_x_rmd 
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 316598 T986 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 316598 T1001 N:127.0.0.1:11383_x_rmd 
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 316646 T1006 N:127.0.0.1:11383_x_rmd C:collection1 S:shard1 
c:collection1 oasc.ZkController.register We are 
http://127.0.0.1:11383/x_rmd/collection1/ and leader is 
http://127.0.0.1:11383/x_rmd/collection1/
   [junit4]   2> 316647 T1006 N:127.0.0.1:11383_x_rmd C:collection1 S:shard1 
c:collection1 oasc.ZkController.register No LogReplay needed for 
core=collection1 baseURL=http://127.0.0.1:11383/x_rmd
   [junit4]   2> 316647 T1006 N:127.0.0.1:11383_x_rmd C:collection1 S:shard1 
c:collection1 oasc.ZkController.checkRecovery I am the leader, no recovery 
necessary
   [junit4]   2> 316647 T1006 N:127.0.0.1:11383_x_rmd C:collection1 S:shard1 
c:collection1 oasc.ZkController.publish publishing core=collection1 
state=active collection=collection1
   [junit4]   2> 316647 T1006 N:127.0.0.1:11383_x_rmd C:collection1 S:shard1 
c:collection1 oasc.ZkController.publish numShards not found on descriptor - 
reading it from system property
   [junit4]   2> 316649 T975 N:127.0.0.1:11377_x_rmd 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 316651 T976 N:127.0.0.1:11377_x_rmd 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "state":"active",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "base_url":"http://127.0.0.1:11383/x_rmd";,
   [junit4]   2>          "node_name":"127.0.0.1:11383_x_rmd"} current state 
version: 7
   [junit4]   2> 316651 T976 N:127.0.0.1:11377_x_rmd 
oasco.ReplicaMutator.updateState Update state numShards=2 message={
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "state":"active",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "base_url":"http://127.0.0.1:11383/x_rmd";,
   [junit4]   2>          "node_name":"127.0.0.1:11383_x_rmd"}
   [junit4]   2> 316756 T986 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 316756 T975 N:127.0.0.1:11377_x_rmd 
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 316756 T1001 N:127.0.0.1:11383_x_rmd 
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 318024 T949 oas.SolrTestCaseJ4.writeCoreProperties Writing 
core.properties file to 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-2-001/cores/collection1
   [junit4]   2> 318027 T949 oasc.AbstractFullDistribZkTestBase.createJettys 
create jetty 2 in directory 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-2-001
   [junit4]   2> 318028 T949 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 318032 T949 oejs.AbstractConnector.doStart Started 
[email protected]:11398
   [junit4]   2> 318033 T949 oascse.JettySolrRunner$1.lifeCycleStarted Jetty 
properties: 
{solr.data.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/tempDir-001/jetty2, hostContext=/x_rmd, hostPort=11398, 
coreRootDirectory=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-2-001/cores, solrconfig=solrconfig.xml}
   [junit4]   2> 318034 T949 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@1e66a917
   [junit4]   2> 318034 T949 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-2-001/'
   [junit4]   2> 318087 T949 oasc.SolrXmlConfig.fromFile Loading container 
configuration from 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-2-001/solr.xml
   [junit4]   2> 318146 T949 oasc.CorePropertiesLocator.<init> Config-defined 
core root directory: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-2-001/cores
   [junit4]   2> 318147 T949 oasc.CoreContainer.<init> New CoreContainer 
1456872945
   [junit4]   2> 318147 T949 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-2-001/]
   [junit4]   2> 318148 T949 oasc.CoreContainer.load loading shared library: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-2-001/lib
   [junit4]   2> 318149 T949 oasc.SolrResourceLoader.addToClassLoader WARN 
Can't find (or read) directory to add to classloader: lib (resolved as: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-2-001/lib).
   [junit4]   2> 318165 T949 oashc.HttpShardHandlerFactory.init created with 
socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 
20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 
2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : 
false,useRetries : false,
   [junit4]   2> 318173 T949 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 318174 T949 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 318174 T949 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 318174 T949 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 318175 T949 oasc.ZkContainer.initZooKeeper Zookeeper 
client=127.0.0.1:11370/solr
   [junit4]   2> 318175 T949 oasc.ZkController.checkChrootPath zkHost includes 
chroot
   [junit4]   2> 318176 T949 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 318177 T949 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 318178 T1018 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@33826ee4 
name:ZooKeeperConnection Watcher:127.0.0.1:11370 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 318179 T949 oascc.ConnectionManager.waitForConnected Client is 
connected to ZooKeeper
   [junit4]   2> 318180 T949 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 318183 T949 N:127.0.0.1:11398_x_rmd 
oascc.ConnectionManager.waitForConnected Waiting for client to connect to 
ZooKeeper
   [junit4]   2> 318184 T1021 N:127.0.0.1:11398_x_rmd 
oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@629565e5 
name:ZooKeeperConnection Watcher:127.0.0.1:11370/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 318185 T949 N:127.0.0.1:11398_x_rmd 
oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 318190 T949 N:127.0.0.1:11398_x_rmd 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 319195 T949 N:127.0.0.1:11398_x_rmd 
oasc.ZkController.createEphemeralLiveNode Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:11398_x_rmd
   [junit4]   2> 319196 T949 N:127.0.0.1:11398_x_rmd 
oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:11398_x_rmd
   [junit4]   2> 319201 T949 N:127.0.0.1:11398_x_rmd oasc.Overseer.close 
Overseer (id=null) closing
   [junit4]   2> 319205 T949 N:127.0.0.1:11398_x_rmd 
oasc.CorePropertiesLocator.discover Looking for core definitions underneath 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-2-001/cores
   [junit4]   2> 319211 T949 N:127.0.0.1:11398_x_rmd oasc.CoreDescriptor.<init> 
CORE DESCRIPTOR: {shard=, collection=collection1, schema=schema.xml, 
config=solrconfig.xml, 
absoluteInstDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-2-001/cores/collection1/, 
instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-2-001/cores/collection1, coreNodeName=, 
transient=false, loadOnStartup=true, name=collection1, dataDir=data/}
   [junit4]   2> 319212 T949 N:127.0.0.1:11398_x_rmd 
oasc.CorePropertiesLocator.discoverUnder Found core collection1 in 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001/shard-2-001/cores/collection1/
   [junit4]   2> 319212 T949 N:127.0.0.1:11398_x_rmd 
oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 319215 T1022 N:127.0.0.1:11398_x_rmd C:collection1 
c:collection1 oasc.ZkController.publish publishing core=collection1 state=down 
collection=collection1
   [junit4]   2> 319215 T1022 N:127.0.0.1:11398_x_rmd C:collection1 
c:collection1 oasc.ZkController.publish numShards not found on descriptor - 
reading it from system property
   [junit4]   2> 319216 T1022 N:127.0.0.1:11398_x_rmd 
oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 319216 T975 N:127.0.0.1:11377_x_rmd 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 319218 T976 N:127.0.0.1:11377_x_rmd 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "state":"down",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "shard":null,
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "base_url":"http://127.0.0.1:11398/x_rmd";,
   [junit4]   2>          "node_name":"127.0.0.1:11398_x_rmd"} current state 
version: 8
   [junit4]   2> 319218 T976 N:127.0.0.1:11377_x_rmd oasco.

[...truncated too long message...]

1:11370 11370
   [junit4]   2> 383309 T950 oasc.ZkTestServer$ZKServerMain.runFromConfig WARN 
Watch limit violations: 
   [junit4]   2>        Maximum concurrent create/delete watches above limit:
   [junit4]   2>        
   [junit4]   2>                11      /solr/clusterstate.json
   [junit4]   2>                10      /solr/aliases.json
   [junit4]   2>                3       /solr/configs/conf1
   [junit4]   2>        
   [junit4]   2>        Maximum concurrent children watches above limit:
   [junit4]   2>        
   [junit4]   2>                11      /solr/live_nodes
   [junit4]   2>                2       /solr/overseer/queue
   [junit4]   2>                2       /solr/overseer/collection-queue-work
   [junit4]   2>        
   [junit4]   2> 383408 T1129 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@3d246002 
name:ZooKeeperConnection Watcher:127.0.0.1:11370/solr got event WatchedEvent 
state:Disconnected type:None path:null path:null type:None
   [junit4]   2> 383408 T1129 oascc.ConnectionManager.process Client->ZooKeeper 
status change trigger but we are already closed
   [junit4]   2> 383408 T1129 oaz.ClientCnxn$EventThread.processEvent ERROR 
Error while calling watcher  java.util.concurrent.RejectedExecutionException: 
Task 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1@59770d81 
rejected from 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@1717be0a[Terminated,
 pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 43]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2048)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:821)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1372)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:133)
   [junit4]   2>        at 
java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService.java:110)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:261)
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)
   [junit4]   2> 
   [junit4]   2> 383409 T1129 oaz.ClientCnxn$EventThread.processEvent ERROR 
Error while calling watcher  java.util.concurrent.RejectedExecutionException: 
Task 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1@1dcdc97f 
rejected from 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@1717be0a[Terminated,
 pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 43]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2048)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:821)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1372)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:133)
   [junit4]   2>        at 
java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService.java:110)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:261)
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)
   [junit4]   2> 
   [junit4]   2> 383409 T1129 oaz.ClientCnxn$EventThread.processEvent ERROR 
Error while calling watcher  java.util.concurrent.RejectedExecutionException: 
Task 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1@12771185 
rejected from 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@1717be0a[Terminated,
 pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 43]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2048)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:821)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1372)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:133)
   [junit4]   2>        at 
java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService.java:110)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:261)
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)
   [junit4]   2> 
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=OverseerRolesTest 
-Dtests.method=test -Dtests.seed=27C370908FCB708A -Dtests.multiplier=2 
-Dtests.slow=true -Dtests.locale=in -Dtests.timezone=Pacific/Niue 
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   74.6s J0 | OverseerRolesTest.test <<<
   [junit4]    > Throwable #1: 
org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = 
Session expired for /live_nodes
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([27C370908FCB708A:AF974F4A21371D72]:0)
   [junit4]    >        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
   [junit4]    >        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
   [junit4]    >        at 
org.apache.zookeeper.ZooKeeper.getChildren(ZooKeeper.java:1472)
   [junit4]    >        at 
org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:328)
   [junit4]    >        at 
org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:325)
   [junit4]    >        at 
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:61)
   [junit4]    >        at 
org.apache.solr.common.cloud.SolrZkClient.getChildren(SolrZkClient.java:325)
   [junit4]    >        at 
org.apache.solr.common.cloud.ZkStateReader.updateClusterState(ZkStateReader.java:517)
   [junit4]    >        at 
org.apache.solr.common.cloud.ZkStateReader.updateClusterState(ZkStateReader.java:255)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:146)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:133)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:128)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:877)
   [junit4]    >        at 
org.apache.solr.cloud.OverseerRolesTest.testOverseerRole(OverseerRolesTest.java:129)
   [junit4]    >        at 
org.apache.solr.cloud.OverseerRolesTest.test(OverseerRolesTest.java:90)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:960)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:935)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 383418 T949 C:control_collection S:shard1 c:collection1 
oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.OverseerRolesTest
 27C370908FCB708A-001
   [junit4]   2> 74642 T948 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will 
linger awaiting termination of 1 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=Lucene50, 
sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=in, 
timezone=Pacific/Niue
   [junit4]   2> NOTE: FreeBSD 9.1-RELEASE-p3 amd64/Oracle Corporation 1.7.0_65 
(64-bit)/cpus=16,threads=1,free=158610824,total=273154048
   [junit4]   2> NOTE: All tests run in this JVM: [AsyncMigrateRouteKeyTest, 
HdfsUnloadDistributedZkTest, BasicDistributedZkTest, 
TestManagedSchemaDynamicFieldResource, TestJoin, DistributedTermsComponentTest, 
OverseerRolesTest]
   [junit4] Completed [69/483] on J0 in 74.94s, 1 test, 1 error <<< FAILURES!

[...truncated 1326 lines...]
BUILD FAILED
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:536:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:484:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:61:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/extra-targets.xml:39:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build.xml:229:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/common-build.xml:511:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/lucene/common-build.xml:1434:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/lucene/common-build.xml:991:
 There were test failures: 483 suites, 1916 tests, 1 error, 64 ignored (23 
assumptions)

Total time: 53 minutes 44 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-Tests-5.x-Java7 #2955
Archived 5 artifacts
Archive block size is 32768
Received 0 blocks and 226955685 bytes
Compression is 0.0%
Took 42 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]

Reply via email to