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/04/13 18:46:21 UTC

[JENKINS] Lucene-Solr-tests-only-trunk - Build # 13082 - Failure

Build: https://builds.apache.org/job/Lucene-Solr-tests-only-trunk/13082/

2 tests failed.
REGRESSION:  org.apache.solr.cloud.BasicDistributedZkTest.testDistribSearch

Error Message:
java.lang.AssertionError: org.apache.solr.cloud.BasicDistributedZkTest.testDistribSearch: Insane FieldCache usage(s) found expected:<0> but was:<1>

Stack Trace:
java.lang.RuntimeException: java.lang.AssertionError: org.apache.solr.cloud.BasicDistributedZkTest.testDistribSearch: Insane FieldCache usage(s) found expected:<0> but was:<1>
	at org.apache.lucene.util.LuceneTestCase.tearDownInternal(LuceneTestCase.java:819)
	at org.apache.lucene.util.LuceneTestCase.access$900(LuceneTestCase.java:138)
	at org.apache.lucene.util.LuceneTestCase$InternalSetupTeardownRule$1.evaluate(LuceneTestCase.java:676)
	at org.apache.lucene.util.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:69)
	at org.apache.lucene.util.LuceneTestCase$TestResultInterceptorRule$1.evaluate(LuceneTestCase.java:591)
	at org.apache.lucene.util.UncaughtExceptionsRule$1.evaluate(UncaughtExceptionsRule.java:75)
	at org.apache.lucene.util.LuceneTestCase$SaveThreadAndTestNameRule$1.evaluate(LuceneTestCase.java:642)
	at org.junit.rules.RunRules.evaluate(RunRules.java:18)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
	at org.apache.lucene.util.LuceneTestCaseRunner.runChild(LuceneTestCaseRunner.java:164)
	at org.apache.lucene.util.LuceneTestCaseRunner.runChild(LuceneTestCaseRunner.java:57)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
	at org.apache.lucene.util.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:63)
	at org.apache.lucene.util.UncaughtExceptionsRule$1.evaluate(UncaughtExceptionsRule.java:75)
	at org.apache.lucene.util.StoreClassNameRule$1.evaluate(StoreClassNameRule.java:38)
	at org.apache.lucene.util.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:69)
	at org.junit.rules.RunRules.evaluate(RunRules.java:18)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
	at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:420)
	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:911)
	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
Caused by: java.lang.AssertionError: org.apache.solr.cloud.BasicDistributedZkTest.testDistribSearch: Insane FieldCache usage(s) found expected:<0> but was:<1>
	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.apache.lucene.util.LuceneTestCase.assertSaneFieldCaches(LuceneTestCase.java:930)
	at org.apache.lucene.util.LuceneTestCase.tearDownInternal(LuceneTestCase.java:809)
	... 28 more


FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.BasicDistributedZkTest

Error Message:
ERROR: SolrIndexSearcher opens=91 closes=89

Stack Trace:
junit.framework.AssertionFailedError: ERROR: SolrIndexSearcher opens=91 closes=89
	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner$3.addError(JUnitTestRunner.java:974)
	at junit.framework.TestResult.addError(TestResult.java:38)
	at junit.framework.JUnit4TestAdapterCache$1.testFailure(JUnit4TestAdapterCache.java:51)
	at org.junit.runner.notification.RunNotifier$4.notifyListener(RunNotifier.java:100)
	at org.junit.runner.notification.RunNotifier$SafeNotifier.run(RunNotifier.java:41)
	at org.junit.runner.notification.RunNotifier.fireTestFailure(RunNotifier.java:97)
	at org.junit.internal.runners.model.EachTestNotifier.addFailure(EachTestNotifier.java:26)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:306)
	at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:420)
	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:911)
	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
Caused by: java.lang.AssertionError: ERROR: SolrIndexSearcher opens=91 closes=89
	at org.junit.Assert.fail(Assert.java:93)
	at org.apache.solr.SolrTestCaseJ4.endTrackingSearchers(SolrTestCaseJ4.java:210)
	at org.apache.solr.SolrTestCaseJ4.afterClassSolrTestCase(SolrTestCaseJ4.java:99)
	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 org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:36)
	at org.apache.lucene.util.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:63)
	at org.apache.lucene.util.UncaughtExceptionsRule$1.evaluate(UncaughtExceptionsRule.java:75)
	at org.apache.lucene.util.StoreClassNameRule$1.evaluate(StoreClassNameRule.java:38)
	at org.apache.lucene.util.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:69)
	at org.junit.rules.RunRules.evaluate(RunRules.java:18)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
	... 4 more




Build Log (for compile errors):
[...truncated 10487 lines...]



Re: [JENKINS] Lucene-Solr-tests-only-trunk - Build # 13082 - Failure

Posted by Yonik Seeley <yo...@lucidimagination.com>.
I purged the field cache for these tests since "insanity" would often
be a normal outcome since we're sorting, faceting, getting stats, etc,
on the same field.

But I think there may be something wrong with the fieldcache insanity
checker stuff...  maybe it has to do with all the recent
reader/context refactoring in Lucene?  I couldn't get it to fail even
when I tried by adding things I knew would use both top-level and
segment field caches.  Not high priority though - the uses of top
fieldcaches are explicit in solr.

-Yonik
lucenerevolution.com - Lucene/Solr Open Source Search Conference.
Boston May 7-10

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
For additional commands, e-mail: dev-help@lucene.apache.org


Re: [JENKINS] Lucene-Solr-tests-only-trunk - Build # 13082 - Failure

Posted by Chris Male <ge...@gmail.com>.
Also, looking back through the failed build reports, this seems to have
begun on April 1st (in my part of the world).

On Sat, Apr 14, 2012 at 2:34 PM, Chris Male <ge...@gmail.com> wrote:

>
>
> On Sat, Apr 14, 2012 at 5:28 AM, Yonik Seeley <yo...@lucidimagination.com>wrote:
>
>> On Fri, Apr 13, 2012 at 12:46 PM, Apache Jenkins Server
>> <je...@builds.apache.org> wrote:
>> > Build:
>> https://builds.apache.org/job/Lucene-Solr-tests-only-trunk/13082/
>> >
>> > 2 tests failed.
>> > REGRESSION:
>>  org.apache.solr.cloud.BasicDistributedZkTest.testDistribSearch
>> >
>> > Error Message:
>> > java.lang.AssertionError:
>> org.apache.solr.cloud.BasicDistributedZkTest.testDistribSearch: Insane
>> FieldCache usage(s) found expected:<0> but was:<1>
>>
>> Does anyone know when this isane fieldcache stuff started happening
>> and if it's even a bug in these cases?
>> Would be helpful if the exception gave the actual field name that it
>> thinks is the issue.
>>
>
> It seems the information about the insanity is dumped to System.err.  I
> found this in the log:
>
> [junit] *** BEGIN org.apache.solr.cloud.BasicDistributedZkTest.testDistribSearch: Insane FieldCache usage(s) ***
>     [junit] SUBREADER: Found caches for descendants of StandardDirectoryReader(segments_2:10:nrt _0(4.0):C10 _1(4.0):C10 _2(4.0):C5)+a_si
>     [junit] 	'StandardDirectoryReader(segments_2:10:nrt _0(4.0):C10 _1(4.0):C10 _2(4.0):C5)'=>'a_si',class org.apache.lucene.search.FieldCache$DocTermsIndex,true=>org.apache.lucene.search.FieldCacheImpl$DocTermsIndexImpl#210835782 (size =~ 280 bytes)
>     [junit] 	'SegmentCoreReader(owner=_1(4.0):C10)'=>'a_si',class org.apache.lucene.search.FieldCache$DocTermsIndex,true=>org.apache.lucene.search.FieldCacheImpl$DocTermsIndexImpl#779556647 (size =~ 240 bytes)
>     [junit] 	'SegmentCoreReader(owner=_2(4.0):C5)'=>'a_si',class org.apache.lucene.search.FieldCache$DocTermsIndex,true=>org.apache.lucene.search.FieldCacheImpl$DocTermsIndexImpl#281632313 (size =~ 232 bytes)
>     [junit] 	'SegmentCoreReader(owner=_0(4.0):C10)'=>'a_si',class org.apache.lucene.search.FieldCache$DocTermsIndex,true=>org.apache.lucene.search.FieldCacheImpl$DocTermsIndexImpl#168970524 (size =~ 264 bytes)
>     [junit]
>     [junit] *** END org.apache.solr.cloud.BasicDistributedZkTest.testDistribSearch: Insane FieldCache usage(s) ***
>
>
> So it sees to be the field a_si, assuming I understand how it all works.
>
>
>> -Yonik
>> lucenerevolution.com - Lucene/Solr Open Source Search Conference.
>> Boston May 7-10
>>
>> ---------------------------------------------------------------------
>> To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
>> For additional commands, e-mail: dev-help@lucene.apache.org
>>
>>
>
>
> --
> Chris Male | Software Developer | DutchWorks | www.dutchworks.nl
>



-- 
Chris Male | Software Developer | DutchWorks | www.dutchworks.nl

Re: [JENKINS] Lucene-Solr-tests-only-trunk - Build # 13082 - Failure

Posted by Chris Male <ge...@gmail.com>.
On Sat, Apr 14, 2012 at 5:28 AM, Yonik Seeley <yo...@lucidimagination.com>wrote:

> On Fri, Apr 13, 2012 at 12:46 PM, Apache Jenkins Server
> <je...@builds.apache.org> wrote:
> > Build: https://builds.apache.org/job/Lucene-Solr-tests-only-trunk/13082/
> >
> > 2 tests failed.
> > REGRESSION:
>  org.apache.solr.cloud.BasicDistributedZkTest.testDistribSearch
> >
> > Error Message:
> > java.lang.AssertionError:
> org.apache.solr.cloud.BasicDistributedZkTest.testDistribSearch: Insane
> FieldCache usage(s) found expected:<0> but was:<1>
>
> Does anyone know when this isane fieldcache stuff started happening
> and if it's even a bug in these cases?
> Would be helpful if the exception gave the actual field name that it
> thinks is the issue.
>

It seems the information about the insanity is dumped to System.err.  I
found this in the log:

[junit] *** BEGIN
org.apache.solr.cloud.BasicDistributedZkTest.testDistribSearch: Insane
FieldCache usage(s) ***
    [junit] SUBREADER: Found caches for descendants of
StandardDirectoryReader(segments_2:10:nrt _0(4.0):C10 _1(4.0):C10
_2(4.0):C5)+a_si
    [junit] 	'StandardDirectoryReader(segments_2:10:nrt _0(4.0):C10
_1(4.0):C10 _2(4.0):C5)'=>'a_si',class
org.apache.lucene.search.FieldCache$DocTermsIndex,true=>org.apache.lucene.search.FieldCacheImpl$DocTermsIndexImpl#210835782
(size =~ 280 bytes)
    [junit] 	'SegmentCoreReader(owner=_1(4.0):C10)'=>'a_si',class
org.apache.lucene.search.FieldCache$DocTermsIndex,true=>org.apache.lucene.search.FieldCacheImpl$DocTermsIndexImpl#779556647
(size =~ 240 bytes)
    [junit] 	'SegmentCoreReader(owner=_2(4.0):C5)'=>'a_si',class
org.apache.lucene.search.FieldCache$DocTermsIndex,true=>org.apache.lucene.search.FieldCacheImpl$DocTermsIndexImpl#281632313
(size =~ 232 bytes)
    [junit] 	'SegmentCoreReader(owner=_0(4.0):C10)'=>'a_si',class
org.apache.lucene.search.FieldCache$DocTermsIndex,true=>org.apache.lucene.search.FieldCacheImpl$DocTermsIndexImpl#168970524
(size =~ 264 bytes)
    [junit]
    [junit] *** END
org.apache.solr.cloud.BasicDistributedZkTest.testDistribSearch: Insane
FieldCache usage(s) ***


So it sees to be the field a_si, assuming I understand how it all works.


> -Yonik
> lucenerevolution.com - Lucene/Solr Open Source Search Conference.
> Boston May 7-10
>
> ---------------------------------------------------------------------
> To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
> For additional commands, e-mail: dev-help@lucene.apache.org
>
>


-- 
Chris Male | Software Developer | DutchWorks | www.dutchworks.nl

Re: [JENKINS] Lucene-Solr-tests-only-trunk - Build # 13082 - Failure

Posted by Yonik Seeley <yo...@lucidimagination.com>.
On Fri, Apr 13, 2012 at 12:46 PM, Apache Jenkins Server
<je...@builds.apache.org> wrote:
> Build: https://builds.apache.org/job/Lucene-Solr-tests-only-trunk/13082/
>
> 2 tests failed.
> REGRESSION:  org.apache.solr.cloud.BasicDistributedZkTest.testDistribSearch
>
> Error Message:
> java.lang.AssertionError: org.apache.solr.cloud.BasicDistributedZkTest.testDistribSearch: Insane FieldCache usage(s) found expected:<0> but was:<1>

Does anyone know when this isane fieldcache stuff started happening
and if it's even a bug in these cases?
Would be helpful if the exception gave the actual field name that it
thinks is the issue.

-Yonik
lucenerevolution.com - Lucene/Solr Open Source Search Conference.
Boston May 7-10

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
For additional commands, e-mail: dev-help@lucene.apache.org