lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS] Lucene-Solr-4.x-Linux (32bit/jdk1.8.0_05) - Build # 10266 - Failure!
Date Sun, 25 May 2014 21:47:33 GMT
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/10266/
Java: 32bit/jdk1.8.0_05 -client -XX:+UseSerialGC

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

Error Message:
New overseer designate has not become the overseer, expected : 127.0.0.1:46735_actual : null

Stack Trace:
java.lang.AssertionError: New overseer designate has not become the overseer, expected : 127.0.0.1:46735_actual : null
	at __randomizedtesting.SeedInfo.seed([E651CF2EC91217C0:67B74136BE4D77FC]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.apache.solr.cloud.OverseerRolesTest.testOverseerRole(OverseerRolesTest.java:224)
	at org.apache.solr.cloud.OverseerRolesTest.doTest(OverseerRolesTest.java:95)
	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:865)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:483)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:360)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:793)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:453)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:360)
	at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 11397 lines...]
   [junit4] Suite: org.apache.solr.cloud.OverseerRolesTest
   [junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/init-core-data-001
   [junit4]   2> 605506 T3113 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /
   [junit4]   2> 605510 T3113 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
   [junit4]   2> 605511 T3113 oasc.ZkTestServer.run STARTING ZK TEST SERVER
   [junit4]   1> client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 605512 T3114 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
   [junit4]   2> 605612 T3113 oasc.ZkTestServer.run start zk server on port:47819
   [junit4]   2> 605613 T3113 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 605714 T3120 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1b35096 name:ZooKeeperConnection Watcher:127.0.0.1:47819 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 605714 T3113 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 605714 T3113 oascc.SolrZkClient.makePath makePath: /solr
   [junit4]   2> 605719 T3113 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 605720 T3122 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@a01937 name:ZooKeeperConnection Watcher:127.0.0.1:47819/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 605721 T3113 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 605721 T3113 oascc.SolrZkClient.makePath makePath: /collections/collection1
   [junit4]   2> 605723 T3113 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
   [junit4]   2> 605724 T3113 oascc.SolrZkClient.makePath makePath: /collections/control_collection
   [junit4]   2> 605726 T3113 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
   [junit4]   2> 605727 T3113 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
   [junit4]   2> 605727 T3113 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 605730 T3113 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
   [junit4]   2> 605730 T3113 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
   [junit4]   2> 605735 T3113 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 605735 T3113 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 605738 T3113 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
   [junit4]   2> 605738 T3113 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 605740 T3113 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
   [junit4]   2> 605740 T3113 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
   [junit4]   2> 605742 T3113 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
   [junit4]   2> 605742 T3113 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
   [junit4]   2> 605744 T3113 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
   [junit4]   2> 605745 T3113 oascc.SolrZkClient.makePath makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 605747 T3113 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 605748 T3113 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 605749 T3113 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 605750 T3113 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 605752 T3113 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
   [junit4]   2> 605752 T3113 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 605754 T3113 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
   [junit4]   2> 605755 T3113 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
   [junit4]   2> 606017 T3113 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 606023 T3113 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:33369
   [junit4]   2> 606024 T3113 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 606024 T3113 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 606024 T3113 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-002
   [junit4]   2> 606025 T3113 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-002/'
   [junit4]   2> 606041 T3113 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-002/solr.xml
   [junit4]   2> 606057 T3113 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-002
   [junit4]   2> 606058 T3113 oasc.CoreContainer.<init> New CoreContainer 17482893
   [junit4]   2> 606058 T3113 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-002/]
   [junit4]   2> 606059 T3113 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 606059 T3113 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 606059 T3113 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 606060 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 606060 T3113 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 606060 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 606060 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 606061 T3113 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 606061 T3113 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 606062 T3113 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 606062 T3113 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 606062 T3113 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 606063 T3113 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:47819/solr
   [junit4]   2> 606063 T3113 oasc.ZkController.checkChrootPath zkHost includes chroot
   [junit4]   2> 606064 T3113 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 606066 T3133 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@174ce49 name:ZooKeeperConnection Watcher:127.0.0.1:47819 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 606066 T3113 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 606068 T3113 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 606069 T3135 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1dfab69 name:ZooKeeperConnection Watcher:127.0.0.1:47819/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 606070 T3113 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 606071 T3113 oascc.SolrZkClient.makePath makePath: /overseer/queue
   [junit4]   2> 606074 T3113 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work
   [junit4]   2> 606076 T3113 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-running
   [junit4]   2> 606078 T3113 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-completed
   [junit4]   2> 606080 T3113 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-failure
   [junit4]   2> 606086 T3113 oascc.SolrZkClient.makePath makePath: /live_nodes
   [junit4]   2> 606088 T3113 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33369_
   [junit4]   2> 606089 T3113 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:33369_
   [junit4]   2> 606091 T3113 oascc.SolrZkClient.makePath makePath: /overseer_elect
   [junit4]   2> 606093 T3113 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
   [junit4]   2> 606096 T3113 oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 127.0.0.1:33369_
   [junit4]   2> 606096 T3113 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
   [junit4]   2> 606098 T3113 oasc.Overseer.start Overseer (id=91819446650404867-127.0.0.1:33369_-n_0000000000) starting
   [junit4]   2> 606100 T3113 oascc.SolrZkClient.makePath makePath: /overseer/queue-work
   [junit4]   2> 606110 T3137 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
   [junit4]   2> 606110 T3113 oascc.SolrZkClient.makePath makePath: /clusterstate.json
   [junit4]   2> 606113 T3113 oascc.SolrZkClient.makePath makePath: /aliases.json
   [junit4]   2> 606114 T3113 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 606116 T3136 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
   [junit4]   2> 606116 T3113 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-002
   [junit4]   2> 606122 T3113 oasc.CorePropertiesLocator.discoverUnder Found core conf in /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-002/conf/
   [junit4]   2> 606229 T3113 oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 606231 T3113 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
   [junit4]   2> 606231 T3113 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 606232 T3113 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 606233 T3140 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1ff087b name:ZooKeeperConnection Watcher:127.0.0.1:47819/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 606233 T3113 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 606234 T3113 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 606236 T3113 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:false cause connection loss:false
   [junit4]   2> 606513 T3113 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 1
   [junit4]   2> 606513 T3113 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 606515 T3113 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:60313
   [junit4]   2> 606517 T3113 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 606517 T3113 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 606517 T3113 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-003
   [junit4]   2> 606518 T3113 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-003/'
   [junit4]   2> 606533 T3113 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-003/solr.xml
   [junit4]   2> 606551 T3113 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-003
   [junit4]   2> 606552 T3113 oasc.CoreContainer.<init> New CoreContainer 10108171
   [junit4]   2> 606552 T3113 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-003/]
   [junit4]   2> 606553 T3113 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 606553 T3113 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 606553 T3113 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 606554 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 606554 T3113 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 606554 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 606555 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 606555 T3113 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 606555 T3113 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 606556 T3113 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 606556 T3113 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 606556 T3113 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 606557 T3113 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:47819/solr
   [junit4]   2> 606557 T3113 oasc.ZkController.checkChrootPath zkHost includes chroot
   [junit4]   2> 606558 T3113 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 606559 T3151 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@59c71a name:ZooKeeperConnection Watcher:127.0.0.1:47819 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 606560 T3113 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 606562 T3113 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 606563 T3153 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@882b31 name:ZooKeeperConnection Watcher:127.0.0.1:47819/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 606563 T3113 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 606568 T3113 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 607570 T3113 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60313_
   [junit4]   2> 607571 T3113 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:60313_
   [junit4]   2> 607574 T3135 oascc.ZkStateReader$3.process Updating live nodes... (2)
   [junit4]   2> 607574 T3140 oascc.ZkStateReader$3.process Updating live nodes... (2)
   [junit4]   2> 607575 T3153 oascc.ZkStateReader$3.process Updating live nodes... (2)
   [junit4]   2> 607578 T3113 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-003
   [junit4]   2> 607583 T3113 oasc.CorePropertiesLocator.discoverUnder Found core conf in /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-003/conf/
   [junit4]   2> 607693 T3113 oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 607694 T3113 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
   [junit4]   2> 607695 T3113 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 607968 T3113 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 2
   [junit4]   2> 607969 T3113 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 607973 T3113 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:46735
   [junit4]   2> 607974 T3113 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 607974 T3113 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 607975 T3113 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-004
   [junit4]   2> 607975 T3113 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-004/'
   [junit4]   2> 607998 T3113 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-004/solr.xml
   [junit4]   2> 608007 T3113 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-004
   [junit4]   2> 608008 T3113 oasc.CoreContainer.<init> New CoreContainer 2939141
   [junit4]   2> 608008 T3113 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-004/]
   [junit4]   2> 608008 T3113 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 608009 T3113 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 608009 T3113 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 608009 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 608010 T3113 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 608010 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 608010 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 608011 T3113 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 608011 T3113 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 608012 T3113 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 608012 T3113 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 608012 T3113 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 608013 T3113 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:47819/solr
   [junit4]   2> 608013 T3113 oasc.ZkController.checkChrootPath zkHost includes chroot
   [junit4]   2> 608014 T3113 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 608015 T3165 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@51b4d9 name:ZooKeeperConnection Watcher:127.0.0.1:47819 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 608015 T3113 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 608020 T3113 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 608021 T3167 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1f32ea0 name:ZooKeeperConnection Watcher:127.0.0.1:47819/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 608021 T3113 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 608026 T3113 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 609028 T3113 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46735_
   [junit4]   2> 609030 T3113 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:46735_
   [junit4]   2> 609033 T3153 oascc.ZkStateReader$3.process Updating live nodes... (3)
   [junit4]   2> 609033 T3135 oascc.ZkStateReader$3.process Updating live nodes... (3)
   [junit4]   2> 609034 T3167 oascc.ZkStateReader$3.process Updating live nodes... (3)
   [junit4]   2> 609033 T3140 oascc.ZkStateReader$3.process Updating live nodes... (3)
   [junit4]   2> 609036 T3113 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-004
   [junit4]   2> 609046 T3113 oasc.CorePropertiesLocator.discoverUnder Found core conf in /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-004/conf/
   [junit4]   2> 609168 T3113 oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 609169 T3113 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
   [junit4]   2> 609169 T3113 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 609447 T3113 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 3
   [junit4]   2> 609448 T3113 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 609449 T3113 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:40188
   [junit4]   2> 609450 T3113 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 609451 T3113 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 609451 T3113 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-005
   [junit4]   2> 609451 T3113 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-005/'
   [junit4]   2> 609466 T3113 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-005/solr.xml
   [junit4]   2> 609476 T3113 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-005
   [junit4]   2> 609477 T3113 oasc.CoreContainer.<init> New CoreContainer 748754
   [junit4]   2> 609477 T3113 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-005/]
   [junit4]   2> 609478 T3113 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 609478 T3113 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 609478 T3113 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 609479 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 609479 T3113 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 609479 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 609480 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 609480 T3113 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 609480 T3113 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 609481 T3113 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 609482 T3113 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 609482 T3113 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 609483 T3113 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:47819/solr
   [junit4]   2> 609483 T3113 oasc.ZkController.checkChrootPath zkHost includes chroot
   [junit4]   2> 609484 T3113 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 609485 T3179 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1506436 name:ZooKeeperConnection Watcher:127.0.0.1:47819 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 609486 T3113 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 609488 T3113 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 609489 T3181 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@11d4b90 name:ZooKeeperConnection Watcher:127.0.0.1:47819/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 609489 T3113 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 609495 T3113 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 610498 T3113 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:40188_
   [junit4]   2> 610499 T3113 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:40188_
   [junit4]   2> 610502 T3153 oascc.ZkStateReader$3.process Updating live nodes... (4)
   [junit4]   2> 610503 T3140 oascc.ZkStateReader$3.process Updating live nodes... (4)
   [junit4]   2> 610503 T3181 oascc.ZkStateReader$3.process Updating live nodes... (4)
   [junit4]   2> 610502 T3135 oascc.ZkStateReader$3.process Updating live nodes... (4)
   [junit4]   2> 610502 T3167 oascc.ZkStateReader$3.process Updating live nodes... (4)
   [junit4]   2> 610506 T3113 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-005
   [junit4]   2> 610513 T3113 oasc.CorePropertiesLocator.discoverUnder Found core conf in /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-005/conf/
   [junit4]   2> 610651 T3113 oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 610652 T3113 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
   [junit4]   2> 610653 T3113 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 610928 T3113 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 4
   [junit4]   2> 610929 T3113 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 610931 T3113 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:43955
   [junit4]   2> 610932 T3113 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 610932 T3113 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 610933 T3113 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-006
   [junit4]   2> 610933 T3113 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-006/'
   [junit4]   2> 610949 T3113 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-006/solr.xml
   [junit4]   2> 610958 T3113 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-006
   [junit4]   2> 610959 T3113 oasc.CoreContainer.<init> New CoreContainer 717564
   [junit4]   2> 610959 T3113 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-006/]
   [junit4]   2> 610960 T3113 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 610960 T3113 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 610960 T3113 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 610961 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 610961 T3113 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 610961 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 610962 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 610962 T3113 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 610962 T3113 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 610963 T3113 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 610963 T3113 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 610963 T3113 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 610964 T3113 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:47819/solr
   [junit4]   2> 610964 T3113 oasc.ZkController.checkChrootPath zkHost includes chroot
   [junit4]   2> 610965 T3113 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 610966 T3193 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@162cf5d name:ZooKeeperConnection Watcher:127.0.0.1:47819 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 610966 T3113 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 610968 T3113 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 610969 T3195 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@10a587b name:ZooKeeperConnection Watcher:127.0.0.1:47819/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 610970 T3113 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 610981 T3113 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 611983 T3113 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43955_
   [junit4]   2> 611984 T3113 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:43955_
   [junit4]   2> 611987 T3167 oascc.ZkStateReader$3.process Updating live nodes... (5)
   [junit4]   2> 611987 T3181 oascc.ZkStateReader$3.process Updating live nodes... (5)
   [junit4]   2> 611987 T3195 oascc.ZkStateReader$3.process Updating live nodes... (5)
   [junit4]   2> 611987 T3140 oascc.ZkStateReader$3.process Updating live nodes... (5)
   [junit4]   2> 611987 T3135 oascc.ZkStateReader$3.process Updating live nodes... (5)
   [junit4]   2> 611987 T3153 oascc.ZkStateReader$3.process Updating live nodes... (5)
   [junit4]   2> 611990 T3113 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-006
   [junit4]   2> 611997 T3113 oasc.CorePropertiesLocator.discoverUnder Found core conf in /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-006/conf/
   [junit4]   2> 612140 T3113 oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 612141 T3113 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
   [junit4]   2> 612141 T3113 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 612408 T3113 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 5
   [junit4]   2> 612409 T3113 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 612411 T3113 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:46341
   [junit4]   2> 612412 T3113 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 612412 T3113 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 612413 T3113 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-007
   [junit4]   2> 612413 T3113 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-007/'
   [junit4]   2> 612428 T3113 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-007/solr.xml
   [junit4]   2> 612437 T3113 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-007
   [junit4]   2> 612438 T3113 oasc.CoreContainer.<init> New CoreContainer 21884954
   [junit4]   2> 612438 T3113 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-007/]
   [junit4]   2> 612438 T3113 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 612439 T3113 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 612439 T3113 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 612439 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 612440 T3113 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 612440 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 612440 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 612440 T3113 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 612441 T3113 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 612441 T3113 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 612442 T3113 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 612442 T3113 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 612442 T3113 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:47819/solr
   [junit4]   2> 612443 T3113 oasc.ZkController.checkChrootPath zkHost includes chroot
   [junit4]   2> 612443 T3113 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 612445 T3207 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@d9a350 name:ZooKeeperConnection Watcher:127.0.0.1:47819 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 612445 T3113 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 612447 T3113 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 612448 T3209 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@7e1ba4 name:ZooKeeperConnection Watcher:127.0.0.1:47819/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 612448 T3113 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 612452 T3113 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 613454 T3113 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46341_
   [junit4]   2> 613456 T3113 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:46341_
   [junit4]   2> 613462 T3167 oascc.ZkStateReader$3.process Updating live nodes... (6)
   [junit4]   2> 613462 T3140 oascc.ZkStateReader$3.process Updating live nodes... (6)
   [junit4]   2> 613462 T3195 oascc.ZkStateReader$3.process Updating live nodes... (6)
   [junit4]   2> 613463 T3135 oascc.ZkStateReader$3.process Updating live nodes... (6)
   [junit4]   2> 613463 T3209 oascc.ZkStateReader$3.process Updating live nodes... (6)
   [junit4]   2> 613462 T3153 oascc.ZkStateReader$3.process Updating live nodes... (6)
   [junit4]   2> 613462 T3181 oascc.ZkStateReader$3.process Updating live nodes... (6)
   [junit4]   2> 613467 T3113 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-007
   [junit4]   2> 613474 T3113 oasc.CorePropertiesLocator.discoverUnder Found core conf in /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-007/conf/
   [junit4]   2> 613620 T3113 oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 613621 T3113 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
   [junit4]   2> 613621 T3113 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 613892 T3113 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 6
   [junit4]   2> 613894 T3113 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 613896 T3113 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:36386
   [junit4]   2> 613897 T3113 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 613897 T3113 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 613897 T3113 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-008
   [junit4]   2> 613898 T3113 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-008/'
   [junit4]   2> 613913 T3113 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-008/solr.xml
   [junit4]   2> 613931 T3113 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-008
   [junit4]   2> 613932 T3113 oasc.CoreContainer.<init> New CoreContainer 8332974
   [junit4]   2> 613932 T3113 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-008/]
   [junit4]   2> 613932 T3113 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 613933 T3113 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 613933 T3113 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 613933 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 613934 T3113 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 613934 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 613934 T3113 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 613935 T3113 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 613935 T3113 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 613935 T3113 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 613936 T3113 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 613936 T3113 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 613936 T3113 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:47819/solr
   [junit4]   2> 613937 T3113 oasc.ZkController.checkChrootPath zkHost includes chroot
   [junit4]   2> 613938 T3113 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 613955 T3221 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1b5d95f name:ZooKeeperConnection Watcher:127.0.0.1:47819 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 613955 T3113 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 613976 T3113 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 613995 T3223 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@252ceb name:ZooKeeperConnection Watcher:127.0.0.1:47819/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 613996 T3113 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 614096 T3113 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 615099 T3113 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36386_
   [junit4]   2> 615100 T3113 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:36386_
   [junit4]   2> 615103 T3140 oascc.ZkStateReader$3.process Updating live nodes... (7)
   [junit4]   2> 615104 T3209 oascc.ZkStateReader$3.process Updating live nodes... (7)
   [junit4]   2> 615104 T3223 oascc.ZkStateReader$3.process Updating live nodes... (7)
   [junit4]   2> 615104 T3181 oascc.ZkStateReader$3.process Updating live nodes... (7)
   [junit4]   2> 615104 T3135 oascc.ZkStateReader$3.process Updating live nodes... (7)
   [junit4]   2> 615104 T3195 oascc.ZkStateReader$3.process Updating live nodes... (7)
   [junit4]   2> 615104 T3167 oascc.ZkStateReader$3.process Updating live nodes... (7)
   [junit4]   2> 615104 T3153 oascc.ZkStateReader$3.process Updating live nodes... (7)
   [junit4]   2> 615108 T3113 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-008
   [junit4]   2> 615113 T3113 oasc.CorePropertiesLocator.discoverUnder Found core conf in /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-008/conf/
   [junit4]   2> 615231 T3113 oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 615232 T3113 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
   [junit4]   2> 615232 T3113 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 615234 T3113 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 615235 T3226 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@981470 name:ZooKeeperConnection Watcher:127.0.0.1:47819/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 615235 T3113 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 615236 T3113 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 615239 T3113 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 615240 T3228 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1b3101b name:ZooKeeperConnection Watcher:127.0.0.1:47819/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 615240 T3113 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 615241 T3113 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 615246 T3205 oasha.CollectionsHandler.handleCreateAction Creating Collection : replicationFactor=2&maxShardsPerNode=2&name=testOverseerQuit&action=CREATE&numShards=4&wt=javabin&version=2
   [junit4]   2> 615247 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/collection-queue-work state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615247 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/collection-queue-work state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615247 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/collection-queue-work state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615247 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/collection-queue-work state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615248 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/collection-queue-work state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615248 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/collection-queue-work state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615248 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/collection-queue-work state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615248 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/collection-queue-work state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615248 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/collection-queue-work state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615249 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/collection-queue-work state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615249 T3137 oasc.OverseerCollectionProcessor.run Overseer Collection Processor: Get the message id:/overseer/collection-queue-work/qn-0000000000 message:{
   [junit4]   2> 	  "operation":"createcollection",
   [junit4]   2> 	  "fromApi":"true",
   [junit4]   2> 	  "name":"testOverseerQuit",
   [junit4]   2> 	  "replicationFactor":"2",
   [junit4]   2> 	  "numShards":"4",
   [junit4]   2> 	  "maxShardsPerNode":"2"}
   [junit4]   2> 615250 T3229 oasc.OverseerCollectionProcessor.processMessage WARN OverseerCollectionProcessor.processMessage : createcollection , {
   [junit4]   2> 	  "operation":"createcollection",
   [junit4]   2> 	  "fromApi":"true",
   [junit4]   2> 	  "name":"testOverseerQuit",
   [junit4]   2> 	  "replicationFactor":"2",
   [junit4]   2> 	  "numShards":"4",
   [junit4]   2> 	  "maxShardsPerNode":"2"}
   [junit4]   2> 615251 T3229 oasc.OverseerCollectionProcessor.createConfNode Only one config set found in zk - using it:conf1
   [junit4]   2> 615251 T3229 oasc.OverseerCollectionProcessor.createConfNode creating collections conf node /collections/testOverseerQuit 
   [junit4]   2> 615252 T3229 oascc.SolrZkClient.makePath makePath: /collections/testOverseerQuit
   [junit4]   2> 615254 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615255 T3136 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
   [junit4]   2> 615255 T3136 oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection: testOverseerQuit
   [junit4]   2> 615256 T3136 oasc.Overseer$ClusterStateUpdater.createCollection Create collection testOverseerQuit with shards [shard1, shard2, shard3, shard4]
   [junit4]   2> 615257 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615258 T3209 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 615258 T3226 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 615258 T3135 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 615259 T3228 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 615258 T3223 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 615258 T3195 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 615258 T3167 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 615258 T3153 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 615258 T3140 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 615258 T3181 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 615354 T3229 oasc.OverseerCollectionProcessor.createCollection Creating SolrCores for new collection testOverseerQuit, shardNames [shard1, shard2, shard3, shard4] , replicationFactor : 2
   [junit4]   2> 615355 T3229 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerQuit_shard1_replica1 as part of slice shard1 of collection testOverseerQuit on 127.0.0.1:33369_
   [junit4]   2> 615355 T3229 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerQuit_shard1_replica2 as part of slice shard1 of collection testOverseerQuit on 127.0.0.1:36386_
   [junit4]   2> 615356 T3229 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerQuit_shard2_replica1 as part of slice shard2 of collection testOverseerQuit on 127.0.0.1:46341_
   [junit4]   2> 615357 T3229 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerQuit_shard2_replica2 as part of slice shard2 of collection testOverseerQuit on 127.0.0.1:60313_
   [junit4]   2> 615358 T3129 oasha.CoreAdminHandler.handleCreateAction core create command qt=/admin/cores&collection.configName=conf1&name=testOverseerQuit_shard1_replica1&action=CREATE&numShards=4&collection=testOverseerQuit&shard=shard1&wt=javabin&version=2
   [junit4]   2> 615358 T3229 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerQuit_shard3_replica1 as part of slice shard3 of collection testOverseerQuit on 127.0.0.1:40188_
   [junit4]   2> 615359 T3203 oasha.CoreAdminHandler.handleCreateAction core create command qt=/admin/cores&collection.configName=conf1&name=testOverseerQuit_shard2_replica1&action=CREATE&numShards=4&collection=testOverseerQuit&shard=shard2&wt=javabin&version=2
   [junit4]   2> 615359 T3147 oasha.CoreAdminHandler.handleCreateAction core create command qt=/admin/cores&collection.configName=conf1&name=testOverseerQuit_shard2_replica2&action=CREATE&numShards=4&collection=testOverseerQuit&shard=shard2&wt=javabin&version=2
   [junit4]   2> 615359 T3216 oasha.CoreAdminHandler.handleCreateAction core create command qt=/admin/cores&collection.configName=conf1&name=testOverseerQuit_shard1_replica2&action=CREATE&numShards=4&collection=testOverseerQuit&shard=shard1&wt=javabin&version=2
   [junit4]   2> 615360 T3229 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerQuit_shard3_replica2 as part of slice shard3 of collection testOverseerQuit on 127.0.0.1:46735_
   [junit4]   2> 615361 T3129 oasc.ZkController.publish publishing core=testOverseerQuit_shard1_replica1 state=down collection=testOverseerQuit
   [junit4]   2> 615361 T3229 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerQuit_shard4_replica1 as part of slice shard4 of collection testOverseerQuit on 127.0.0.1:43955_
   [junit4]   2> 615362 T3160 oasha.CoreAdminHandler.handleCreateAction core create command qt=/admin/cores&collection.configName=conf1&name=testOverseerQuit_shard3_replica2&action=CREATE&numShards=4&collection=testOverseerQuit&shard=shard3&wt=javabin&version=2
   [junit4]   2> 615362 T3203 oasc.ZkController.publish publishing core=testOverseerQuit_shard2_replica1 state=down collection=testOverseerQuit
   [junit4]   2> 615362 T3175 oasha.CoreAdminHandler.handleCreateAction core create command qt=/admin/cores&collection.configName=conf1&name=testOverseerQuit_shard3_replica1&action=CREATE&numShards=4&collection=testOverseerQuit&shard=shard3&wt=javabin&version=2
   [junit4]   2> 615363 T3229 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerQuit_shard4_replica2 as part of slice shard4 of collection testOverseerQuit on 127.0.0.1:33369_
   [junit4]   2> 615361 T3216 oasc.ZkController.publish publishing core=testOverseerQuit_shard1_replica2 state=down collection=testOverseerQuit
   [junit4]   2> 615361 T3147 oasc.ZkController.publish publishing core=testOverseerQuit_shard2_replica2 state=down collection=testOverseerQuit
   [junit4]   2> 615363 T3129 oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 615365 T3190 oasha.CoreAdminHandler.handleCreateAction core create command qt=/admin/cores&collection.configName=conf1&name=testOverseerQuit_shard4_replica1&action=CREATE&numShards=4&collection=testOverseerQuit&shard=shard4&wt=javabin&version=2
   [junit4]   2> 615366 T3130 oasha.CoreAdminHandler.handleCreateAction core create command qt=/admin/cores&collection.configName=conf1&name=testOverseerQuit_shard4_replica2&action=CREATE&numShards=4&collection=testOverseerQuit&shard=shard4&wt=javabin&version=2
   [junit4]   2> 615363 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615366 T3190 oasc.ZkController.publish publishing core=testOverseerQuit_shard4_replica1 state=down collection=testOverseerQuit
   [junit4]   2> 615365 T3175 oasc.ZkController.publish publishing core=testOverseerQuit_shard3_replica1 state=down collection=testOverseerQuit
   [junit4]   2> 615367 T3190 oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 615365 T3216 oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 615365 T3147 oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 615364 T3160 oasc.ZkController.publish publishing core=testOverseerQuit_shard3_replica2 state=down collection=testOverseerQuit
   [junit4]   2> 615364 T3203 oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 615368 T3175 oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 615367 T3136 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
   [junit4]   2> 615367 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615367 T3130 oasc.ZkController.publish publishing core=testOverseerQuit_shard4_replica2 state=down collection=testOverseerQuit
   [junit4]   2> 615370 T3136 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:33369",
   [junit4]   2> 	  "core":"testOverseerQuit_shard1_replica1",
   [junit4]   2> 	  "roles":null,
   [junit4]   2> 	  "node_name":"127.0.0.1:33369_",
   [junit4]   2> 	  "shard":"shard1",
   [junit4]   2> 	  "collection":"testOverseerQuit",
   [junit4]   2> 	  "numShards":"4",
   [junit4]   2> 	  "core_node_name":null}
   [junit4]   2> 615369 T3160 oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 615371 T3130 oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 615373 T3136 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:46341",
   [junit4]   2> 	  "core":"testOverseerQuit_shard2_replica1",
   [junit4]   2> 	  "roles":null,
   [junit4]   2> 	  "node_name":"127.0.0.1:46341_",
   [junit4]   2> 	  "shard":"shard2",
   [junit4]   2> 	  "collection":"testOverseerQuit",
   [junit4]   2> 	  "numShards":"4",
   [junit4]   2> 	  "core_node_name":null}
   [junit4]   2> 615377 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615377 T3136 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:60313",
   [junit4]   2> 	  "core":"testOverseerQuit_shard2_replica2",
   [junit4]   2> 	  "roles":null,
   [junit4]   2> 	  "node_name":"127.0.0.1:60313_",
   [junit4]   2> 	  "shard":"shard2",
   [junit4]   2> 	  "collection":"testOverseerQuit",
   [junit4]   2> 	  "numShards":"4",
   [junit4]   2> 	  "core_node_name":null}
   [junit4]   2> 615380 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615380 T3136 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:36386",
   [junit4]   2> 	  "core":"testOverseerQuit_shard1_replica2",
   [junit4]   2> 	  "roles":null,
   [junit4]   2> 	  "node_name":"127.0.0.1:36386_",
   [junit4]   2> 	  "shard":"shard1",
   [junit4]   2> 	  "collection":"testOverseerQuit",
   [junit4]   2> 	  "numShards":"4",
   [junit4]   2> 	  "core_node_name":null}
   [junit4]   2> 615382 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615383 T3136 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:43955",
   [junit4]   2> 	  "core":"testOverseerQuit_shard4_replica1",
   [junit4]   2> 	  "roles":null,
   [junit4]   2> 	  "node_name":"127.0.0.1:43955_",
   [junit4]   2> 	  "shard":"shard4",
   [junit4]   2> 	  "collection":"testOverseerQuit",
   [junit4]   2> 	  "numShards":"4",
   [junit4]   2> 	  "core_node_name":null}
   [junit4]   2> 615385 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615385 T3136 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:40188",
   [junit4]   2> 	  "core":"testOverseerQuit_shard3_replica1",
   [junit4]   2> 	  "roles":null,
   [junit4]   2> 	  "node_name":"127.0.0.1:40188_",
   [junit4]   2> 	  "shard":"shard3",
   [junit4]   2> 	  "collection":"testOverseerQuit",
   [junit4]   2> 	  "numShards":"4",
   [junit4]   2> 	  "core_node_name":null}
   [junit4]   2> 615387 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615388 T3136 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:46735",
   [junit4]   2> 	  "core":"testOverseerQuit_shard3_replica2",
   [junit4]   2> 	  "roles":null,
   [junit4]   2> 	  "node_name":"127.0.0.1:46735_",
   [junit4]   2> 	  "shard":"shard3",
   [junit4]   2> 	  "collection":"testOverseerQuit",
   [junit4]   2> 	  "numShards":"4",
   [junit4]   2> 	  "core_node_name":null}
   [junit4]   2> 615389 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615390 T3136 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:33369",
   [junit4]   2> 	  "core":"testOverseerQuit_shard4_replica2",
   [junit4]   2> 	  "roles":null,
   [junit4]   2> 	  "node_name":"127.0.0.1:33369_",
   [junit4]   2> 	  "shard":"shard4",
   [junit4]   2> 	  "collection":"testOverseerQuit",
   [junit4]   2> 	  "numShards":"4",
   [junit4]   2> 	  "core_node_name":null}
   [junit4]   2> 615391 T3135 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 615494 T3226 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 615494 T3153 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 615494 T3223 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 615494 T3167 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 615494 T3181 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 615494 T3135 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 615494 T3195 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 615494 T3140 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 615494 T3209 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 615494 T3228 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
   [junit4]   2> 616365 T3129 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerQuit_shard1_replica1
   [junit4]   2> 616366 T3129 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerQuit
   [junit4]   2> 616367 T3129 oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 616367 T3129 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerQuit
   [junit4]   2> 616368 T3190 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerQuit_shard4_replica1
   [junit4]   2> 616368 T3216 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerQuit_shard1_replica2
   [junit4]   2> 616368 T3147 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerQuit_shard2_replica2
   [junit4]   2> 616368 T3129 oascc.ZkStateReader.readConfigName path=/collections/testOverseerQuit configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 616369 T3147 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerQuit
   [junit4]   2> 616369 T3175 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerQuit_shard3_replica1
   [junit4]   2> 616369 T3190 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerQuit
   [junit4]   2> 616369 T3129 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-002/testOverseerQuit_shard1_replica1/'
   [junit4]   2> 616369 T3216 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerQuit
   [junit4]   2> 616369 T3203 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerQuit_shard2_replica1
   [junit4]   2> 616371 T3130 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerQuit_shard4_replica2
   [junit4]   2> 616372 T3130 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerQuit
   [junit4]   2> 616371 T3160 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerQuit_shard3_replica2
   [junit4]   2> 616371 T3175 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerQuit
   [junit4]   2> 616371 T3190 oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 616374 T3130 oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 616371 T3147 oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 616374 T3130 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerQuit
   [junit4]   2> 616374 T3190 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerQuit
   [junit4]   2> 616374 T3175 oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 616376 T3175 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerQuit
   [junit4]   2> 616373 T3160 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerQuit
   [junit4]   2> 616373 T3216 oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 616372 T3203 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerQuit
   [junit4]   2> 616377 T3175 oascc.ZkStateReader.readConfigName path=/collections/testOverseerQuit configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 616377 T3160 oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 616377 T3216 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerQuit
   [junit4]   2> 616376 T3190 oascc.ZkStateReader.readConfigName path=/collections/testOverseerQuit configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 616376 T3130 oascc.ZkStateReader.readConfigName path=/collections/testOverseerQuit configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 616375 T3147 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerQuit
   [junit4]   2> 616379 T3216 oascc.ZkStateReader.readConfigName path=/collections/testOverseerQuit configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 616379 T3130 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-002/testOverseerQuit_shard4_replica2/'
   [junit4]   2> 616379 T3190 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-006/testOverseerQuit_shard4_replica1/'
   [junit4]   2> 616378 T3160 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerQuit
   [junit4]   2> 616378 T3203 oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 616382 T3203 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerQuit
   [junit4]   2> 616378 T3175 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-005/testOverseerQuit_shard3_replica1/'
   [junit4]   2> 616383 T3160 oascc.ZkStateReader.readConfigName path=/collections/testOverseerQuit configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 616382 T3147 oascc.ZkStateReader.readConfigName path=/collections/testOverseerQuit configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 616384 T3147 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-003/testOverseerQuit_shard2_replica2/'
   [junit4]   2> 616380 T3216 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-008/testOverseerQuit_shard1_replica2/'
   [junit4]   2> 616384 T3160 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-004/testOverseerQuit_shard3_replica2/'
   [junit4]   2> 616383 T3203 oascc.ZkStateReader.readConfigName path=/collections/testOverseerQuit configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 616388 T3203 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-007/testOverseerQuit_shard2_replica1/'
   [junit4]   2> 616433 T3129 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_9
   [junit4]   2> 616438 T3130 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_9
   [junit4]   2> 616458 T3203 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_9
   [junit4]   2> 616463 T3129 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 616465 T3129 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 616491 T3203 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 616497 T3203 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 616497 T3190 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_9
   [junit4]   2> 616499 T3130 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 616500 T3216 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_9
   [junit4]   2> 616501 T3130 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 616515 T3129 oass.IndexSchema.readSchema [testOverseerQuit_shard1_replica1] Schema name=test
   [junit4]   2> 616516 T3147 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_9
   [junit4]   2> 616523 T3160 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_9
   [junit4]   2> 616543 T3130 oass.IndexSchema.readSchema [testOverseerQuit_shard4_replica2] Schema name=test
   [junit4]   2> 616545 T3216 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 616547 T3216 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 616548 T3203 oass.IndexSchema.readSchema [testOverseerQuit_shard2_replica1] Schema name=test
   [junit4]   2> 616550 T3147 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 616551 T3190 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 616568 T3147 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 616571 T3175 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_9
   [junit4]   2> 616575 T3190 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 616595 T3216 oass.IndexSchema.readSchema [testOverseerQuit_shard1_replica2] Schema name=test
   [junit4]   2> 616601 T3160 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 616623 T3190 oass.IndexSchema.readSchema [testOverseerQuit_shard4_replica1] Schema name=test
   [junit4]   2> 616627 T3160 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 616627 T3147 oass.IndexSchema.readSchema [testOverseerQuit_shard2_replica2] Schema name=test
   [junit4]   2> 616628 T3175 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 616651 T3160 oass.IndexSchema.readSchema [testOverseerQuit_shard3_replica2] Schema name=test
   [junit4]   2> 616694 T3175 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 616737 T3175 oass.IndexSchema.readSchema [testOverseerQuit_shard3_replica1] Schema name=test
   [junit4]   2> 617023 T3147 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
   [junit4]   2> 617024 T3147 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
   [junit4]   2> 617037 T3147 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 617045 T3130 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
   [junit4]   2> 617046 T3130 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
   [junit4]   2> 617047 T3130 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 617047 T3147 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 617050 T3147 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 617070 T3216 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
   [junit4]   2> 617071 T3216 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
   [junit4]   2> 617072 T3216 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 617074 T3129 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
   [junit4]   2> 617075 T3129 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
   [junit4]   2> 617076 T3129 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 617078 T3147 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 617079 T3216 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 617082 T3147 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 617082 T3216 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 617083 T3129 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 617086 T3129 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 617086 T3130 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 617086 T3147 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 617095 T3147 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 617097 T3147 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 617096 T3130 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 617097 T3147 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 617100 T3147 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 617101 T3147 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 617101 T3147 oasc.CoreContainer.create Creating SolrCore 'testOverseerQuit_shard2_replica2' using configuration from collection testOverseerQuit
   [junit4]   2> 617102 T3147 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 617102 T3147 oasc.SolrCore.<init> [testOverseerQuit_shard2_replica2] Opening new SolrCore at ./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-003/testOverseerQuit_shard2_replica2/, dataDir=./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-003/testOverseerQuit_shard2_replica2/data/
   [junit4]   2> 617103 T3147 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@18e9a67
   [junit4]   2> 617104 T3147 oasc.CachingDirectoryFactory.get return new directory for ./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-003/testOverseerQuit_shard2_replica2/data
   [junit4]   2> 617105 T3147 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-003/testOverseerQuit_shard2_replica2/data/index/
   [junit4]   2> 617105 T3147 oasc.SolrCore.initIndex WARN [testOverseerQuit_shard2_replica2] Solr index directory

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

   2> 647080 T3181 oasc.CachingDirectoryFactory.closeCacheValue looking to close ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-005/testOverseerQuit_shard3_replica1/data/index [CachedDir<<refCount=0;path=../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-005/testOverseerQuit_shard3_replica1/data/index;done=false>>]
   [junit4]   2> 647080 T3181 oasc.CachingDirectoryFactory.close Closing directory: ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-005/testOverseerQuit_shard3_replica1/data/index
   [junit4]   2> 647080 T3181 oasc.CachingDirectoryFactory.closeCacheValue looking to close ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-005/testOverseerQuit_shard3_replica1/data [CachedDir<<refCount=0;path=../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-005/testOverseerQuit_shard3_replica1/data;done=false>>]
   [junit4]   2> 647081 T3181 oasc.CachingDirectoryFactory.close Closing directory: ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001/tempDir-005/testOverseerQuit_shard3_replica1/data
   [junit4]   2> 647081 T3181 oascc.SolrZkClient.makePath makePath: /collections/testOverseerQuit/leaders/shard3
   [junit4]   2> 647082 T3181 oasc.SolrException.log ERROR There was a problem trying to register as the leader:org.apache.solr.common.SolrException: Could not register as the leader because creating the ephemeral registration node in ZooKeeper failed
   [junit4]   2> 		at org.apache.solr.cloud.ShardLeaderElectionContextBase.runLeaderProcess(ElectionContext.java:135)
   [junit4]   2> 		at org.apache.solr.cloud.ShardLeaderElectionContext.runLeaderProcess(ElectionContext.java:290)
   [junit4]   2> 		at org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:142)
   [junit4]   2> 		at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:110)
   [junit4]   2> 		at org.apache.solr.cloud.LeaderElector.access$200(LeaderElector.java:55)
   [junit4]   2> 		at org.apache.solr.cloud.LeaderElector$ElectionWatcher.process(LeaderElector.java:303)
   [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> 	Caused by: org.apache.solr.common.SolrException: org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /collections
   [junit4]   2> 		at org.apache.solr.common.util.RetryUtil.retryOnThrowable(RetryUtil.java:40)
   [junit4]   2> 		at org.apache.solr.cloud.ShardLeaderElectionContextBase.runLeaderProcess(ElectionContext.java:122)
   [junit4]   2> 		... 7 more
   [junit4]   2> 	Caused by: org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /collections
   [junit4]   2> 		at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
   [junit4]   2> 		at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
   [junit4]   2> 		at org.apache.zookeeper.ZooKeeper.exists(ZooKeeper.java:1045)
   [junit4]   2> 		at org.apache.solr.common.cloud.SolrZkClient$3.execute(SolrZkClient.java:209)
   [junit4]   2> 		at org.apache.solr.common.cloud.SolrZkClient$3.execute(SolrZkClient.java:206)
   [junit4]   2> 		at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:73)
   [junit4]   2> 		at org.apache.solr.common.cloud.SolrZkClient.exists(SolrZkClient.java:206)
   [junit4]   2> 		at org.apache.solr.common.cloud.SolrZkClient.makePath(SolrZkClient.java:417)
   [junit4]   2> 		at org.apache.solr.common.cloud.SolrZkClient.makePath(SolrZkClient.java:386)
   [junit4]   2> 		at org.apache.solr.common.cloud.SolrZkClient.makePath(SolrZkClient.java:373)
   [junit4]   2> 		at org.apache.solr.cloud.ShardLeaderElectionContextBase$1.execute(ElectionContext.java:127)
   [junit4]   2> 		at org.apache.solr.common.util.RetryUtil.retryOnThrowable(RetryUtil.java:34)
   [junit4]   2> 		... 8 more
   [junit4]   2> 	
   [junit4]   2> 647083 T3181 oasc.LeaderElector$ElectionWatcher.process WARN  org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /overseer_elect/election
   [junit4]   2> 	at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
   [junit4]   2> 	at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
   [junit4]   2> 	at org.apache.zookeeper.ZooKeeper.getChildren(ZooKeeper.java:1472)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:260)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:257)
   [junit4]   2> 	at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:73)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient.getChildren(SolrZkClient.java:257)
   [junit4]   2> 	at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:94)
   [junit4]   2> 	at org.apache.solr.cloud.LeaderElector.access$200(LeaderElector.java:55)
   [junit4]   2> 	at org.apache.solr.cloud.LeaderElector$ElectionWatcher.process(LeaderElector.java:303)
   [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> 647083 T3181 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
   [junit4]   2> NOTE: leaving temporary files on disk at: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solr.cloud.OverseerRolesTest-E651CF2EC91217C0-001
   [junit4]   2> NOTE: test params are: codec=CheapBastard, sim=DefaultSimilarity, locale=ro_RO, timezone=Pacific/Saipan
   [junit4]   2> NOTE: Linux 3.8.0-39-generic i386/Oracle Corporation 1.8.0_05 (32-bit)/cpus=8,threads=1,free=46945680,total=170942464
   [junit4]   2> NOTE: All tests run in this JVM: [SolrXmlInZkTest, CurrencyFieldOpenExchangeTest, SolrRequestParserTest, DeleteInactiveReplicaTest, TestCollationField, TestInfoStreamLogging, TestRandomFaceting, TestSolrXmlPersistence, TestQuerySenderNoQuery, DefaultValueUpdateProcessorTest, SuggesterWFSTTest, TestDynamicFieldResource, TestPartialUpdateDeduplication, TestHighlightDedupGrouping, SimplePostToolTest, CollectionsAPIDistributedZkTest, LeaderElectionIntegrationTest, TestFastOutputStream, HdfsWriteToMultipleCollectionsTest, FullSolrCloudDistribCmdsTest, FileUtilsTest, TestClassNameShortening, TestMaxScoreQueryParser, TestStressLucene, SpellCheckCollatorTest, HdfsRecoveryZkTest, TestFastLRUCache, AlternateDirectoryTest, PrimUtilsTest, RAMDirectoryFactoryTest, TestCSVLoader, CoreContainerCoreInitFailuresTest, RequestHandlersTest, BadIndexSchemaTest, DisMaxRequestHandlerTest, SortByFunctionTest, TestCollapseQParserPlugin, TestSolr4Spatial, DirectUpdateHandlerTest, DistributedQueryComponentCustomSortTest, ResponseHeaderTest, TestDefaultSimilarityFactory, ConnectionManagerTest, SignatureUpdateProcessorFactoryTest, DistributedDebugComponentTest, TestSerializedLuceneMatchVersion, ChaosMonkeySafeLeaderTest, TestCustomSort, ConvertedLegacyTest, HdfsCollectionsAPIDistributedZkTest, TestZkChroot, TestDocBasedVersionConstraints, RemoteQueryErrorTest, TestFuzzyAnalyzedSuggestions, DebugComponentTest, OpenCloseCoreStressTest, SolrCoreCheckLockOnStartupTest, TestSolrJ, TestComponentsName, TestIndexSearcher, TestRequestStatusCollectionAPI, TestInitQParser, PreAnalyzedUpdateProcessorTest, HighlighterTest, TestOmitPositions, TestAtomicUpdateErrorCases, FieldAnalysisRequestHandlerTest, PingRequestHandlerTest, TestRecovery, TestIndexingPerformance, RequiredFieldsTest, TestUpdate, XmlUpdateRequestHandlerTest, TestSolrDeletionPolicy2, SolrPluginUtilsTest, TestFreeTextSuggestions, TestLazyCores, CurrencyFieldXmlFileTest, TestSolrQueryParserResource, TestBinaryField, OverseerRolesTest]
   [junit4] Completed on J1 in 42.39s, 1 test, 1 failure <<< FAILURES!

[...truncated 650 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:467: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:447: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:45: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/extra-targets.xml:37: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:189: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:496: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1297: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:921: There were test failures: 396 suites, 1640 tests, 1 failure, 36 ignored (15 assumptions)

Total time: 68 minutes 2 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 32bit/jdk1.8.0_05 -client -XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message