Build: https://builds.apache.org/job/Lucene-Solr-tests-only-trunk/14643/
1 tests failed.
REGRESSION: org.apache.solr.cloud.OverseerTest.testShardLeaderChange
Error Message:
Unexpected shard leader coll:collection1 shard:shard1 expected:<core[1]> but
was:<core[4]>
Stack Trace:
org.junit.ComparisonFailure: Unexpected shard leader coll:collection1
shard:shard1 expected:<core[1]> but was:<core[4]>
at
__randomizedtesting.SeedInfo.seed([E1CD79FC4836B0F7:3F9EFE0B52AE4506]:0)
at org.junit.Assert.assertEquals(Assert.java:125)
at
org.apache.solr.cloud.OverseerTest.verifyShardLeader(OverseerTest.java:522)
at
org.apache.solr.cloud.OverseerTest.testShardLeaderChange(OverseerTest.java:673)
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 11149 lines...]
[junit4] 2> at
org.apache.solr.cloud.Overseer$CloudStateUpdater.amILeader(Overseer.java:186)
[junit4] 2> at
org.apache.solr.cloud.Overseer$CloudStateUpdater.run(Overseer.java:111)
[junit4] 2> at java.lang.Thread.run(Thread.java:679)
[junit4] 2>
[junit4] 2> 17700 T1489 oasc.Overseer$CloudStateUpdater.amILeader
According to ZK I (id=87766509155713060-127.0.0.1:40338_solr-n_0000000010) am
no longer a leader.
[junit4] 2> 19638 T1408 oazs.PrepRequestProcessor.pRequest Processed
session termination for sessionid: 0x137cf2cd1670025
[junit4] 2> 19645 T1491 oaz.ClientCnxn$EventThread.run EventThread shut
down
[junit4] 2> 19645 T1451 oaz.ZooKeeper.close Session: 0x137cf2cd1670025
closed
[junit4] 2> 19645 T1405 oazs.NIOServerCnxn.closeSock Closed socket
connection for client /140.211.11.196:40376 which had sessionid
0x137cf2cd1670025
[junit4] 2> 19645 T1451 oaz.ZooKeeper.<init> Initiating client connection,
connectString=127.0.0.1:40338/solr sessionTimeout=10000
watcher=org.apache.solr.common.cloud.ConnectionManager@716f733f
[junit4] 2> 19646 T1493 oaz.ClientCnxn$SendThread.startConnect Opening
socket connection to server /127.0.0.1:40338
[junit4] 2> 19646 T1493 oaz.ClientCnxn$SendThread.primeConnection Socket
connection established to localhost/127.0.0.1:40338, initiating session
[junit4] 2> 19646 T1405 oazs.NIOServerCnxn$Factory.run Accepted socket
connection from /140.211.11.196:40377
[junit4] 2> 19646 T1405 oazs.NIOServerCnxn.readConnectRequest Client
attempting to establish new session at /140.211.11.196:40377
[junit4] 2> 19647 T1407 oazs.NIOServerCnxn.finishSessionInit Established
session 0x137cf2cd1670026 with negotiated timeout 10000 for client
/140.211.11.196:40377
[junit4] 2> 19647 T1493 oaz.ClientCnxn$SendThread.readConnectResult
Session establishment complete on server localhost/127.0.0.1:40338, sessionid =
0x137cf2cd1670026, negotiated timeout = 10000
[junit4] 2> 19647 T1494 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@716f733f
name:ZooKeeperConnection Watcher:127.0.0.1:40338/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 19660 T1451 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 19661 T1451 oasc.Overseer.<init> Overseer
(id=87766509155713062-127.0.0.1:40338_solr-n_0000000014) starting
[junit4] 2> 19661 T1408 oazs.PrepRequestProcessor.pRequest Got user-level
KeeperException when processing sessionid:0x137cf2cd1670026 type:create
cxid:0x8 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error
Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 19662 T1408 oazs.PrepRequestProcessor.pRequest Got user-level
KeeperException when processing sessionid:0x137cf2cd1670026 type:create
cxid:0x9 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error
Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 19670 T1495 oasc.Overseer$CloudStateUpdater.run Starting to
work on the main queue
[junit4] 2> 19821 T1492 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:186)
[junit4] 2> at
org.apache.solr.cloud.Overseer$CloudStateUpdater.run(Overseer.java:111)
[junit4] 2> at java.lang.Thread.run(Thread.java:679)
[junit4] 2>
[junit4] 2> 19821 T1492 oasc.Overseer$CloudStateUpdater.amILeader
According to ZK I (id=87766509155713061-127.0.0.1:40338_solr-n_0000000012) am
no longer a leader.
[junit4] 2> 23609 T1408 oazs.PrepRequestProcessor.pRequest Processed
session termination for sessionid: 0x137cf2cd1670026
[junit4] 2> 23610 T1494 oaz.ClientCnxn$EventThread.run EventThread shut
down
[junit4] 2> 23610 T1451 oaz.ZooKeeper.close Session: 0x137cf2cd1670026
closed
[junit4] 2> 23611 T1405 oazs.NIOServerCnxn.closeSock Closed socket
connection for client /140.211.11.196:40377 which had sessionid
0x137cf2cd1670026
[junit4] 2> 23611 T1451 oaz.ZooKeeper.<init> Initiating client connection,
connectString=127.0.0.1:40338/solr sessionTimeout=10000
watcher=org.apache.solr.common.cloud.ConnectionManager@288485e9
[junit4] 2> 23611 T1496 oaz.ClientCnxn$SendThread.startConnect Opening
socket connection to server /127.0.0.1:40338
[junit4] 2> 23612 T1496 oaz.ClientCnxn$SendThread.primeConnection Socket
connection established to localhost/127.0.0.1:40338, initiating session
[junit4] 2> 23612 T1405 oazs.NIOServerCnxn$Factory.run Accepted socket
connection from /140.211.11.196:40378
[junit4] 2> 23612 T1405 oazs.NIOServerCnxn.readConnectRequest Client
attempting to establish new session at /140.211.11.196:40378
[junit4] 2> 23613 T1407 oazs.NIOServerCnxn.finishSessionInit Established
session 0x137cf2cd1670027 with negotiated timeout 10000 for client
/140.211.11.196:40378
[junit4] 2> 23613 T1496 oaz.ClientCnxn$SendThread.readConnectResult
Session establishment complete on server localhost/127.0.0.1:40338, sessionid =
0x137cf2cd1670027, negotiated timeout = 10000
[junit4] 2> 23613 T1497 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@288485e9
name:ZooKeeperConnection Watcher:127.0.0.1:40338/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 23625 T1451 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 23627 T1451 oasc.Overseer.<init> Overseer
(id=87766509155713063-127.0.0.1:40338_solr-n_0000000016) starting
[junit4] 2> 23628 T1408 oazs.PrepRequestProcessor.pRequest Got user-level
KeeperException when processing sessionid:0x137cf2cd1670027 type:create
cxid:0x8 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error
Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 23629 T1408 oazs.PrepRequestProcessor.pRequest Got user-level
KeeperException when processing sessionid:0x137cf2cd1670027 type:create
cxid:0x9 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error
Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 23639 T1498 oasc.Overseer$CloudStateUpdater.run Starting to
work on the main queue
[junit4] 2> 23679 T1495 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:186)
[junit4] 2> at
org.apache.solr.cloud.Overseer$CloudStateUpdater.run(Overseer.java:111)
[junit4] 2> at java.lang.Thread.run(Thread.java:679)
[junit4] 2>
[junit4] 2> 23679 T1495 oasc.Overseer$CloudStateUpdater.amILeader
According to ZK I (id=87766509155713062-127.0.0.1:40338_solr-n_0000000014) am
no longer a leader.
[junit4] 2> 24244 T1408 oazs.PrepRequestProcessor.pRequest Processed
session termination for sessionid: 0x137cf2cd1670027
[junit4] 2> 24245 T1497 oaz.ClientCnxn$EventThread.run EventThread shut
down
[junit4] 2> 24245 T1451 oaz.ZooKeeper.close Session: 0x137cf2cd1670027
closed
[junit4] 2> 24245 T1405 oazs.NIOServerCnxn.closeSock Closed socket
connection for client /140.211.11.196:40378 which had sessionid
0x137cf2cd1670027
[junit4] 2> 24247 T1481 oascc.ZkStateReader$3.process Updating live nodes
[junit4] 2> 24247 T1483 oascc.ZkStateReader$3.process Updating live nodes
[junit4] 2> 24247 T1410 oascc.ZkStateReader$3.process Updating live nodes
[junit4] 2> 24247 T1408 oazs.PrepRequestProcessor.pRequest Processed
session termination for sessionid: 0x137cf2cd1670021
[junit4] 2> 24258 T1405 oazs.NIOServerCnxn.closeSock Closed socket
connection for client /140.211.11.196:40372 which had sessionid
0x137cf2cd1670021
[junit4] 2> 24258 T1285 oaz.ZooKeeper.close Session: 0x137cf2cd1670021
closed
[junit4] 2> 24260 T1483 oascc.ZkStateReader$3.process Updating live nodes
[junit4] 2> 24260 T1410 oascc.ZkStateReader$3.process Updating live nodes
[junit4] 2> 24260 T1408 oazs.PrepRequestProcessor.pRequest Processed
session termination for sessionid: 0x137cf2cd1670022
[junit4] 2> 24267 T1285 oaz.ZooKeeper.close Session: 0x137cf2cd1670022
closed
[junit4] 2> 24267 T1405 oazs.NIOServerCnxn.closeSock Closed socket
connection for client /140.211.11.196:40373 which had sessionid
0x137cf2cd1670022
[junit4] 2> 24267 T1408 oazs.PrepRequestProcessor.pRequest Processed
session termination for sessionid: 0x137cf2cd1670000
[junit4] 2> 24268 T1410 oaz.ClientCnxn$EventThread.run EventThread shut
down
[junit4] 2> 24268 T1405 oazs.NIOServerCnxn.closeSock Closed socket
connection for client /140.211.11.196:40339 which had sessionid
0x137cf2cd1670000
[junit4] 2> 24268 T1285 oaz.ZooKeeper.close Session: 0x137cf2cd1670000
closed
[junit4] 2> 24268 T1408 oazs.PrepRequestProcessor.run PrepRequestProcessor
exited loop!
[junit4] 2> 24268 T1407 oazs.SyncRequestProcessor.run SyncRequestProcessor
exited!
[junit4] 2> 24268 T1285 oazs.FinalRequestProcessor.shutdown shutdown of
request processor complete
[junit4] 2> 24538 T1405 oazs.NIOServerCnxn$Factory.run NIOServerCnxn
factory exited run method
[junit4] 2> 24538 T1285 oazs.FinalRequestProcessor.shutdown shutdown of
request processor complete
[junit4] 2> 24538 T1285 oas.SolrTestCaseJ4.tearDown ###Ending
testShardLeaderChange
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=OverseerTest
-Dtests.method=testShardLeaderChange -Dtests.seed=E1CD79FC4836B0F7
-Dtests.multiplier=3 -Dtests.locale=ko_KR
-Dtests.timezone=America/North_Dakota/New_Salem
-Dargs="-Dfile.encoding=ISO8859-1"
[junit4] 2>
[junit4] > (@AfterClass output)
[junit4] 2> 35268 T1285 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 35268 T1285 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 35268 T1285 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: test params are: codec=Lucene40: {},
sim=RandomSimilarityProvider(queryNorm=true,coord=false): {}, locale=ko_KR,
timezone=America/North_Dakota/New_Salem
[junit4] 2> NOTE: FreeBSD 9.0-RELEASE amd64/Sun Microsystems Inc. 1.6.0_32
(64-bit)/cpus=16,threads=5,free=91817032,total=275775488
[junit4] 2> NOTE: All tests run in this JVM: [TestPatternTokenizerFactory,
FieldMutatingUpdateProcessorTest, TestPHPSerializedResponseWriter,
TestMultiWordSynonyms, TestUtils, URLClassifyProcessorTest,
TestKeepFilterFactory, TestRealTimeGet, TestBeiderMorseFilterFactory,
TestQueryTypes, TestPseudoReturnFields, TestKStemFilterFactory,
DoubleMetaphoneFilterFactoryTest, TestGalicianMinimalStemFilterFactory,
TestSynonymFilterFactory, IndexBasedSpellCheckerTest,
TestPhoneticFilterFactory, TestArbitraryIndexDir, DocumentBuilderTest,
TestGroupingSearch, TestFastLRUCache, SnowballPorterFilterFactoryTest,
DistributedTermsComponentTest, UpdateRequestProcessorFactoryTest,
UpdateParamsTest, TestFaceting, TestNumberUtils, SolrPluginUtilsTest,
TestDistributedSearch, TestNGramFilters, LukeRequestHandlerTest,
BasicDistributedZkTest, TestGreekStemFilterFactory, SpatialFilterTest,
TestArabicFilters, TestPortugueseMinimalStemFilterFactory, FileUtilsTest,
TestElisionFilterFactory, TestDelimitedPayloadTokenFilterFactory,
TestGermanLightStemFilterFactory, AutoCommitTest,
TestBrazilianStemFilterFactory, NoCacheHeaderTest,
TestJapaneseBaseFormFilterFactory, RequiredFieldsTest, ReturnFieldsTest,
TestJapaneseKatakanaStemFilterFactory, SuggesterFSTTest, SuggesterWFSTTest,
TestGermanStemFilterFactory, RecoveryZkTest,
TestNorwegianMinimalStemFilterFactory, TestTrimFilterFactory,
DirectUpdateHandlerOptimizeTest, SolrInfoMBeanTest, SpellCheckComponentTest,
TestWriterPerf, TestSpanishLightStemFilterFactory, RAMDirectoryFactoryTest,
XsltUpdateRequestHandlerTest, TestBulgarianStemFilterFactory,
TestLuceneMatchVersion, TestHindiFilters, TestFrenchMinimalStemFilterFactory,
TestHyphenationCompoundWordTokenFilterFactory, TestPorterStemFilterFactory,
TestHTMLStripCharFilterFactory, TestEnglishMinimalStemFilterFactory,
TestHungarianLightStemFilterFactory, TestUpdate,
DocumentAnalysisRequestHandlerTest, SpellCheckCollatorTest, SuggesterTSTTest,
TestSwedishLightStemFilterFactory, TestHunspellStemFilterFactory,
FieldAnalysisRequestHandlerTest, StandardRequestHandlerTest,
TestMappingCharFilterFactory, TestPluginEnable, TestGalicianStemFilterFactory,
PeerSyncTest, FileBasedSpellCheckerTest, TestSuggestSpellingConverter,
TestDFRSimilarityFactory, OverseerTest]
[junit4] 2>
[junit4] Completed on J1 in 35.33s, 8 tests, 1 failure <<< FAILURES!
[...truncated 88 lines...]
[...truncated 11338 lines...]
[...truncated 11338 lines...]
[...truncated 11338 lines...]
[...truncated 11338 lines...]
[...truncated 11338 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]