lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From jenk...@sd-datasolutions.de
Subject [JENKINS] Lucene-Solr-4.x-Windows-Java6-64 - Build # 46 - Failure!
Date Mon, 11 Jun 2012 10:38:18 GMT
Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-4.x-Windows-Java6-64/46/

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

Error Message:
Thread threw an uncaught exception, thread: Thread[Lucene Merge Thread #0,6,]

Stack Trace:
java.lang.RuntimeException: Thread threw an uncaught exception, thread: Thread[Lucene Merge
Thread #0,6,]
	at com.carrotsearch.randomizedtesting.RunnerThreadGroup.processUncaught(RunnerThreadGroup.java:96)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:857)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$700(RandomizedRunner.java:132)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3$1.run(RandomizedRunner.java:669)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:695)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:734)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:745)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleReportUncaughtExceptions$1.evaluate(TestRuleReportUncaughtExceptions.java:68)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
	at org.apache.lucene.util.TestRuleIcuHack$1.evaluate(TestRuleIcuHack.java:51)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleNoInstanceHooksOverrides$1.evaluate(TestRuleNoInstanceHooksOverrides.java:53)
	at org.apache.lucene.util.TestRuleNoStaticHooksShadowing$1.evaluate(TestRuleNoStaticHooksShadowing.java:52)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:36)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:56)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:605)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$400(RandomizedRunner.java:132)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$2.run(RandomizedRunner.java:551)
Caused by: org.apache.lucene.index.MergePolicy$MergeException: org.apache.lucene.store.AlreadyClosedException:
this Directory is closed
	at __randomizedtesting.SeedInfo.seed([918444B633412A98]:0)
	at org.apache.lucene.index.ConcurrentMergeScheduler.handleMergeException(ConcurrentMergeScheduler.java:507)
	at org.apache.lucene.index.ConcurrentMergeScheduler$MergeThread.run(ConcurrentMergeScheduler.java:480)
Caused by: org.apache.lucene.store.AlreadyClosedException: this Directory is closed
	at org.apache.lucene.store.Directory.ensureOpen(Directory.java:244)
	at org.apache.lucene.store.FSDirectory.listAll(FSDirectory.java:241)
	at org.apache.lucene.index.IndexFileDeleter.refresh(IndexFileDeleter.java:321)
	at org.apache.lucene.index.IndexWriter.merge(IndexWriter.java:3149)
	at org.apache.lucene.index.ConcurrentMergeScheduler.doMerge(ConcurrentMergeScheduler.java:382)
	at org.apache.lucene.index.ConcurrentMergeScheduler$MergeThread.run(ConcurrentMergeScheduler.java:451)




Build Log:
[...truncated 22375 lines...]
   [junit4]   2> 50960 T349 oascc.ZkStateReader.updateCloudState Manual update of cluster
state initiated
   [junit4]   2> 50960 T349 oascc.ZkStateReader.updateCloudState Updating cloud state from
ZooKeeper... 
   [junit4]   2> 50961 T349 oasc.Overseer$CloudStateUpdater.run Announcing new cluster
state
   [junit4]   2> 50963 T209 oascc.ZkStateReader$2.process A cluster state change has occurred
   [junit4]   2> 50963 T205 oascc.ZkStateReader$2.process A cluster state change has occurred
   [junit4]   2> 50965 T250 oascc.ZkStateReader$2.process A cluster state change has occurred
   [junit4]   2> 50986 T155 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1794423774
   [junit4]   2> 50986 T155 oasc.RecoveryStrategy.close WARNING Stopping recovery for core
collection1 zkNodeName=127.0.0.1:61728_solr_collection1
   [junit4]   2> 50986 T155 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@4b919723
   [junit4]   2> 50991 T155 oasc.SolrCore.closeSearcher [collection1] Closing main searcher
on request.
   [junit4]   2> 50991 T155 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=6,autocommits=0,soft
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=952,cumulative_deletesById=452,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 50998 T155 oasc.RecoveryStrategy.close WARNING Stopping recovery for core
collection1 zkNodeName=127.0.0.1:61728_solr_collection1
   [junit4]   2> 51000 T162 oazs.PrepRequestProcessor.pRequest Processed session termination
for sessionid: 0x137db0fb5400007
   [junit4]   2> 51055 T157 oazs.NIOServerCnxn.closeSock Closed socket connection for client
/127.0.0.1:61752 which had sessionid 0x137db0fb5400007
   [junit4]   2> 51056 T205 oascc.ZkStateReader$3.process Updating live nodes
   [junit4]   2> 51056 T209 oascc.ZkStateReader$3.process Updating live nodes
   [junit4]   2> 51057 T155 oaz.ZooKeeper.close Session: 0x137db0fb5400007 closed
   [junit4]   2> 51061 T155 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 51063 T176 oasc.Overseer$CloudStateUpdater.amILeader WARNING  org.apache.zookeeper.KeeperException$SessionExpiredException:
KeeperErrorCode = Session expired for /overseer_elect/leader
   [junit4]   2> 	at org.apache.zookeeper.KeeperException.create(KeeperException.java:118)
   [junit4]   2> 	at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
   [junit4]   2> 	at org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:927)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:289)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:286)
   [junit4]   2> 	at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:65)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:286)
   [junit4]   2> 	at org.apache.solr.cloud.Overseer$CloudStateUpdater.amILeader(Overseer.java:174)
   [junit4]   2> 	at org.apache.solr.cloud.Overseer$CloudStateUpdater.run(Overseer.java:104)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:662)
   [junit4]   2> 
   [junit4]   2> 51063 T176 oasc.Overseer$CloudStateUpdater.amILeader According to ZK I
(id=87779578268876802-127.0.0.1:61720_solr-n_0000000000) am no longer a leader.
   [junit4]   2> 51483 T155 oejut.QueuedThreadPool.doStop WARNING 31 threads could not
be stopped
   [junit4]   2> 51484 T162 oazs.PrepRequestProcessor.pRequest Processed session termination
for sessionid: 0x137db0fb5400006
   [junit4]   2> 51489 T157 oazs.NIOServerCnxn.closeSock Closed socket connection for client
/127.0.0.1:61740 which had sessionid 0x137db0fb5400006
   [junit4]   2> 51489 T155 oaz.ZooKeeper.close Session: 0x137db0fb5400006 closed
   [junit4]   2> 51490 T209 oaz.ClientCnxn$EventThread.run EventThread shut down
   [junit4]   2> 51493 T162 oazs.PrepRequestProcessor.pRequest Processed session termination
for sessionid: 0x137db0fb5400005
   [junit4]   2> 51496 T157 oazs.NIOServerCnxn.closeSock Closed socket connection for client
/127.0.0.1:61735 which had sessionid 0x137db0fb5400005
   [junit4]   2> 51496 T155 oaz.ZooKeeper.close Session: 0x137db0fb5400005 closed
   [junit4]   2> 51496 T205 oaz.ClientCnxn$EventThread.run EventThread shut down
   [junit4]   2> 51496 T162 oazs.PrepRequestProcessor.run PrepRequestProcessor exited loop!
   [junit4]   2> 51496 T160 oazs.SyncRequestProcessor.run SyncRequestProcessor exited!
   [junit4]   2> 51497 T155 oazs.FinalRequestProcessor.shutdown shutdown of request processor
complete
   [junit4]   2> 51509 T348 oasc.Overseer$CloudStateUpdater.amILeader WARNING  org.apache.zookeeper.KeeperException$SessionExpiredException:
KeeperErrorCode = Session expired for /overseer_elect/leader
   [junit4]   2> 	at org.apache.zookeeper.KeeperException.create(KeeperException.java:118)
   [junit4]   2> 	at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
   [junit4]   2> 	at org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:927)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:289)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:286)
   [junit4]   2> 	at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:65)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:286)
   [junit4]   2> 	at org.apache.solr.cloud.Overseer$CloudStateUpdater.amILeader(Overseer.java:174)
   [junit4]   2> 	at org.apache.solr.cloud.Overseer$CloudStateUpdater.run(Overseer.java:104)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:662)
   [junit4]   2> 
   [junit4]   2> 51510 T348 oasc.Overseer$CloudStateUpdater.amILeader According to ZK I
(id=87779578268876803-127.0.0.1:61724_solr-n_0000000001) am no longer a leader.
   [junit4]   2> 51574 T349 oasc.Overseer$CloudStateUpdater.amILeader WARNING  org.apache.zookeeper.KeeperException$SessionExpiredException:
KeeperErrorCode = Session expired for /overseer_elect/leader
   [junit4]   2> 	at org.apache.zookeeper.KeeperException.create(KeeperException.java:118)
   [junit4]   2> 	at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
   [junit4]   2> 	at org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:927)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:289)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:286)
   [junit4]   2> 	at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:65)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:286)
   [junit4]   2> 	at org.apache.solr.cloud.Overseer$CloudStateUpdater.amILeader(Overseer.java:174)
   [junit4]   2> 	at org.apache.solr.cloud.Overseer$CloudStateUpdater.run(Overseer.java:104)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:662)
   [junit4]   2> 
   [junit4]   2> 51574 T349 oasc.Overseer$CloudStateUpdater.amILeader According to ZK I
(id=87779578268876807-127.0.0.1:61728_solr-n_0000000004) am no longer a leader.
   [junit4]   2> 51932 T158 oazs.SessionTrackerImpl.run SessionTrackerImpl exited loop!
   [junit4]   2> 52139 T188 oasc.Overseer$2.process WARNING ZooKeeper watch triggered,
but Solr cannot talk to ZK
   [junit4]   2> 52140 T188 oasc.Overseer$3$1.process WARNING ZooKeeper watch triggered,
but Solr cannot talk to ZK
   [junit4]   2> 52140 T188 oascc.ZkStateReader$3.process Updating live nodes
   [junit4]   2> 52140 T188 oascc.ZkStateReader$3.process WARNING ZooKeeper watch triggered,
but Solr cannot talk to ZK
   [junit4]   2> 52140 T188 oaz.ClientCnxn$EventThread.run EventThread shut down
   [junit4]   2> 52252 T250 oasc.Overseer$2.process WARNING ZooKeeper watch triggered,
but Solr cannot talk to ZK
   [junit4]   2> 52252 T250 oascc.ZkStateReader$3.process Updating live nodes
   [junit4]   2> 52252 T250 oascc.ZkStateReader$3.process WARNING ZooKeeper watch triggered,
but Solr cannot talk to ZK
   [junit4]   2> 52252 T250 oasc.Overseer$3$1.process WARNING ZooKeeper watch triggered,
but Solr cannot talk to ZK
   [junit4]   2> 52252 T250 oaz.ClientCnxn$EventThread.run EventThread shut down
   [junit4]   2> 54022 T157 oazs.NIOServerCnxn$Factory.run WARNING Ignoring unexpected
runtime exception java.nio.channels.CancelledKeyException
   [junit4]   2> 	at sun.nio.ch.SelectionKeyImpl.ensureValid(SelectionKeyImpl.java:55)
   [junit4]   2> 	at sun.nio.ch.SelectionKeyImpl.readyOps(SelectionKeyImpl.java:69)
   [junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxn$Factory.run(NIOServerCnxn.java:241)
   [junit4]   2> 
   [junit4]   2> 54023 T157 oazs.NIOServerCnxn$Factory.run NIOServerCnxn factory exited
run method
   [junit4]   2> 54024 T155 oazs.FinalRequestProcessor.shutdown shutdown of request processor
complete
   [junit4]   2> !!!! WARNING: best effort to remove C:\Jenkins\workspace\Lucene-Solr-4.x-Windows-Java6-64\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1339410068606\jetty2\index.20120611102131\_1c.fdt
FAILED !!!!!
   [junit4]   2> !!!! WARNING: best effort to remove C:\Jenkins\workspace\Lucene-Solr-4.x-Windows-Java6-64\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1339410068606\jetty2\index.20120611102131
FAILED !!!!!
   [junit4]   2> !!!! WARNING: best effort to remove C:\Jenkins\workspace\Lucene-Solr-4.x-Windows-Java6-64\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1339410068606\jetty2
FAILED !!!!!
   [junit4]   2> !!!! WARNING: best effort to remove C:\Jenkins\workspace\Lucene-Solr-4.x-Windows-Java6-64\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1339410068606
FAILED !!!!!
   [junit4]   2> 54131 T155 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=RecoveryZkTest -Dtests.method=testDistribSearch
-Dtests.seed=918444B633412A98 -Dtests.locale=de_DE -Dtests.timezone=Etc/Universal -Dargs="-Dfile.encoding=Cp1252"
   [junit4]   2>
   [junit4]    > (@AfterClass output)
   [junit4]   2> 54167 T155 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> NOTE: test params are: codec=Lucene40: {}, sim=DefaultSimilarity, locale=de_DE,
timezone=Etc/Universal
   [junit4]   2> NOTE: Windows 7 6.1 amd64/Sun Microsystems Inc. 1.6.0_32 (64-bit)/cpus=2,threads=2,free=48574800,total=136052736
   [junit4]   2> NOTE: All tests run in this JVM: [TestFiltering, HighlighterTest, DistributedTermsComponentTest,
StandardRequestHandlerTest, TestArabicFilters, TestHungarianLightStemFilterFactory, TestRemoveDuplicatesTokenFilterFactory,
TestIndexingPerformance, TestSearchPerf, TestPatternReplaceCharFilterFactory, TestBinaryField,
HighlighterConfigTest, TestSort, TestBinaryResponseWriter, TestBrazilianStemFilterFactory,
TestChineseFilterFactory, RecoveryZkTest]
   [junit4]   2> 
   [junit4] Completed in 54.18s, 1 test, 1 error <<< FAILURES!
[...truncated 1113 lines...]

[...truncated 23589 lines...]

[...truncated 23589 lines...]

[...truncated 23589 lines...]

[...truncated 23589 lines...]

[...truncated 23589 lines...]



Mime
View raw message