You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2012/06/06 16:15:13 UTC
[JENKINS] Lucene-Solr-tests-only-trunk - Build # 14607 - Failure
Build: https://builds.apache.org/job/Lucene-Solr-tests-only-trunk/14607/
1 tests failed.
REGRESSION: org.apache.solr.cloud.BasicDistributedZkTest.testDistribSearch
Error Message:
expected:<409> but was:<500>
Stack Trace:
java.lang.AssertionError: expected:<409> but was:<500>
at __randomizedtesting.SeedInfo.seed([EAD306743E5EE5FB:6B35886C490185C7]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at org.apache.solr.cloud.BasicDistributedZkTest.doOptimisticLockingAndUpdating(BasicDistributedZkTest.java:367)
at org.apache.solr.cloud.BasicDistributedZkTest.doTest(BasicDistributedZkTest.java:292)
at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:680)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:616)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1969)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$1100(RandomizedRunner.java:132)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:814)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:875)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:889)
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:32)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleReportUncaughtExceptions$1.evaluate(TestRuleReportUncaughtExceptions.java:68)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:821)
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)
Build Log:
[...truncated 11574 lines...]
[junit4] 2> 33165 T1071 oaz.ClientCnxn$SendThread.run Client session timed out, have not heard from server in 12001ms for sessionid 0x137c21f7c590005, closing socket connection and attempting reconnect
[junit4] 2> 33167 T1059 oaz.ClientCnxn$SendThread.run Client session timed out, have not heard from server in 12001ms for sessionid 0x137c21f7c590004, closing socket connection and attempting reconnect
[junit4] 2> 33266 T1015 oaz.ZooKeeper.close Session: 0x137c21f7c590003 closed
[junit4] 2> 33267 T1015 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 33319 T1015 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=285580881
[junit4] 2> 33320 T1015 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2a75dca3
[junit4] 2> 33322 T1015 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 33322 T1015 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=6,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=1,adds=1,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=20,cumulative_deletesById=0,cumulative_deletesByQuery=3,cumulative_errors=0}
[junit4] 2> 33410 T1015 C41 P60079 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4] 2> commit{dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-tests-only-trunk/checkout/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZkTest-1338991672404/jetty2/index,segFN=segments_2,generation=2,filenames=[_1_Lucene40_0.tim, _1_nrm.cfs, _0_Lucene40_0.tim, _0.fnm, _1_Lucene40_0.frq, _0_nrm.cfs, _0_Lucene40_0.prx, _1.fnm, _1_Lucene40_0.prx, _1_Lucene40_0.tip, _1_nrm.cfe, _0_Lucene40_0.tip, _1.fdx, _0_Lucene40_0.frq, _1.fdt, _1.si, _0_nrm.cfe, segments_2, _0.fdx, _0.si, _0.fdt]
[junit4] 2> commit{dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-tests-only-trunk/checkout/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZkTest-1338991672404/jetty2/index,segFN=segments_3,generation=3,filenames=[_1_Lucene40_0.tim, _2.si, _0_Lucene40_0.prx, _1.fnm, _1_Lucene40_0.tip, _2_Lucene40_0.tip, _2_nrm.cfe, _0_Lucene40_0.frq, _2_Lucene40_0.tim, _2_nrm.cfs, _0.si, _1_nrm.cfs, _0_Lucene40_0.tim, _0.fnm, _1_Lucene40_0.frq, _2.fdt, _0_nrm.cfs, _2.fdx, _2.fnm, _0_Lucene40_0.tip, _1_nrm.cfe, _1_Lucene40_0.prx, _1.fdx, _1.fdt, _2_Lucene40_0.frq, _2_Lucene40_0.prx, _1.si, _0_nrm.cfe, _0.fdx, _0.fdt, segments_3]
[junit4] 2> 33411 T1015 C41 P60079 oasc.SolrDeletionPolicy.updateCommits newest commit = 3
[junit4] 2> 34267 T1048 oasc.LeaderElector$1.process WARNING org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /overseer_elect/election
[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.getChildren(ZooKeeper.java:1249)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:266)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:263)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:65)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.getChildren(SolrZkClient.java:263)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:91)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.access$000(LeaderElector.java:57)
[junit4] 2> at org.apache.solr.cloud.LeaderElector$1.process(LeaderElector.java:120)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:531)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:507)
[junit4] 2>
[junit4] 2> 34267 T1048 oascc.ZkStateReader$3.process Updating live nodes
[junit4] 2> 34267 T1048 oascc.ZkStateReader$3.process WARNING ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 34267 T1048 oascc.ZkStateReader$2.process A cluster state change has occurred
[junit4] 2> 34268 T1048 oascc.ZkStateReader$2.process WARNING ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 34268 T1048 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4] 2> 34741 T1059 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost/127.0.0.1:60068
[junit4] 2> 35062 T1071 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost/127.0.0.1:60068
[junit4] 2> 39267 T1076 oaz.ClientCnxn$SendThread.run Client session timed out, have not heard from server in 10001ms for sessionid 0x137c21f7c590006, closing socket connection and attempting reconnect
[junit4] 2> 39541 T951 oaz.ClientCnxn$SendThread.run Client session timed out, have not heard from server in 12001ms for sessionid 0x137c21d99380010, closing socket connection and attempting reconnect
[junit4] 2> 40578 T1076 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost/127.0.0.1:60068
[junit4] 2> 41167 T951 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost/127.0.0.1:59563
[junit4] 2> 45267 T1071 oaz.ClientCnxn$SendThread.run Client session timed out, have not heard from server in 12001ms for sessionid 0x137c21f7c590005, closing socket connection and attempting reconnect
[junit4] 2> 45370 T1015 oaz.ZooKeeper.close Session: 0x137c21f7c590004 closed
[junit4] 2> 45370 T1015 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 45424 T1015 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1815278899
[junit4] 2> 45425 T1015 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@4478de9f
[junit4] 2> 45427 T1015 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 45428 T1015 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=27,cumulative_deletesById=0,cumulative_deletesByQuery=3,cumulative_errors=0}
[junit4] 2> 46547 T1071 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost/127.0.0.1:60068
[junit4] 2> 48273 T1060 oasc.LeaderElector$1.process WARNING org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /overseer_elect/election
[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.getChildren(ZooKeeper.java:1249)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:266)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:263)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:65)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.getChildren(SolrZkClient.java:263)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:91)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.access$000(LeaderElector.java:57)
[junit4] 2> at org.apache.solr.cloud.LeaderElector$1.process(LeaderElector.java:120)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:531)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:507)
[junit4] 2>
[junit4] 2> 48273 T1060 oascc.ZkStateReader$3.process Updating live nodes
[junit4] 2> 48274 T1060 oascc.ZkStateReader$3.process WARNING ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 48274 T1060 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@7dce092 name:ZooKeeperConnection Watcher:127.0.0.1:60068/solr got event WatchedEvent state:Disconnected type:None path:null path:null type:None
[junit4] 2> 48274 T1060 oascc.ZkStateReader$2.process A cluster state change has occurred
[junit4] 2> 48274 T1060 oascc.ZkStateReader$2.process WARNING ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 48274 T1060 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4] 2> 49369 T1076 oaz.ClientCnxn$SendThread.run Client session timed out, have not heard from server in 10001ms for sessionid 0x137c21f7c590006, closing socket connection and attempting reconnect
[junit4] 2> 50615 T1076 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost/127.0.0.1:60068
[junit4] 2> 51643 T951 oaz.ClientCnxn$SendThread.run Client session timed out, have not heard from server in 12001ms for sessionid 0x137c21d99380010, closing socket connection and attempting reconnect
[junit4] 2> 52859 T951 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost/127.0.0.1:59563
[junit4] 2> 57470 T1015 oaz.ZooKeeper.close Session: 0x137c21f7c590005 closed
[junit4] 2> 57471 T1015 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 57549 T1015 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4] 2> 59372 T1072 oascc.ZkStateReader$3.process WARNING ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 59372 T1072 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@4c8b8da6 name:ZooKeeperConnection Watcher:127.0.0.1:60068/solr got event WatchedEvent state:Disconnected type:None path:null path:null type:None
[junit4] 2> 59372 T1072 oascc.ZkStateReader$2.process A cluster state change has occurred
[junit4] 2> 59372 T1072 oascc.ZkStateReader$2.process WARNING ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 59372 T1072 oasc.LeaderElector$1.process WARNING org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /overseer_elect/election
[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.getChildren(ZooKeeper.java:1249)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:266)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:263)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:65)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.getChildren(SolrZkClient.java:263)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:91)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.access$000(LeaderElector.java:57)
[junit4] 2> at org.apache.solr.cloud.LeaderElector$1.process(LeaderElector.java:120)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:531)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:507)
[junit4] 2>
[junit4] 2> 59373 T1072 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4] 2> 59572 T1015 oaz.ZooKeeper.close Session: 0x137c21f7c590006 closed
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=BasicDistributedZkTest -Dtests.method=testDistribSearch -Dtests.seed=EAD306743E5EE5FB -Dtests.multiplier=3 -Dtests.locale=pl -Dtests.timezone=Indian/Mahe -Dargs="-Dfile.encoding=ISO8859-1"
[junit4] 2>
[junit4] > (@AfterClass output)
[junit4] 2> 59589 T1015 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: test params are: codec=Lucene40: {}, sim=RandomSimilarityProvider(queryNorm=true,coord=true): {}, locale=pl, timezone=Indian/Mahe
[junit4] 2> NOTE: FreeBSD 9.0-RELEASE amd64/Sun Microsystems Inc. 1.6.0_32 (64-bit)/cpus=16,threads=2,free=136263216,total=266993664
[junit4] 2> NOTE: All tests run in this JVM: [TestKeywordMarkerFilterFactory, TestPropInject, TestReversedWildcardFilterFactory, TestTrie, TestNorwegianLightStemFilterFactory, FullSolrCloudDistribCmdsTest, UniqFieldsUpdateProcessorFactoryTest, TestGermanStemFilterFactory, TestOmitPositions, DoubleMetaphoneFilterFactoryTest, StatsComponentTest, TestLMDirichletSimilarityFactory, MultiTermTest, TermVectorComponentTest, CSVRequestHandlerTest, ShowFileRequestHandlerTest, PluginInfoTest, TestQuerySenderNoQuery, TestStandardFactories, FieldAnalysisRequestHandlerTest, TestIndexSearcher, TestFoldingMultitermQuery, TestPropInjectDefaults, BinaryUpdateRequestHandlerTest, TestSwedishLightStemFilterFactory, DocumentBuilderTest, TestBeiderMorseFilterFactory, TestMultiWordSynonyms, LukeRequestHandlerTest, TestHyphenationCompoundWordTokenFilterFactory, TestUAX29URLEmailTokenizerFactory, TestSynonymFilterFactory, TestWriterPerf, SpellCheckComponentTest, TestItalianLightStemFilterFactory, TestGermanNormalizationFilterFactory, FieldMutatingUpdateProcessorTest, TestRemoveDuplicatesTokenFilterFactory, TestPHPSerializedResponseWriter, SampleTest, TestEnglishMinimalStemFilterFactory, UpdateParamsTest, ZkControllerTest, TestDocSet, PrimitiveFieldTypeTest, TestQuerySenderListener, LeaderElectionTest, OpenExchangeRatesOrgProviderTest, FullSolrCloudTest, TestWordDelimiterFilterFactory, TestPhoneticFilterFactory, TestDictionaryCompoundWordTokenFilterFactory, SnowballPorterFilterFactoryTest, TestJmxMonitoredMap, TestStopFilterFactory, SpellingQueryConverterTest, CloudStateUpdateTest, TestPorterStemFilterFactory, MinimalSchemaTest, TestUtils, CommonGramsFilterFactoryTest, HighlighterConfigTest, TestPersianNormalizationFilterFactory, BasicDistributedZkTest]
[junit4] 2>
[junit4] Completed on J0 in 59.59s, 1 test, 1 failure <<< FAILURES!
[...truncated 350 lines...]
[...truncated 12025 lines...]
[...truncated 12025 lines...]
[...truncated 12025 lines...]
[...truncated 12025 lines...]
[...truncated 12025 lines...]