I improved the verbosity for this test ... once it fails on windows again I'll look.
But this looks like it's just LUCENE-6684 again, where we had suppressed FNFE/NSFE on Windows because of pending deletions, but in LUCENE-6835 I removed part of that suppression ... Mike McCandless http://blog.mikemccandless.com On Sun, Feb 7, 2016 at 5:11 AM, Michael McCandless <luc...@mikemccandless.com> wrote: > I'll dig ... > > Mike McCandless > > http://blog.mikemccandless.com > > > On Sun, Feb 7, 2016 at 3:45 AM, Policeman Jenkins Server > <jenk...@thetaphi.de> wrote: >> Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/5603/ >> Java: 64bit/jdk1.8.0_72 -XX:+UseCompressedOops -XX:+UseSerialGC >> >> 2 tests failed. >> FAILED: org.apache.lucene.store.TestSimpleFSLockFactory.testStressLocks >> >> Error Message: >> IndexWriter hit unexpected exceptions >> >> Stack Trace: >> java.lang.AssertionError: IndexWriter hit unexpected exceptions >> at >> __randomizedtesting.SeedInfo.seed([4719CF214BAA3E97:192881DC5706F6F1]:0) >> at org.junit.Assert.fail(Assert.java:93) >> at org.junit.Assert.assertTrue(Assert.java:43) >> at >> org.apache.lucene.store.BaseLockFactoryTestCase.testStressLocks(BaseLockFactoryTestCase.java:180) >> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) >> at >> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) >> at >> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) >> at java.lang.reflect.Method.invoke(Method.java:498) >> at >> com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) >> at >> com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) >> at >> com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) >> at >> com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) >> at >> org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) >> at >> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) >> at >> org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) >> at >> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) >> at >> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) >> at >> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) >> at >> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) >> at >> com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809) >> at >> com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) >> at >> com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) >> at >> com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) >> at >> com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) >> at >> com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) >> at >> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) >> at >> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) >> at >> org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) >> at >> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) >> at >> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) >> 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:53) >> at >> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) >> at >> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) >> at >> org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) >> at >> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) >> at >> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) >> at java.lang.Thread.run(Thread.java:745) >> >> >> FAILED: org.apache.lucene.index.TestIndexWriter.testDeleteUnusedFiles >> >> Error Message: >> >> >> Stack Trace: >> java.lang.AssertionError >> at >> __randomizedtesting.SeedInfo.seed([4719CF214BAA3E97:F82F9DAE23F29378]:0) >> at org.junit.Assert.fail(Assert.java:92) >> at org.junit.Assert.assertTrue(Assert.java:43) >> at org.junit.Assert.assertTrue(Assert.java:54) >> at >> org.apache.lucene.index.TestIndexWriter.testDeleteUnusedFiles(TestIndexWriter.java:1322) >> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) >> at >> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) >> at >> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) >> at java.lang.reflect.Method.invoke(Method.java:498) >> at >> com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) >> at >> com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) >> at >> com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) >> at >> com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) >> at >> org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) >> at >> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) >> at >> org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) >> at >> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) >> at >> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) >> at >> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) >> at >> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) >> at >> com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809) >> at >> com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) >> at >> com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) >> at >> com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) >> at >> com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) >> at >> com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) >> at >> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) >> at >> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) >> at >> org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) >> at >> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) >> at >> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) >> 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:53) >> at >> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) >> at >> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) >> at >> org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) >> at >> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) >> at >> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) >> at java.lang.Thread.run(Thread.java:745) >> >> >> >> >> Build Log: >> [...truncated 425 lines...] >> [junit4] Suite: org.apache.lucene.store.TestSimpleFSLockFactory >> [junit4] 1> Stress Test Index Writer: close hit unexpected exception: >> java.nio.file.NoSuchFileException: >> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_4719CF214BAA3E97-001\tempDir-004\segments_9 >> [junit4] 1> java.nio.file.NoSuchFileException: >> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_4719CF214BAA3E97-001\tempDir-004\segments_9 >> [junit4] 1> at >> sun.nio.fs.WindowsException.translateToIOException(WindowsException.java:79) >> [junit4] 1> at >> sun.nio.fs.WindowsException.rethrowAsIOException(WindowsException.java:97) >> [junit4] 1> at >> sun.nio.fs.WindowsException.rethrowAsIOException(WindowsException.java:102) >> [junit4] 1> at >> sun.nio.fs.WindowsFileSystemProvider.implDelete(WindowsFileSystemProvider.java:269) >> [junit4] 1> at >> sun.nio.fs.AbstractFileSystemProvider.delete(AbstractFileSystemProvider.java:103) >> [junit4] 1> at >> org.apache.lucene.mockfile.FilterFileSystemProvider.delete(FilterFileSystemProvider.java:137) >> [junit4] 1> at >> org.apache.lucene.mockfile.FilterFileSystemProvider.delete(FilterFileSystemProvider.java:137) >> [junit4] 1> at >> org.apache.lucene.mockfile.FilterFileSystemProvider.delete(FilterFileSystemProvider.java:137) >> [junit4] 1> at >> org.apache.lucene.mockfile.FilterFileSystemProvider.delete(FilterFileSystemProvider.java:137) >> [junit4] 1> at >> org.apache.lucene.mockfile.FilterFileSystemProvider.delete(FilterFileSystemProvider.java:137) >> [junit4] 1> at java.nio.file.Files.delete(Files.java:1126) >> [junit4] 1> at >> org.apache.lucene.store.FSDirectory.privateDeleteFile(FSDirectory.java:368) >> [junit4] 1> at >> org.apache.lucene.store.FSDirectory.deletePendingFiles(FSDirectory.java:350) >> [junit4] 1> at >> org.apache.lucene.store.FSDirectory.maybeDeletePendingFiles(FSDirectory.java:361) >> [junit4] 1> at >> org.apache.lucene.store.FSDirectory.renameFile(FSDirectory.java:301) >> [junit4] 1> at >> org.apache.lucene.store.MockDirectoryWrapper.renameFile(MockDirectoryWrapper.java:228) >> [junit4] 1> at >> org.apache.lucene.store.LockValidatingDirectoryWrapper.renameFile(LockValidatingDirectoryWrapper.java:56) >> [junit4] 1> at >> org.apache.lucene.index.SegmentInfos.finishCommit(SegmentInfos.java:782) >> [junit4] 1> at >> org.apache.lucene.index.IndexWriter.finishCommit(IndexWriter.java:2987) >> [junit4] 1> at >> org.apache.lucene.index.IndexWriter.commitInternal(IndexWriter.java:2962) >> [junit4] 1> at >> org.apache.lucene.index.IndexWriter.shutdown(IndexWriter.java:1073) >> [junit4] 1> at >> org.apache.lucene.index.IndexWriter.close(IndexWriter.java:1116) >> [junit4] 1> at >> org.apache.lucene.store.BaseLockFactoryTestCase$WriterThread.run(BaseLockFactoryTestCase.java:263) >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.157Z; Thread-214]: init: >> current segments file is "segments_f"; >> deletionPolicy=org.apache.lucene.index.KeepOnlyLastCommitDeletionPolicy@2db45f34 >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.157Z; Thread-214]: init: load >> commit "segments_f" >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.158Z; Thread-214]: delete "[]" >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.158Z; Thread-214]: now >> checkpoint "_a(6.0.0):c10 _b(6.0.0):c1 _c(6.0.0):c1 _d(6.0.0):c1 >> _e(6.0.0):c1 _f(6.0.0):c1" [6 segments ; isCommit = false] >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.158Z; Thread-214]: delete "[]" >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.158Z; Thread-214]: 0 msec to >> checkpoint >> [junit4] 1> IW 16 [2016-02-07T08:41:33.160Z; Thread-214]: init: >> create=false >> [junit4] 1> IW 16 [2016-02-07T08:41:33.160Z; Thread-214]: >> [junit4] 1> >> dir=MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_4719CF214BAA3E97-001\tempDir-004 >> lockFactory=org.apache.lucene.store.SimpleFSLockFactory@468d3963) >> [junit4] 1> index=_a(6.0.0):c10 _b(6.0.0):c1 _c(6.0.0):c1 _d(6.0.0):c1 >> _e(6.0.0):c1 _f(6.0.0):c1 >> [junit4] 1> version=6.0.0 >> [junit4] 1> analyzer=org.apache.lucene.analysis.MockAnalyzer >> [junit4] 1> ramBufferSizeMB=16.0 >> [junit4] 1> maxBufferedDocs=-1 >> [junit4] 1> maxBufferedDeleteTerms=-1 >> [junit4] 1> mergedSegmentWarmer=null >> [junit4] 1> >> delPolicy=org.apache.lucene.index.KeepOnlyLastCommitDeletionPolicy >> [junit4] 1> commit=null >> [junit4] 1> openMode=APPEND >> [junit4] 1> >> similarity=org.apache.lucene.search.similarities.BM25Similarity >> [junit4] 1> mergeScheduler=ConcurrentMergeScheduler: maxThreadCount=-1, >> maxMergeCount=-1, ioThrottle=true >> [junit4] 1> codec=Asserting(Lucene60) >> [junit4] 1> infoStream=org.apache.lucene.util.PrintStreamInfoStream >> [junit4] 1> mergePolicy=[TieredMergePolicy: maxMergeAtOnce=10, >> maxMergeAtOnceExplicit=30, maxMergedSegmentMB=5120.0, floorSegmentMB=2.0, >> forceMergeDeletesPctAllowed=10.0, segmentsPerTier=10.0, >> maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1 >> [junit4] 1> >> indexerThreadPool=org.apache.lucene.index.DocumentsWriterPerThreadPool@4987dd52 >> [junit4] 1> readerPooling=false >> [junit4] 1> perThreadHardLimitMB=1945 >> [junit4] 1> useCompoundFile=true >> [junit4] 1> commitOnClose=true >> [junit4] 1> writer=org.apache.lucene.index.IndexWriter@35a0b2ea >> [junit4] 1> >> [junit4] 1> IW 16 [2016-02-07T08:41:33.160Z; Thread-214]: >> MMapDirectory.UNMAP_SUPPORTED=true >> [junit4] 1> IW 16 [2016-02-07T08:41:33.162Z; Thread-214]: now flush at >> close >> [junit4] 1> IW 16 [2016-02-07T08:41:33.162Z; Thread-214]: start >> flush: applyAllDeletes=true >> [junit4] 1> IW 16 [2016-02-07T08:41:33.162Z; Thread-214]: index >> before flush _a(6.0.0):c10 _b(6.0.0):c1 _c(6.0.0):c1 _d(6.0.0):c1 >> _e(6.0.0):c1 _f(6.0.0):c1 >> [junit4] 1> DW 16 [2016-02-07T08:41:33.162Z; Thread-214]: startFullFlush >> [junit4] 1> DW 16 [2016-02-07T08:41:33.162Z; Thread-214]: anyChanges? >> numDocsInRam=1 deletes=false hasTickets:false pendingChangesInFullFlush: >> false >> [junit4] 1> DWFC 16 [2016-02-07T08:41:33.162Z; Thread-214]: >> addFlushableState DocumentsWriterPerThread [pendingDeletes=gen=0, >> segment=_g, aborted=false, numDocsInRAM=1, deleteQueue=DWDQ: [ generation: 0 >> ]] >> [junit4] 1> DWPT 16 [2016-02-07T08:41:33.162Z; Thread-214]: flush >> postings as segment _g numDocs=1 >> [junit4] 1> IW 16 [2016-02-07T08:41:33.163Z; Thread-214]: 0 msec to >> write norms >> [junit4] 1> IW 16 [2016-02-07T08:41:33.163Z; Thread-214]: 0 msec to >> write docValues >> [junit4] 1> IW 16 [2016-02-07T08:41:33.163Z; Thread-214]: 0 msec to >> write points >> [junit4] 1> IW 16 [2016-02-07T08:41:33.163Z; Thread-214]: 0 msec to >> finish stored fields >> [junit4] 1> IW 16 [2016-02-07T08:41:33.165Z; Thread-214]: 1 msec to >> write postings and finish vectors >> [junit4] 1> IW 16 [2016-02-07T08:41:33.165Z; Thread-214]: 0 msec to >> write fieldInfos >> [junit4] 1> DWPT 16 [2016-02-07T08:41:33.165Z; Thread-214]: new segment >> has 0 deleted docs >> [junit4] 1> DWPT 16 [2016-02-07T08:41:33.165Z; Thread-214]: new segment >> has no vectors; norms; no docValues; prox; freqs >> [junit4] 1> DWPT 16 [2016-02-07T08:41:33.165Z; Thread-214]: >> flushedFiles=[_g.nvm, _g_Asserting_0.doc, _g_Asserting_0.tim, _g.fnm, >> _g_Asserting_0.tip, _g.nvd, _g.fdx, _g_Asserting_0.pos, _g.fdt] >> [junit4] 1> DWPT 16 [2016-02-07T08:41:33.165Z; Thread-214]: flushed >> codec=Asserting(Lucene60) >> [junit4] 1> DWPT 16 [2016-02-07T08:41:33.166Z; Thread-214]: flushed: >> segment=_g ramUsed=0.071 MB newFlushedSize=0.001 MB docs/MB=1,132.371 >> [junit4] 1> IW 16 [2016-02-07T08:41:33.166Z; Thread-214]: create >> compound file >> [junit4] 1> DWPT 16 [2016-02-07T08:41:33.169Z; Thread-214]: flush time >> 7.0877 msec >> [junit4] 1> DW 16 [2016-02-07T08:41:33.169Z; Thread-214]: >> publishFlushedSegment seg-private updates=null >> [junit4] 1> IW 16 [2016-02-07T08:41:33.169Z; Thread-214]: >> publishFlushedSegment >> [junit4] 1> IW 16 [2016-02-07T08:41:33.169Z; Thread-214]: publish sets >> newSegment delGen=1 seg=_g(6.0.0):c1 >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.169Z; Thread-214]: now >> checkpoint "_a(6.0.0):c10 _b(6.0.0):c1 _c(6.0.0):c1 _d(6.0.0):c1 >> _e(6.0.0):c1 _f(6.0.0):c1 _g(6.0.0):c1" [7 segments ; isCommit = false] >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.169Z; Thread-214]: delete "[]" >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.169Z; Thread-214]: 0 msec to >> checkpoint >> [junit4] 1> DW 16 [2016-02-07T08:41:33.169Z; Thread-214]: Thread-214 >> finishFullFlush success=true >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.169Z; Thread-214]: will delete >> new file "_g.nvm" >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.169Z; Thread-214]: will delete >> new file "_g_Asserting_0.doc" >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.169Z; Thread-214]: will delete >> new file "_g_Asserting_0.tim" >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.169Z; Thread-214]: will delete >> new file "_g.fnm" >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.169Z; Thread-214]: will delete >> new file "_g_Asserting_0.tip" >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.169Z; Thread-214]: will delete >> new file "_g.nvd" >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.169Z; Thread-214]: will delete >> new file "_g.fdx" >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.169Z; Thread-214]: will delete >> new file "_g_Asserting_0.pos" >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.169Z; Thread-214]: will delete >> new file "_g.fdt" >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.169Z; Thread-214]: delete >> "[_g.nvm, _g_Asserting_0.doc, _g_Asserting_0.tim, _g.fnm, >> _g_Asserting_0.tip, _g.nvd, _g.fdx, _g_Asserting_0.pos, _g.fdt]" >> [junit4] 1> IW 16 [2016-02-07T08:41:33.172Z; Thread-214]: apply all >> deletes during flush >> [junit4] 1> IW 16 [2016-02-07T08:41:33.172Z; Thread-214]: now apply all >> deletes for all segments maxDoc=16 >> [junit4] 1> BD 16 [2016-02-07T08:41:33.172Z; Thread-214]: applyDeletes: >> open segment readers took 0 msec >> [junit4] 1> BD 16 [2016-02-07T08:41:33.172Z; Thread-214]: applyDeletes: >> no segments; skipping >> [junit4] 1> BD 16 [2016-02-07T08:41:33.172Z; Thread-214]: prune >> sis=segments_f: _a(6.0.0):c10 _b(6.0.0):c1 _c(6.0.0):c1 _d(6.0.0):c1 >> _e(6.0.0):c1 _f(6.0.0):c1 _g(6.0.0):c1 minGen=0 packetCount=0 >> [junit4] 1> TMP 16 [2016-02-07T08:41:33.172Z; Thread-214]: findMerges: >> 7 segments >> [junit4] 1> TMP 16 [2016-02-07T08:41:33.172Z; Thread-214]: >> seg=_a(6.0.0):c10 size=0.001 MB [floored] >> [junit4] 1> TMP 16 [2016-02-07T08:41:33.172Z; Thread-214]: >> seg=_b(6.0.0):c1 size=0.001 MB [floored] >> [junit4] 1> TMP 16 [2016-02-07T08:41:33.172Z; Thread-214]: >> seg=_c(6.0.0):c1 size=0.001 MB [floored] >> [junit4] 1> TMP 16 [2016-02-07T08:41:33.172Z; Thread-214]: >> seg=_d(6.0.0):c1 size=0.001 MB [floored] >> [junit4] 1> TMP 16 [2016-02-07T08:41:33.172Z; Thread-214]: >> seg=_e(6.0.0):c1 size=0.001 MB [floored] >> [junit4] 1> TMP 16 [2016-02-07T08:41:33.172Z; Thread-214]: >> seg=_f(6.0.0):c1 size=0.001 MB [floored] >> [junit4] 1> TMP 16 [2016-02-07T08:41:33.172Z; Thread-214]: >> seg=_g(6.0.0):c1 size=0.001 MB [floored] >> [junit4] 1> TMP 16 [2016-02-07T08:41:33.172Z; Thread-214]: >> allowedSegmentCount=1 vs count=7 (eligible count=7) tooBigCount=0 >> [junit4] 1> MS 16 [2016-02-07T08:41:33.173Z; Thread-214]: >> initDynamicDefaults spins=true maxThreadCount=1 maxMergeCount=6 >> [junit4] 1> MS 16 [2016-02-07T08:41:33.173Z; Thread-214]: now merge >> [junit4] 1> MS 16 [2016-02-07T08:41:33.173Z; Thread-214]: index: >> _a(6.0.0):c10 _b(6.0.0):c1 _c(6.0.0):c1 _d(6.0.0):c1 _e(6.0.0):c1 >> _f(6.0.0):c1 _g(6.0.0):c1 >> [junit4] 1> MS 16 [2016-02-07T08:41:33.173Z; Thread-214]: no more >> merges pending; now return >> [junit4] 1> MS 16 [2016-02-07T08:41:33.173Z; Thread-214]: >> updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec >> [junit4] 1> MS 16 [2016-02-07T08:41:33.173Z; Thread-214]: now merge >> [junit4] 1> MS 16 [2016-02-07T08:41:33.173Z; Thread-214]: index: >> _a(6.0.0):c10 _b(6.0.0):c1 _c(6.0.0):c1 _d(6.0.0):c1 _e(6.0.0):c1 >> _f(6.0.0):c1 _g(6.0.0):c1 >> [junit4] 1> MS 16 [2016-02-07T08:41:33.173Z; Thread-214]: no more >> merges pending; now return >> [junit4] 1> IW 16 [2016-02-07T08:41:33.173Z; Thread-214]: waitForMerges >> [junit4] 1> IW 16 [2016-02-07T08:41:33.173Z; Thread-214]: waitForMerges >> done >> [junit4] 1> IW 16 [2016-02-07T08:41:33.173Z; Thread-214]: commit: start >> [junit4] 1> IW 16 [2016-02-07T08:41:33.173Z; Thread-214]: commit: enter >> lock >> [junit4] 1> IW 16 [2016-02-07T08:41:33.173Z; Thread-214]: commit: now >> prepare >> [junit4] 1> IW 16 [2016-02-07T08:41:33.173Z; Thread-214]: >> prepareCommit: flush >> [junit4] 1> IW 16 [2016-02-07T08:41:33.173Z; Thread-214]: index >> before flush _a(6.0.0):c10 _b(6.0.0):c1 _c(6.0.0):c1 _d(6.0.0):c1 >> _e(6.0.0):c1 _f(6.0.0):c1 _g(6.0.0):c1 >> [junit4] 1> DW 16 [2016-02-07T08:41:33.173Z; Thread-214]: startFullFlush >> [junit4] 1> IW 16 [2016-02-07T08:41:33.173Z; Thread-214]: apply all >> deletes during flush >> [junit4] 1> IW 16 [2016-02-07T08:41:33.173Z; Thread-214]: now apply all >> deletes for all segments maxDoc=16 >> [junit4] 1> BD 16 [2016-02-07T08:41:33.173Z; Thread-214]: applyDeletes: >> open segment readers took 0 msec >> [junit4] 1> BD 16 [2016-02-07T08:41:33.173Z; Thread-214]: applyDeletes: >> no segments; skipping >> [junit4] 1> BD 16 [2016-02-07T08:41:33.173Z; Thread-214]: prune >> sis=segments_f: _a(6.0.0):c10 _b(6.0.0):c1 _c(6.0.0):c1 _d(6.0.0):c1 >> _e(6.0.0):c1 _f(6.0.0):c1 _g(6.0.0):c1 minGen=0 packetCount=0 >> [junit4] 1> DW 16 [2016-02-07T08:41:33.173Z; Thread-214]: Thread-214 >> finishFullFlush success=true >> [junit4] 1> IW 16 [2016-02-07T08:41:33.173Z; Thread-214]: >> startCommit(): start >> [junit4] 1> IW 16 [2016-02-07T08:41:33.173Z; Thread-214]: startCommit >> index=_a(6.0.0):c10 _b(6.0.0):c1 _c(6.0.0):c1 _d(6.0.0):c1 _e(6.0.0):c1 >> _f(6.0.0):c1 _g(6.0.0):c1 changeCount=3 >> [junit4] 1> IW 16 [2016-02-07T08:41:33.176Z; Thread-214]: startCommit: >> wrote pending segments file "pending_segments_g" >> [junit4] 1> IW 16 [2016-02-07T08:41:33.180Z; Thread-214]: done all >> syncs: [_b.cfe, _g.cfe, _c.cfs, _a.si, _c.si, _b.si, _d.cfe, _e.cfs, _f.cfe, >> _a.cfs, _b.cfs, _d.cfs, _f.si, _g.cfs, _g.si, _d.si, _e.si, _e.cfe, _f.cfs, >> _c.cfe, _a.cfe] >> [junit4] 1> IW 16 [2016-02-07T08:41:33.180Z; Thread-214]: commit: >> pendingCommit != null >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.181Z; Thread-214]: delete "[]" >> [junit4] 1> IW 16 [2016-02-07T08:41:33.181Z; Thread-214]: hit exception >> during finishCommit: >> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_4719CF214BAA3E97-001\tempDir-004\segments_9 >> [junit4] 1> IW 16 [2016-02-07T08:41:33.181Z; Thread-214]: rollback >> [junit4] 1> IW 16 [2016-02-07T08:41:33.181Z; Thread-214]: all running >> merges have aborted >> [junit4] 1> IW 16 [2016-02-07T08:41:33.181Z; Thread-214]: rollback: >> done finish merges >> [junit4] 1> DW 16 [2016-02-07T08:41:33.181Z; Thread-214]: abort >> [junit4] 1> DW 16 [2016-02-07T08:41:33.181Z; Thread-214]: done abort >> success=true >> [junit4] 1> IW 16 [2016-02-07T08:41:33.181Z; Thread-214]: rollback: >> infos=_a(6.0.0):c10 _b(6.0.0):c1 _c(6.0.0):c1 _d(6.0.0):c1 _e(6.0.0):c1 >> _f(6.0.0):c1 >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.181Z; Thread-214]: now >> checkpoint "_a(6.0.0):c10 _b(6.0.0):c1 _c(6.0.0):c1 _d(6.0.0):c1 >> _e(6.0.0):c1 _f(6.0.0):c1" [6 segments ; isCommit = false] >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.181Z; Thread-214]: delete >> "[_g.cfe, _g.cfs, _g.si]" >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.182Z; Thread-214]: 0 msec to >> checkpoint >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.182Z; Thread-214]: refresh: >> removing newly created unreferenced file "segments_g" >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.182Z; Thread-214]: delete >> "[segments_g]" >> [junit4] 1> IFD 16 [2016-02-07T08:41:33.182Z; Thread-214]: delete "[]" >> [junit4] 1> >> [junit4] 2> NOTE: reproduce with: ant test >> -Dtestcase=TestSimpleFSLockFactory -Dtests.method=testStressLocks >> -Dtests.seed=4719CF214BAA3E97 -Dtests.slow=true -Dtests.locale=sr-RS >> -Dtests.timezone=PLT -Dtests.asserts=true -Dtests.file.encoding=UTF-8 >> [junit4] FAILURE 1.14s J1 | TestSimpleFSLockFactory.testStressLocks <<< >> [junit4] > Throwable #1: java.lang.AssertionError: IndexWriter hit >> unexpected exceptions >> [junit4] > at >> __randomizedtesting.SeedInfo.seed([4719CF214BAA3E97:192881DC5706F6F1]:0) >> [junit4] > at >> org.apache.lucene.store.BaseLockFactoryTestCase.testStressLocks(BaseLockFactoryTestCase.java:180) >> [junit4] > at java.lang.Thread.run(Thread.java:745) >> [junit4] 2> NOTE: leaving temporary files on disk at: >> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\build\core\test\J1\temp\lucene.store.TestSimpleFSLockFactory_4719CF214BAA3E97-001 >> [junit4] 2> NOTE: test params are: codec=Asserting(Lucene60), >> sim=ClassicSimilarity, locale=sr-RS, timezone=PLT >> [junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_72 >> (64-bit)/cpus=3,threads=1,free=23017888,total=64946176 >> [junit4] 2> NOTE: All tests run in this JVM: [TestCloseableThreadLocal, >> TestByteBlockPool, TestIndexFileDeleter, TestRecyclingIntBlockAllocator, >> TestBlockPostingsFormat, TestPrefixCodedTerms, TestPriorityQueue, >> TestSortedSetSelector, TestSnapshotDeletionPolicy, TestIndexWriterCommit, >> TestSpanCollection, Test4GBStoredFields, >> TestLucene50StoredFieldsFormatHighCompression, TestMultiTermsEnum, >> TestBlockPostingsFormat3, TestComplexExplanationsOfNonMatches, >> TestBooleanQueryVisitSubscorers, TestBytesRefArray, >> TestDocInverterPerFieldErrorInfo, TestArrayUtil, TestWildcard, >> TestAllFilesCheckIndexHeader, TestIndexInput, >> Test2BSortedDocValuesFixedSorted, TestIndexWriterMergePolicy, >> TestTermVectorsWriter, TestIndexWriterThreadsToSegments, TestReaderClosed, >> TestMaxPosition, TestToken, TestSentinelIntSet, TestNumericDocValuesUpdates, >> TestApproximationSearchEquivalence, TestIntBlockPool, TestDocCount, >> TestFieldCacheRewriteMethod, TestWildcardRandom, TestSpansEnum, >> TestLucene60PointFormat, TestPerSegmentDeletes, TestBufferedIndexInput, >> TestSimpleFSLockFactory] >> [junit4] Completed [64/412 (1!)] on J1 in 7.17s, 7 tests, 1 failure <<< >> FAILURES! >> >> [...truncated 462 lines...] >> [junit4] Suite: org.apache.lucene.index.TestIndexWriter >> [junit4] IGNOR/A 0.00s J1 | TestIndexWriter.testWithPendingDeletions >> [junit4] > Assumption #1: windows is not supported >> [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestIndexWriter >> -Dtests.method=testDeleteUnusedFiles -Dtests.seed=4719CF214BAA3E97 >> -Dtests.slow=true -Dtests.locale=ar -Dtests.timezone=America/Catamarca >> -Dtests.asserts=true -Dtests.file.encoding=UTF-8 >> [junit4] FAILURE 0.13s J1 | TestIndexWriter.testDeleteUnusedFiles <<< >> [junit4] > Throwable #1: java.lang.AssertionError >> [junit4] > at >> __randomizedtesting.SeedInfo.seed([4719CF214BAA3E97:F82F9DAE23F29378]:0) >> [junit4] > at >> org.apache.lucene.index.TestIndexWriter.testDeleteUnusedFiles(TestIndexWriter.java:1322) >> [junit4] > at java.lang.Thread.run(Thread.java:745) >> [junit4] 2> NOTE: leaving temporary files on disk at: >> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\build\core\test\J1\temp\lucene.index.TestIndexWriter_4719CF214BAA3E97-001 >> [junit4] 2> NOTE: test params are: codec=Asserting(Lucene60): >> {=PostingsFormat(name=Memory doPackFST= false), >> a=PostingsFormat(name=MockRandom), c=PostingsFormat(name=Memory doPackFST= >> true), string=PostingsFormat(name=Memory doPackFST= true), >> foo=PostingsFormat(name=Direct), body=PostingsFormat(name=Direct), >> content=PostingsFormat(name=MockRandom), >> str=PostingsFormat(name=MockRandom), tvtest=PostingsFormat(name=Memory >> doPackFST= false), field=PostingsFormat(name=Direct), >> str3=PostingsFormat(name=Direct), content4=PostingsFormat(name=MockRandom), >> str2=PostingsFormat(name=MockRandom), content1=PostingsFormat(name=Memory >> doPackFST= false), binary=PostingsFormat(name=Memory doPackFST= true), >> id=PostingsFormat(name=Memory doPackFST= true), >> myfield=PostingsFormat(name=Direct)}, >> docValues:{binarydv=DocValuesFormat(name=Memory), >> dv=DocValuesFormat(name=Lucene54), sortedsetdv=DocValuesFormat(name=Memory), >> sortednumericdv=DocValuesFormat(name=Lucene54), >> numericdv=DocValuesFormat(name=Memory), >> sorteddv=DocValuesFormat(name=Memory)}, sim=ClassicSimilarity, locale=ar, >> timezone=America/Catamarca >> [junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_72 >> (64-bit)/cpus=3,threads=1,free=96694072,total=145547264 >> [junit4] 2> NOTE: All tests run in this JVM: [TestCloseableThreadLocal, >> TestByteBlockPool, TestIndexFileDeleter, TestRecyclingIntBlockAllocator, >> TestBlockPostingsFormat, TestPrefixCodedTerms, TestPriorityQueue, >> TestSortedSetSelector, TestSnapshotDeletionPolicy, TestIndexWriterCommit, >> TestSpanCollection, Test4GBStoredFields, >> TestLucene50StoredFieldsFormatHighCompression, TestMultiTermsEnum, >> TestBlockPostingsFormat3, TestComplexExplanationsOfNonMatches, >> TestBooleanQueryVisitSubscorers, TestBytesRefArray, >> TestDocInverterPerFieldErrorInfo, TestArrayUtil, TestWildcard, >> TestAllFilesCheckIndexHeader, TestIndexInput, >> Test2BSortedDocValuesFixedSorted, TestIndexWriterMergePolicy, >> TestTermVectorsWriter, TestIndexWriterThreadsToSegments, TestReaderClosed, >> TestMaxPosition, TestToken, TestSentinelIntSet, TestNumericDocValuesUpdates, >> TestApproximationSearchEquivalence, TestIntBlockPool, TestDocCount, >> TestFieldCacheRewriteMethod, TestWildcardRandom, TestSpansEnum, >> TestLucene60PointFormat, TestPerSegmentDeletes, TestBufferedIndexInput, >> TestSimpleFSLockFactory, TestUpgradeIndexMergePolicy, TestMergeRateLimiter, >> TestSimilarityProvider, TestBKD, TestRegexpRandom, TestNumericRangeQuery64, >> TestTimeLimitingCollector, TestTimSorterWorstCase, TestPackedInts, >> TestDocumentsWriterDeleteQueue, TestDocumentsWriterStallControl, >> TestMathUtil, TestSpanNearQuery, TestControlledRealTimeReopenThread, >> TestDocumentWriter, TestNIOFSDirectory, TestAssertions, TestOmitTf, >> TestIndexableField, TestSimpleAttributeImpl, TestStressIndexing, >> TestMatchNoDocsQuery, TestTragicIndexWriterDeadlock, >> TestReaderWrapperDVTypeCheck, TestQueryRescorer, TestIOUtils, >> TestIndexWriterUnicode, TestConjunctions, TestFieldMaskingSpanQuery, >> TestStressDeletes, TestAddIndexes, TestAutomatonQuery, TestMultiset, >> TestCustomNorms, TestIntArrayDocIdSet, TestIndexWriterOnVMError, >> TestSloppyPhraseQuery, TestSynonymQuery, TestBM25Similarity, >> TestTotalHitCountCollector, TestTopFieldCollector, TestTopDocsCollector, >> TestCachingCollector, TestDirectoryReader, TestIndexWriterDeleteByQuery, >> TestLevenshteinAutomata, TestSameScoresWithThreads, TestDirectMonotonic, >> TestForTooMuchCloning, TestDuelingCodecsAtNight, TestHugeRamFile, >> TestMergeSchedulerExternal, TestFilterDirectoryReader, >> TestLucene53NormsFormat, TestBooleanMinShouldMatch, TestDateSort, >> TestIndexSearcher, TestDeterminism, TestNewestSegment, TestIndexWriter] >> [junit4] Completed [204/412 (2!)] on J1 in 7.25s, 71 tests, 1 failure, 1 >> skipped <<< FAILURES! >> >> [...truncated 690 lines...] >> BUILD FAILED >> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:740: The >> following error occurred while executing this line: >> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:684: The >> following error occurred while executing this line: >> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:59: The >> following error occurred while executing this line: >> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\build.xml:50: >> The following error occurred while executing this line: >> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1457: >> The following error occurred while executing this line: >> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1014: >> There were test failures: 412 suites (1 ignored), 3384 tests, 2 failures, >> 66 ignored (62 assumptions) [seed: 4719CF214BAA3E97] >> >> Total time: 5 minutes 24 seconds >> Build step 'Invoke Ant' marked build as failure >> Archiving artifacts >> [WARNINGS] Skipping publisher since build result is FAILURE >> Recording test results >> Email was triggered for: Failure - Any >> Sending email for trigger: Failure - Any >> >> >> >> >> --------------------------------------------------------------------- >> 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
