You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2014/05/25 23:47:33 UTC
[JENKINS] Lucene-Solr-4.x-Linux (32bit/jdk1.8.0_05) - Build # 10266
- Failure!
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
Re: [JENKINS] Lucene-Solr-4.x-Linux (32bit/jdk1.8.0_20-ea-b15) -
Build # 10267 - Still Failing!
Posted by Robert Muir <rc...@gmail.com>.
I committed a fix, this test had a useless newSearcher. I think it is
confusing in the following ways:
* newSearcher should ensure when it creates an executor that it is
totally clear such an executor was created from newSearcher(). Just
describing threads as "LuceneTestCase" is bullshit
* newSearcher should be careful exactly which reader it registers the
close hook on. Currently it can wrap the reader behind the scenes, but
if the wrong (say a wrapper) reader gets the close hook, it will never
shut down the executor.
We should fix this stuff as a followup.
On Mon, May 26, 2014 at 6:08 PM, Robert Muir <rc...@gmail.com> wrote:
> this reproduces.
>
> On Mon, May 26, 2014 at 1:32 AM, Policeman Jenkins Server
> <je...@thetaphi.de> wrote:
>> Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/10267/
>> Java: 32bit/jdk1.8.0_20-ea-b15 -server -XX:+UseG1GC
>>
>> 2 tests failed.
>> FAILED: junit.framework.TestSuite.org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest
>>
>> Error Message:
>> 2 threads leaked from SUITE scope at org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest: 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745) 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745)
>>
>> Stack Trace:
>> com.carrotsearch.randomizedtesting.ThreadLeakError: 2 threads leaked from SUITE scope at org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest:
>> 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
>> at sun.misc.Unsafe.park(Native Method)
>> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
>> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
>> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
>> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
>> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
>> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
>> at java.lang.Thread.run(Thread.java:745)
>> 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
>> at sun.misc.Unsafe.park(Native Method)
>> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
>> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
>> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
>> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
>> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
>> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
>> at java.lang.Thread.run(Thread.java:745)
>> at __randomizedtesting.SeedInfo.seed([FA64877FF1E6DD8A]:0)
>>
>>
>> FAILED: junit.framework.TestSuite.org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest
>>
>> Error Message:
>> There are still zombie threads that couldn't be terminated: 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745) 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745)
>>
>> Stack Trace:
>> com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
>> 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
>> at sun.misc.Unsafe.park(Native Method)
>> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
>> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
>> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
>> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
>> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
>> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
>> at java.lang.Thread.run(Thread.java:745)
>> 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
>> at sun.misc.Unsafe.park(Native Method)
>> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
>> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
>> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
>> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
>> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
>> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
>> at java.lang.Thread.run(Thread.java:745)
>> at __randomizedtesting.SeedInfo.seed([FA64877FF1E6DD8A]:0)
>>
>>
>>
>>
>> Build Log:
>> [...truncated 6974 lines...]
>> [junit4] Suite: org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest
>> [junit4] 2> трав. 25, 2014 7:32:16 PM WhitespaceTokenizer initialize
>> [junit4] 2> INFO: "Whitespace tokenizer successfully initialized"
>> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer typeSystemInit
>> [junit4] 2> INFO: "Whitespace tokenizer typesystem initialized"
>> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
>> [junit4] 2> INFO: "Whitespace tokenizer starts processing"
>> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
>> [junit4] 2> INFO: "Whitespace tokenizer finished processing"
>> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
>> [junit4] 2> INFO: "Whitespace tokenizer starts processing"
>> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
>> [junit4] 2> INFO: "Whitespace tokenizer finished processing"
>> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
>> [junit4] 2> INFO: "Whitespace tokenizer starts processing"
>> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
>> [junit4] 2> INFO: "Whitespace tokenizer finished processing"
>> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
>> [junit4] 2> INFO: "Whitespace tokenizer starts processing"
>> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
>> [junit4] 2> INFO: "Whitespace tokenizer finished processing"
>> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer initialize
>> [junit4] 2> INFO: "Whitespace tokenizer successfully initialized"
>> [junit4] 2> трав. 25, 2014 7:32:22 PM WhitespaceTokenizer typeSystemInit
>> [junit4] 2> INFO: "Whitespace tokenizer typesystem initialized"
>> [junit4] 2> трав. 25, 2014 7:32:22 PM WhitespaceTokenizer process
>> [junit4] 2> INFO: "Whitespace tokenizer starts processing"
>> [junit4] 2> трав. 25, 2014 7:32:22 PM WhitespaceTokenizer process
>> [junit4] 2> INFO: "Whitespace tokenizer finished processing"
>> [junit4] 2> May 25, 2014 11:32:24 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
>> [junit4] 2> WARNING: Will linger awaiting termination of 2 leaked thread(s).
>> [junit4] 2> May 25, 2014 11:32:44 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
>> [junit4] 2> SEVERE: 2 threads leaked from SUITE scope at org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest:
>> [junit4] 2> 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
>> [junit4] 2> at sun.misc.Unsafe.park(Native Method)
>> [junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
>> [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
>> [junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
>> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
>> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
>> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
>> [junit4] 2> at java.lang.Thread.run(Thread.java:745)
>> [junit4] 2> 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
>> [junit4] 2> at sun.misc.Unsafe.park(Native Method)
>> [junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
>> [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
>> [junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
>> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
>> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
>> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
>> [junit4] 2> at java.lang.Thread.run(Thread.java:745)
>> [junit4] 2> May 25, 2014 11:32:44 PM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
>> [junit4] 2> INFO: Starting to interrupt leaked threads:
>> [junit4] 2> 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
>> [junit4] 2> 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
>> [junit4] 2> May 25, 2014 11:32:47 PM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
>> [junit4] 2> SEVERE: There are still zombie threads that couldn't be terminated:
>> [junit4] 2> 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
>> [junit4] 2> at sun.misc.Unsafe.park(Native Method)
>> [junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
>> [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
>> [junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
>> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
>> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
>> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
>> [junit4] 2> at java.lang.Thread.run(Thread.java:745)
>> [junit4] 2> 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
>> [junit4] 2> at sun.misc.Unsafe.park(Native Method)
>> [junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
>> [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
>> [junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
>> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
>> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
>> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
>> [junit4] 2> at java.lang.Thread.run(Thread.java:745)
>> [junit4] 2> NOTE: test params are: codec=Lucene46: {dummy=FST41, contents=FST41, title=FST41}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=no): {}, locale=uk_UA, timezone=America/St_Lucia
>> [junit4] 2> NOTE: Linux 3.8.0-39-generic i386/Oracle Corporation 1.8.0_20-ea (32-bit)/cpus=8,threads=3,free=112905040,total=224395264
>> [junit4] 2> NOTE: All tests run in this JVM: [UIMABaseAnalyzerTest]
>> [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=UIMABaseAnalyzerTest -Dtests.seed=FA64877FF1E6DD8A -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=uk_UA -Dtests.timezone=America/St_Lucia -Dtests.file.encoding=UTF-8
>> [junit4] ERROR 0.00s | UIMABaseAnalyzerTest (suite) <<<
>> [junit4] > Throwable #1: com.carrotsearch.randomizedtesting.ThreadLeakError: 2 threads leaked from SUITE scope at org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest:
>> [junit4] > 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
>> [junit4] > at sun.misc.Unsafe.park(Native Method)
>> [junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
>> [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
>> [junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
>> [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
>> [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
>> [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
>> [junit4] > at java.lang.Thread.run(Thread.java:745)
>> [junit4] > 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
>> [junit4] > at sun.misc.Unsafe.park(Native Method)
>> [junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
>> [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
>> [junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
>> [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
>> [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
>> [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
>> [junit4] > at java.lang.Thread.run(Thread.java:745)
>> [junit4] > at __randomizedtesting.SeedInfo.seed([FA64877FF1E6DD8A]:0)Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
>> [junit4] > 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
>> [junit4] > at sun.misc.Unsafe.park(Native Method)
>> [junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
>> [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
>> [junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
>> [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
>> [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
>> [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
>> [junit4] > at java.lang.Thread.run(Thread.java:745)
>> [junit4] > 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
>> [junit4] > at sun.misc.Unsafe.park(Native Method)
>> [junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
>> [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
>> [junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
>> [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
>> [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
>> [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
>> [junit4] > at java.lang.Thread.run(Thread.java:745)
>> [junit4] > at __randomizedtesting.SeedInfo.seed([FA64877FF1E6DD8A]:0)
>> [junit4] Completed in 31.98s, 4 tests, 2 errors <<< FAILURES!
>>
>> [...truncated 12 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/lucene/build.xml:539: The following error occurred while executing this line:
>> /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:2017: The following error occurred while executing this line:
>> /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/analysis/build.xml:106: The following error occurred while executing this line:
>> /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/analysis/build.xml:38: The following error occurred while executing this line:
>> /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/module-build.xml:60: 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: 5 suites, 12 tests, 2 suite-level errors, 2 ignored
>>
>> Total time: 30 minutes 55 seconds
>> Build step 'Invoke Ant' marked build as failure
>> Description set: Java: 32bit/jdk1.8.0_20-ea-b15 -server -XX:+UseG1GC
>> Archiving artifacts
>> Recording test results
>> Email was triggered for: Failure
>> Sending email for trigger: Failure
>>
>>
>>
>>
>> ---------------------------------------------------------------------
>> To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
>> For additional commands, e-mail: dev-help@lucene.apache.org
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
For additional commands, e-mail: dev-help@lucene.apache.org
Re: [JENKINS] Lucene-Solr-4.x-Linux (32bit/jdk1.8.0_20-ea-b15) -
Build # 10267 - Still Failing!
Posted by Robert Muir <rc...@gmail.com>.
this reproduces.
On Mon, May 26, 2014 at 1:32 AM, Policeman Jenkins Server
<je...@thetaphi.de> wrote:
> Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/10267/
> Java: 32bit/jdk1.8.0_20-ea-b15 -server -XX:+UseG1GC
>
> 2 tests failed.
> FAILED: junit.framework.TestSuite.org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest
>
> Error Message:
> 2 threads leaked from SUITE scope at org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest: 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745) 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745)
>
> Stack Trace:
> com.carrotsearch.randomizedtesting.ThreadLeakError: 2 threads leaked from SUITE scope at org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest:
> 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
> at sun.misc.Unsafe.park(Native Method)
> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> at java.lang.Thread.run(Thread.java:745)
> 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
> at sun.misc.Unsafe.park(Native Method)
> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> at java.lang.Thread.run(Thread.java:745)
> at __randomizedtesting.SeedInfo.seed([FA64877FF1E6DD8A]:0)
>
>
> FAILED: junit.framework.TestSuite.org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest
>
> Error Message:
> There are still zombie threads that couldn't be terminated: 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745) 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745)
>
> Stack Trace:
> com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
> 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
> at sun.misc.Unsafe.park(Native Method)
> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> at java.lang.Thread.run(Thread.java:745)
> 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
> at sun.misc.Unsafe.park(Native Method)
> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> at java.lang.Thread.run(Thread.java:745)
> at __randomizedtesting.SeedInfo.seed([FA64877FF1E6DD8A]:0)
>
>
>
>
> Build Log:
> [...truncated 6974 lines...]
> [junit4] Suite: org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest
> [junit4] 2> трав. 25, 2014 7:32:16 PM WhitespaceTokenizer initialize
> [junit4] 2> INFO: "Whitespace tokenizer successfully initialized"
> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer typeSystemInit
> [junit4] 2> INFO: "Whitespace tokenizer typesystem initialized"
> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
> [junit4] 2> INFO: "Whitespace tokenizer starts processing"
> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
> [junit4] 2> INFO: "Whitespace tokenizer finished processing"
> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
> [junit4] 2> INFO: "Whitespace tokenizer starts processing"
> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
> [junit4] 2> INFO: "Whitespace tokenizer finished processing"
> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
> [junit4] 2> INFO: "Whitespace tokenizer starts processing"
> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
> [junit4] 2> INFO: "Whitespace tokenizer finished processing"
> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
> [junit4] 2> INFO: "Whitespace tokenizer starts processing"
> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
> [junit4] 2> INFO: "Whitespace tokenizer finished processing"
> [junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer initialize
> [junit4] 2> INFO: "Whitespace tokenizer successfully initialized"
> [junit4] 2> трав. 25, 2014 7:32:22 PM WhitespaceTokenizer typeSystemInit
> [junit4] 2> INFO: "Whitespace tokenizer typesystem initialized"
> [junit4] 2> трав. 25, 2014 7:32:22 PM WhitespaceTokenizer process
> [junit4] 2> INFO: "Whitespace tokenizer starts processing"
> [junit4] 2> трав. 25, 2014 7:32:22 PM WhitespaceTokenizer process
> [junit4] 2> INFO: "Whitespace tokenizer finished processing"
> [junit4] 2> May 25, 2014 11:32:24 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
> [junit4] 2> WARNING: Will linger awaiting termination of 2 leaked thread(s).
> [junit4] 2> May 25, 2014 11:32:44 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
> [junit4] 2> SEVERE: 2 threads leaked from SUITE scope at org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest:
> [junit4] 2> 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
> [junit4] 2> at sun.misc.Unsafe.park(Native Method)
> [junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
> [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
> [junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> [junit4] 2> at java.lang.Thread.run(Thread.java:745)
> [junit4] 2> 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
> [junit4] 2> at sun.misc.Unsafe.park(Native Method)
> [junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
> [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
> [junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> [junit4] 2> at java.lang.Thread.run(Thread.java:745)
> [junit4] 2> May 25, 2014 11:32:44 PM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
> [junit4] 2> INFO: Starting to interrupt leaked threads:
> [junit4] 2> 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
> [junit4] 2> 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
> [junit4] 2> May 25, 2014 11:32:47 PM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
> [junit4] 2> SEVERE: There are still zombie threads that couldn't be terminated:
> [junit4] 2> 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
> [junit4] 2> at sun.misc.Unsafe.park(Native Method)
> [junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
> [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
> [junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> [junit4] 2> at java.lang.Thread.run(Thread.java:745)
> [junit4] 2> 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
> [junit4] 2> at sun.misc.Unsafe.park(Native Method)
> [junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
> [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
> [junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
> [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> [junit4] 2> at java.lang.Thread.run(Thread.java:745)
> [junit4] 2> NOTE: test params are: codec=Lucene46: {dummy=FST41, contents=FST41, title=FST41}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=no): {}, locale=uk_UA, timezone=America/St_Lucia
> [junit4] 2> NOTE: Linux 3.8.0-39-generic i386/Oracle Corporation 1.8.0_20-ea (32-bit)/cpus=8,threads=3,free=112905040,total=224395264
> [junit4] 2> NOTE: All tests run in this JVM: [UIMABaseAnalyzerTest]
> [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=UIMABaseAnalyzerTest -Dtests.seed=FA64877FF1E6DD8A -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=uk_UA -Dtests.timezone=America/St_Lucia -Dtests.file.encoding=UTF-8
> [junit4] ERROR 0.00s | UIMABaseAnalyzerTest (suite) <<<
> [junit4] > Throwable #1: com.carrotsearch.randomizedtesting.ThreadLeakError: 2 threads leaked from SUITE scope at org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest:
> [junit4] > 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
> [junit4] > at sun.misc.Unsafe.park(Native Method)
> [junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
> [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
> [junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
> [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
> [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
> [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> [junit4] > at java.lang.Thread.run(Thread.java:745)
> [junit4] > 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
> [junit4] > at sun.misc.Unsafe.park(Native Method)
> [junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
> [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
> [junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
> [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
> [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
> [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> [junit4] > at java.lang.Thread.run(Thread.java:745)
> [junit4] > at __randomizedtesting.SeedInfo.seed([FA64877FF1E6DD8A]:0)Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
> [junit4] > 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
> [junit4] > at sun.misc.Unsafe.park(Native Method)
> [junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
> [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
> [junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
> [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
> [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
> [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> [junit4] > at java.lang.Thread.run(Thread.java:745)
> [junit4] > 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
> [junit4] > at sun.misc.Unsafe.park(Native Method)
> [junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
> [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
> [junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
> [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
> [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
> [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> [junit4] > at java.lang.Thread.run(Thread.java:745)
> [junit4] > at __randomizedtesting.SeedInfo.seed([FA64877FF1E6DD8A]:0)
> [junit4] Completed in 31.98s, 4 tests, 2 errors <<< FAILURES!
>
> [...truncated 12 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/lucene/build.xml:539: The following error occurred while executing this line:
> /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:2017: The following error occurred while executing this line:
> /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/analysis/build.xml:106: The following error occurred while executing this line:
> /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/analysis/build.xml:38: The following error occurred while executing this line:
> /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/module-build.xml:60: 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: 5 suites, 12 tests, 2 suite-level errors, 2 ignored
>
> Total time: 30 minutes 55 seconds
> Build step 'Invoke Ant' marked build as failure
> Description set: Java: 32bit/jdk1.8.0_20-ea-b15 -server -XX:+UseG1GC
> Archiving artifacts
> Recording test results
> Email was triggered for: Failure
> Sending email for trigger: Failure
>
>
>
>
> ---------------------------------------------------------------------
> To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
> For additional commands, e-mail: dev-help@lucene.apache.org
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
For additional commands, e-mail: dev-help@lucene.apache.org
[JENKINS] Lucene-Solr-4.x-Linux (32bit/jdk1.8.0_20-ea-b15) - Build
# 10267 - Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/10267/
Java: 32bit/jdk1.8.0_20-ea-b15 -server -XX:+UseG1GC
2 tests failed.
FAILED: junit.framework.TestSuite.org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest
Error Message:
2 threads leaked from SUITE scope at org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest: 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745) 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 2 threads leaked from SUITE scope at org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest:
1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
at __randomizedtesting.SeedInfo.seed([FA64877FF1E6DD8A]:0)
FAILED: junit.framework.TestSuite.org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest
Error Message:
There are still zombie threads that couldn't be terminated: 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745) 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
at __randomizedtesting.SeedInfo.seed([FA64877FF1E6DD8A]:0)
Build Log:
[...truncated 6974 lines...]
[junit4] Suite: org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest
[junit4] 2> трав. 25, 2014 7:32:16 PM WhitespaceTokenizer initialize
[junit4] 2> INFO: "Whitespace tokenizer successfully initialized"
[junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer typeSystemInit
[junit4] 2> INFO: "Whitespace tokenizer typesystem initialized"
[junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
[junit4] 2> INFO: "Whitespace tokenizer starts processing"
[junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
[junit4] 2> INFO: "Whitespace tokenizer finished processing"
[junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
[junit4] 2> INFO: "Whitespace tokenizer starts processing"
[junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
[junit4] 2> INFO: "Whitespace tokenizer finished processing"
[junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
[junit4] 2> INFO: "Whitespace tokenizer starts processing"
[junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
[junit4] 2> INFO: "Whitespace tokenizer finished processing"
[junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
[junit4] 2> INFO: "Whitespace tokenizer starts processing"
[junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer process
[junit4] 2> INFO: "Whitespace tokenizer finished processing"
[junit4] 2> трав. 25, 2014 7:32:19 PM WhitespaceTokenizer initialize
[junit4] 2> INFO: "Whitespace tokenizer successfully initialized"
[junit4] 2> трав. 25, 2014 7:32:22 PM WhitespaceTokenizer typeSystemInit
[junit4] 2> INFO: "Whitespace tokenizer typesystem initialized"
[junit4] 2> трав. 25, 2014 7:32:22 PM WhitespaceTokenizer process
[junit4] 2> INFO: "Whitespace tokenizer starts processing"
[junit4] 2> трав. 25, 2014 7:32:22 PM WhitespaceTokenizer process
[junit4] 2> INFO: "Whitespace tokenizer finished processing"
[junit4] 2> May 25, 2014 11:32:24 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 2 leaked thread(s).
[junit4] 2> May 25, 2014 11:32:44 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> SEVERE: 2 threads leaked from SUITE scope at org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest:
[junit4] 2> 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> May 25, 2014 11:32:44 PM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
[junit4] 2> 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
[junit4] 2> May 25, 2014 11:32:47 PM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> SEVERE: There are still zombie threads that couldn't be terminated:
[junit4] 2> 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> NOTE: test params are: codec=Lucene46: {dummy=FST41, contents=FST41, title=FST41}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=no): {}, locale=uk_UA, timezone=America/St_Lucia
[junit4] 2> NOTE: Linux 3.8.0-39-generic i386/Oracle Corporation 1.8.0_20-ea (32-bit)/cpus=8,threads=3,free=112905040,total=224395264
[junit4] 2> NOTE: All tests run in this JVM: [UIMABaseAnalyzerTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=UIMABaseAnalyzerTest -Dtests.seed=FA64877FF1E6DD8A -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=uk_UA -Dtests.timezone=America/St_Lucia -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s | UIMABaseAnalyzerTest (suite) <<<
[junit4] > Throwable #1: com.carrotsearch.randomizedtesting.ThreadLeakError: 2 threads leaked from SUITE scope at org.apache.lucene.analysis.uima.UIMABaseAnalyzerTest:
[junit4] > 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > at __randomizedtesting.SeedInfo.seed([FA64877FF1E6DD8A]:0)Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
[junit4] > 1) Thread[id=18, name=LuceneTestCase-1-thread-2, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > 2) Thread[id=17, name=LuceneTestCase-1-thread-1, state=WAITING, group=TGRP-UIMABaseAnalyzerTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > at __randomizedtesting.SeedInfo.seed([FA64877FF1E6DD8A]:0)
[junit4] Completed in 31.98s, 4 tests, 2 errors <<< FAILURES!
[...truncated 12 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/lucene/build.xml:539: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:2017: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/analysis/build.xml:106: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/analysis/build.xml:38: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/module-build.xml:60: 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: 5 suites, 12 tests, 2 suite-level errors, 2 ignored
Total time: 30 minutes 55 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 32bit/jdk1.8.0_20-ea-b15 -server -XX:+UseG1GC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure