Whoa, it does repro!  I'll open an issue and try to understand ... maybe
just unlucky random IWC, etc.

Mike McCandless

http://blog.mikemccandless.com


On Tue, Sep 7, 2021 at 8:09 AM Michael McCandless <luc...@mikemccandless.com>
wrote:

> Hmm, too many open files.  I wonder if we have a file handle leak?  I'll
> see if it repros.
>
> Mike McCandless
>
> http://blog.mikemccandless.com
>
>
> On Mon, Sep 6, 2021 at 3:27 AM Apache Jenkins Server <
> jenk...@builds.apache.org> wrote:
>
>> Build:
>> https://ci-builds.apache.org/job/Lucene/job/Lucene-NightlyTests-main/386/
>>
>> 1 tests failed.
>> FAILED:
>> org.apache.lucene.index.TestIndexWriterMergePolicy.testStressUpdateSameDocumentWithMergeOnGetReader
>>
>> Error Message:
>> org.apache.lucene.store.AlreadyClosedException: refusing to delete any
>> files: this IndexWriter hit an unrecoverable exception
>>
>> Stack Trace:
>> org.apache.lucene.store.AlreadyClosedException: refusing to delete any
>> files: this IndexWriter hit an unrecoverable exception
>>         at
>> app//org.apache.lucene.index.IndexFileDeleter.ensureOpen(IndexFileDeleter.java:400)
>>         at
>> app//org.apache.lucene.index.IndexFileDeleter.deleteFiles(IndexFileDeleter.java:734)
>>         at
>> app//org.apache.lucene.index.IndexFileDeleter.decRef(IndexFileDeleter.java:655)
>>         at
>> app//org.apache.lucene.index.IndexFileDeleter.checkpoint(IndexFileDeleter.java:597)
>>         at
>> app//org.apache.lucene.index.IndexWriter.checkpointNoSIS(IndexWriter.java:2742)
>>         at
>> app//org.apache.lucene.index.IndexWriter.writeReaderPool(IndexWriter.java:3732)
>>         at
>> app//org.apache.lucene.index.IndexWriter.prepareCommitInternal(IndexWriter.java:3445)
>>         at
>> app//org.apache.lucene.index.IndexWriter.commitInternal(IndexWriter.java:3863)
>>         at
>> app//org.apache.lucene.index.IndexWriter.commit(IndexWriter.java:3825)
>>         at
>> app//org.apache.lucene.index.RandomIndexWriter.getReader(RandomIndexWriter.java:479)
>>         at
>> app//org.apache.lucene.index.RandomIndexWriter.getReader(RandomIndexWriter.java:406)
>>         at
>> app//org.apache.lucene.index.TestIndexWriterMergePolicy.stressUpdateSameDocumentWithMergeOnX(TestIndexWriterMergePolicy.java:763)
>>         at
>> app//org.apache.lucene.index.TestIndexWriterMergePolicy.testStressUpdateSameDocumentWithMergeOnGetReader(TestIndexWriterMergePolicy.java:707)
>>         at 
>> java.base@11.0.11/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native
>> Method)
>>         at java.base@11.0.11
>> /jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>>         at java.base@11.0.11
>> /jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>>         at java.base@11.0.11
>> /java.lang.reflect.Method.invoke(Method.java:566)
>>         at
>> app//com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
>>         at
>> app//com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
>>         at
>> app//com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
>>         at
>> app//com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
>>         at
>> app//org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:44)
>>         at
>> app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>         at
>> app//org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
>>         at
>> app//org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>>         at
>> app//org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>>         at app//org.junit.rules.RunRules.evaluate(RunRules.java:20)
>>         at
>> app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>         at
>> app//com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
>>         at
>> app//com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
>>         at
>> app//com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
>>         at
>> app//com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
>>         at
>> app//com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
>>         at
>> app//com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
>>         at
>> app//com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
>>         at
>> app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>         at
>> app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>         at
>> app//org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
>>         at
>> app//com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
>>         at
>> app//com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
>>         at
>> app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>         at
>> app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>         at
>> app//org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
>>         at
>> app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>         at
>> app//org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>>         at
>> app//org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>>         at
>> app//org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:47)
>>         at app//org.junit.rules.RunRules.evaluate(RunRules.java:20)
>>         at
>> app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>         at
>> app//com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
>>         at
>> app//com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
>>         at java.base@11.0.11/java.lang.Thread.run(Thread.java:834)
>> Caused by: java.nio.file.FileSystemException:
>> /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-main/checkout/lucene/core/build/tmp/tests-tmp/lucene.index.TestIndexWriterMergePolicy_971E1D93B44F0009-001/index-NIOFSDirectory-001/_2eb_Lucene90FieldsIndexfile_pointers_4sn.tmp:
>> Too many open files
>>         at
>> org.apache.lucene.mockfile.HandleLimitFS.onOpen(HandleLimitFS.java:45)
>>         at
>> org.apache.lucene.mockfile.HandleTrackingFS.callOpenHook(HandleTrackingFS.java:82)
>>         at
>> org.apache.lucene.mockfile.HandleTrackingFS.newOutputStream(HandleTrackingFS.java:163)
>>         at
>> org.apache.lucene.mockfile.FilterFileSystemProvider.newOutputStream(FilterFileSystemProvider.java:194)
>>         at java.base/java.nio.file.Files.newOutputStream(Files.java:220)
>>         at
>> org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:392)
>>         at
>> org.apache.lucene.store.FSDirectory.createTempOutput(FSDirectory.java:234)
>>         at
>> org.apache.lucene.store.FileSwitchDirectory.createTempOutput(FileSwitchDirectory.java:198)
>>         at
>> org.apache.lucene.store.MockDirectoryWrapper.createTempOutput(MockDirectoryWrapper.java:745)
>>         at
>> org.apache.lucene.store.FilterDirectory.createTempOutput(FilterDirectory.java:81)
>>         at
>> org.apache.lucene.store.TrackingDirectoryWrapper.createTempOutput(TrackingDirectoryWrapper.java:49)
>>         at
>> org.apache.lucene.codecs.lucene90.compressing.FieldsIndexWriter.<init>(FieldsIndexWriter.java:87)
>>         at
>> org.apache.lucene.codecs.lucene90.compressing.Lucene90CompressingStoredFieldsWriter.<init>(Lucene90CompressingStoredFieldsWriter.java:148)
>>         at
>> org.apache.lucene.codecs.lucene90.compressing.Lucene90CompressingStoredFieldsFormat.fieldsWriter(Lucene90CompressingStoredFieldsFormat.java:140)
>>         at
>> org.apache.lucene.codecs.lucene90.Lucene90StoredFieldsFormat.fieldsWriter(Lucene90StoredFieldsFormat.java:154)
>>         at
>> org.apache.lucene.index.StoredFieldsConsumer.initStoredFieldsWriter(StoredFieldsConsumer.java:49)
>>         at
>> org.apache.lucene.index.StoredFieldsConsumer.startDocument(StoredFieldsConsumer.java:56)
>>         at
>> org.apache.lucene.index.IndexingChain.startStoredFields(IndexingChain.java:556)
>>         at
>> org.apache.lucene.index.IndexingChain.processDocument(IndexingChain.java:587)
>>         at
>> org.apache.lucene.index.DocumentsWriterPerThread.updateDocuments(DocumentsWriterPerThread.java:239)
>>         at
>> org.apache.lucene.index.DocumentsWriter.updateDocuments(DocumentsWriter.java:432)
>>         at
>> org.apache.lucene.index.IndexWriter.updateDocuments(IndexWriter.java:1530)
>>         at
>> org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1815)
>>         at
>> org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1468)
>>         at
>> org.apache.lucene.index.RandomIndexWriter.addDocument(RandomIndexWriter.java:208)
>>         at
>> org.apache.lucene.index.TestIndexWriterMergePolicy.lambda$stressUpdateSameDocumentWithMergeOnX$4(TestIndexWriterMergePolicy.java:748)
>>         ... 1 more
>>
>>
>>
>>
>> Build Log:
>> [...truncated 1153 lines...]
>> ERROR: The following test(s) have failed:
>>   -
>> org.apache.lucene.index.TestIndexWriterMergePolicy.testStressUpdateSameDocumentWithMergeOnGetReader
>> (:lucene:core)
>>     Test output:
>> /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-main/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.index.TestIndexWriterMergePolicy.txt
>>     Reproduce with: gradlew :lucene:core:test --tests
>> "org.apache.lucene.index.TestIndexWriterMergePolicy.testStressUpdateSameDocumentWithMergeOnGetReader"
>> -Ptests.jvms=4 -Ptests.haltonfailure=false
>> -Ptests.jvmargs=-XX:TieredStopAtLevel=1 -Ptests.seed=971E1D93B44F0009
>> -Ptests.multiplier=2 -Ptests.nightly=true -Ptests.badapples=false
>> -Ptests.file.encoding=US-ASCII
>> -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-main/test-data/enwiki.random.lines.txt
>>
>>
>> Deprecated Gradle features were used in this build, making it
>> incompatible with Gradle 8.0.
>>
>> You can use '--warning-mode all' to show the individual deprecation
>> warnings and determine if they come from your own scripts or plugins.
>>
>> See
>> https://docs.gradle.org/7.2/userguide/command_line_interface.html#sec:command_line_warnings
>>
>> BUILD SUCCESSFUL in 4h 21m 21s
>> 195 actionable tasks: 195 executed
>> Build step 'Invoke Gradle script' changed build result to SUCCESS
>> Archiving artifacts
>> java.lang.InterruptedException: no matches found within 10000
>>         at
>> hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3069)
>>         at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2948)
>>         at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2929)
>>         at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3317)
>> Also:   hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene1
>>                 at
>> hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1800)
>>                 at
>> hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
>>                 at hudson.remoting.Channel.call(Channel.java:1001)
>>                 at hudson.FilePath.act(FilePath.java:1159)
>>                 at hudson.FilePath.act(FilePath.java:1148)
>>                 at hudson.FilePath.validateAntFileMask(FilePath.java:2927)
>>                 at
>> hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:270)
>>                 at
>> hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:80)
>>                 at
>> hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
>>                 at
>> hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:803)
>>                 at
>> hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:752)
>>                 at hudson.model.Build$BuildExecution.post2(Build.java:177)
>>                 at
>> hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:697)
>>                 at hudson.model.Run.execute(Run.java:1931)
>>                 at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
>>                 at
>> hudson.model.ResourceController.execute(ResourceController.java:97)
>>                 at hudson.model.Executor.run(Executor.java:429)
>> Caused: hudson.FilePath$TunneledInterruptedException
>>         at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3319)
>>         at hudson.remoting.UserRequest.perform(UserRequest.java:211)
>>         at hudson.remoting.UserRequest.perform(UserRequest.java:54)
>>         at hudson.remoting.Request$2.run(Request.java:376)
>>         at
>> hudson.remoting.InterceptingExecutorService.lambda$wrap$0(InterceptingExecutorService.java:78)
>>         at java.util.concurrent.FutureTask.run(FutureTask.java:266)
>>         at
>> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
>>         at
>> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
>>         at java.lang.Thread.run(Thread.java:748)
>> Caused: java.lang.InterruptedException: java.lang.InterruptedException:
>> no matches found within 10000
>>         at hudson.FilePath.act(FilePath.java:1161)
>>         at hudson.FilePath.act(FilePath.java:1148)
>>         at hudson.FilePath.validateAntFileMask(FilePath.java:2927)
>>         at
>> hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:270)
>>         at
>> hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:80)
>>         at
>> hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
>>         at
>> hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:803)
>>         at
>> hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:752)
>>         at hudson.model.Build$BuildExecution.post2(Build.java:177)
>>         at
>> hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:697)
>>         at hudson.model.Run.execute(Run.java:1931)
>>         at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
>>         at
>> hudson.model.ResourceController.execute(ResourceController.java:97)
>>         at hudson.model.Executor.run(Executor.java:429)
>> No artifacts found that match the file pattern
>> "**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
>> Recording test results
>> [Checks API] No suitable checks publisher found.
>> Build step 'Publish JUnit test result report' changed build result to
>> UNSTABLE
>> Email was triggered for: Unstable (Test Failures)
>> Sending email for trigger: Unstable (Test Failures)
>>
>> ---------------------------------------------------------------------
>> To unsubscribe, e-mail: builds-unsubscr...@lucene.apache.org
>> For additional commands, e-mail: builds-h...@lucene.apache.org
>
>

Reply via email to