These are false failures ... the test is buggy because it relies on
wall-clock time, so if the machine is otherwise busy, it can false
fail.

I don't see how we can test this without false failures, unless we can
"mock in" a wall clock.  We'd need to fix
ControlledRealTimeReopenThread to allow pluggable clock
(System.nanoTime) and wait(msec).

I'll disable the test for now.

Mike McCandless

http://blog.mikemccandless.com


On Wed, Jun 4, 2014 at 5:29 PM,  <buil...@flonkings.com> wrote:
> Build: builds.flonkings.com/job/Lucene-4x-Linux-Java7-64-test-only/23286/
>
> 2 tests failed.
> FAILED:  
> junit.framework.TestSuite.org.apache.lucene.search.TestControlledRealTimeReopenThread
>
> Error Message:
> 1 thread leaked from SUITE scope at 
> org.apache.lucene.search.TestControlledRealTimeReopenThread:     1) 
> Thread[id=119, name=Thread-53, state=TIMED_WAITING, 
> group=TGRP-TestControlledRealTimeReopenThread]         at 
> sun.misc.Unsafe.park(Native Method)         at 
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)        
>  at 
> java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
>          at 
> org.apache.lucene.search.ControlledRealTimeReopenThread.run(ControlledRealTimeReopenThread.java:223)
>
> Stack Trace:
> com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from 
> SUITE scope at org.apache.lucene.search.TestControlledRealTimeReopenThread:
>    1) Thread[id=119, name=Thread-53, state=TIMED_WAITING, 
> group=TGRP-TestControlledRealTimeReopenThread]
>         at sun.misc.Unsafe.park(Native Method)
>         at 
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
>         at 
> java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
>         at 
> org.apache.lucene.search.ControlledRealTimeReopenThread.run(ControlledRealTimeReopenThread.java:223)
>         at __randomizedtesting.SeedInfo.seed([2651BE7982C65DFA]:0)
>
>
> REGRESSION:  
> org.apache.lucene.search.TestControlledRealTimeReopenThread.testCRTReopen
>
> Error Message:
> waited too long for generation 25376
>
> Stack Trace:
> java.lang.AssertionError: waited too long for generation 25376
>         at 
> __randomizedtesting.SeedInfo.seed([2651BE7982C65DFA:7471234D5601E583]:0)
>         at org.junit.Assert.fail(Assert.java:93)
>         at org.junit.Assert.assertTrue(Assert.java:43)
>         at 
> org.apache.lucene.search.TestControlledRealTimeReopenThread.testCRTReopen(TestControlledRealTimeReopenThread.java:519)
>         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:606)
>         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 
> 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 
> 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 1506 lines...]
>    [junit4] Suite: org.apache.lucene.search.TestControlledRealTimeReopenThread
>    [junit4]   2> NOTE: reproduce with: ant test  
> -Dtestcase=TestControlledRealTimeReopenThread -Dtests.method=testCRTReopen 
> -Dtests.seed=2651BE7982C65DFA -Dtests.slow=true -Dtests.locale=it_CH 
> -Dtests.timezone=America/Dawson_Creek -Dtests.file.encoding=UTF-8
>    [junit4] FAILURE 29.4s J4 | 
> TestControlledRealTimeReopenThread.testCRTReopen <<<
>    [junit4]    > Throwable #1: java.lang.AssertionError: waited too long for 
> generation 25376
>    [junit4]    >        at 
> __randomizedtesting.SeedInfo.seed([2651BE7982C65DFA:7471234D5601E583]:0)
>    [junit4]    >        at 
> org.apache.lucene.search.TestControlledRealTimeReopenThread.testCRTReopen(TestControlledRealTimeReopenThread.java:519)
>    [junit4]    >        at java.lang.Thread.run(Thread.java:745)
>    [junit4]   2> NOTE: leaving temporary files on disk at: 
> /var/lib/jenkins/workspace/Lucene-4x-Linux-Java7-64-test-only/checkout/lucene/build/core/test/J4/./lucene.search.TestControlledRealTimeReopenThread-2651BE7982C65DFA-001
>    [junit4]   2> NOTE: test params are: 
> codec=DummyCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=DUMMY,
>  chunkSize=137), 
> termVectorsFormat=CompressingTermVectorsFormat(compressionMode=DUMMY, 
> chunkSize=137)), sim=RandomSimilarityProvider(queryNorm=false,coord=no): 
> {extra14=IB SPL-L1, extra13=DFR I(F)L1, test=IB LL-L3(800.0), extra24=DFR 
> GLZ(0.3), extra17=BM25(k1=1.2,b=0.75), extra12=DFR I(ne)L2, extra31=DFR G1, 
> extra3=DFR I(ne)L1, extra29=DFR I(n)LZ(0.3), titleTokenized=IB LL-D1, 
> extra28=IB SPL-L2, extra15=DFR I(n)2, extra20=DFR I(F)L1, extra2=DFR I(F)B2, 
> extra26=DFR I(ne)1, extra16=DFR GL1, extra18=DFR I(ne)L3(800.0), body=DFR 
> I(ne)1}, locale=it_CH, timezone=America/Dawson_Creek
>    [junit4]   2> NOTE: Linux 3.2.0-26-generic amd64/Oracle Corporation 
> 1.7.0_55 (64-bit)/cpus=8,threads=1,free=203226976,total=274202624
>    [junit4]   2> NOTE: All tests run in this JVM: [TestPackedInts, 
> TestBinaryTerms, TestDuelingCodecs, TestLevenshteinAutomata, Nested, Nested2, 
> TestBinaryDocValuesUpdates, TestPagedBytes, TestDeterminism, 
> TestTopScoreDocCollector, TestToken, TestSegmentMerger, TestTryDelete, 
> TestDocTermOrdsRewriteMethod, TestRateLimitedDirectoryWrapper, TestSearch, 
> TestOmitNorms, TestSloppyPhraseQuery, TestMixedCodecs, Test2BDocs, 
> TestCrashCausesCorruptIndex, TestControlledRealTimeReopenThread]
>    [junit4]   2> NOTE: reproduce with: ant test  
> -Dtestcase=TestControlledRealTimeReopenThread -Dtests.seed=2651BE7982C65DFA 
> -Dtests.slow=true -Dtests.locale=it_CH -Dtests.timezone=America/Dawson_Creek 
> -Dtests.file.encoding=UTF-8
>    [junit4] ERROR   0.00s J4 | TestControlledRealTimeReopenThread (suite) <<<
>    [junit4]    > Throwable #1: 
> com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from 
> SUITE scope at org.apache.lucene.search.TestControlledRealTimeReopenThread:
>    [junit4]    >    1) Thread[id=119, name=Thread-53, state=TIMED_WAITING, 
> group=TGRP-TestControlledRealTimeReopenThread]
>    [junit4]    >         at sun.misc.Unsafe.park(Native Method)
>    [junit4]    >         at 
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
>    [junit4]    >         at 
> java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
>    [junit4]    >         at 
> org.apache.lucene.search.ControlledRealTimeReopenThread.run(ControlledRealTimeReopenThread.java:223)
>    [junit4]    >        at 
> __randomizedtesting.SeedInfo.seed([2651BE7982C65DFA]:0)
>    [junit4] Completed on J4 in 60.07s, 5 tests, 1 failure, 1 error <<< 
> FAILURES!
>
> [...truncated 26 lines...]
> BUILD FAILED
> /var/lib/jenkins/workspace/Lucene-4x-Linux-Java7-64-test-only/checkout/lucene/build.xml:49:
>  The following error occurred while executing this line:
> /var/lib/jenkins/workspace/Lucene-4x-Linux-Java7-64-test-only/checkout/lucene/common-build.xml:1297:
>  The following error occurred while executing this line:
> /var/lib/jenkins/workspace/Lucene-4x-Linux-Java7-64-test-only/checkout/lucene/common-build.xml:921:
>  There were test failures: 407 suites, 3341 tests, 1 suite-level error, 1 
> failure, 96 ignored (86 assumptions)
>
> Total time: 6 minutes 7 seconds
> Build step 'Invoke Ant' marked build as failure
> Recording test results
> Email was triggered for: Failure
> Sending email for trigger: Failure
>
>
>
>
> ---------------------------------------------------------------------
> To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
> For additional commands, e-mail: dev-h...@lucene.apache.org

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

Reply via email to