You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Michael McCandless <lu...@mikemccandless.com> on 2023/08/31 11:06:38 UTC

Re: [JENKINS] Lucene » Lucene-NightlyTests-9.x - Build # 665 - Unstable!

Good grief -- why are we getting SocketTimeoutException in our
LockVerifyServer's attempt to accept an incoming connection!?  These are
all processes running on the same host ...

Mike McCandless

http://blog.mikemccandless.com


On Tue, Aug 29, 2023 at 11:17 PM Apache Jenkins Server <
jenkins@builds.apache.org> wrote:

> Build:
> https://ci-builds.apache.org/job/Lucene/job/Lucene-NightlyTests-9.x/665/
>
> 2 tests failed.
> FAILED:
> org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory
>
> Error Message:
> java.net.SocketTimeoutException: Accept timed out
>
> Stack Trace:
> java.net.SocketTimeoutException: Accept timed out
>         at
> __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993:F325FE2A6E367AC7]:0)
>         at java.base/java.net.PlainSocketImpl.socketAccept(Native Method)
>         at java.base/java.net
> .AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:474)
>         at java.base/java.net
> .ServerSocket.implAccept(ServerSocket.java:565)
>         at java.base/java.net.ServerSocket.accept(ServerSocket.java:533)
>         at
> org.apache.lucene.store.LockVerifyServer.run(LockVerifyServer.java:62)
>         at
> org.apache.lucene.store.TestStressLockFactories.runImpl(TestStressLockFactories.java:53)
>         at
> org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory(TestStressLockFactories.java:104)
>         at
> java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native
> Method)
>         at
> java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>         at
> java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>         at java.base/java.lang.reflect.Method.invoke(Method.java:566)
>         at
> com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1758)
>         at
> com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:946)
>         at
> com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:982)
>         at
> com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:996)
>         at
> org.apache.lucene.tests.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:48)
>         at
> org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>         at
> org.apache.lucene.tests.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
>         at
> org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>         at
> org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>         at org.junit.rules.RunRules.evaluate(RunRules.java:20)
>         at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>         at
> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
>         at
> com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:843)
>         at
> com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:490)
>         at
> com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:955)
>         at
> com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:840)
>         at
> com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:891)
>         at
> com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:902)
>         at
> org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>         at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>         at
> org.apache.lucene.tests.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
>         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
> org.apache.lucene.tests.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
>         at
> org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>         at
> org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>         at
> org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>         at
> org.apache.lucene.tests.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:47)
>         at org.junit.rules.RunRules.evaluate(RunRules.java:20)
>         at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>         at
> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
>         at
> com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:850)
>         at java.base/java.lang.Thread.run(Thread.java:829)
>
>
> FAILED:  org.apache.lucene.store.TestStressLockFactories.classMethod
>
> Error Message:
> com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from
> SUITE scope at org.apache.lucene.store.TestStressLockFactories:
>    1) Thread[id=6713, name=Thread-5553, state=WAITING,
> group=TGRP-TestStressLockFactories]
>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
> Method)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>         at
> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>         at
> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>    2) Thread[id=6710, name=Thread-5550, state=WAITING,
> group=TGRP-TestStressLockFactories]
>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
> Method)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>         at
> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>         at
> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>    3) Thread[id=6712, name=Thread-5552, state=WAITING,
> group=TGRP-TestStressLockFactories]
>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
> Method)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>         at
> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>         at
> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>    4) Thread[id=6711, name=Thread-5551, state=WAITING,
> group=TGRP-TestStressLockFactories]
>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
> Method)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>         at
> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>         at
> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>
> Stack Trace:
> com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from
> SUITE scope at org.apache.lucene.store.TestStressLockFactories:
>    1) Thread[id=6713, name=Thread-5553, state=WAITING,
> group=TGRP-TestStressLockFactories]
>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
> Method)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>         at
> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>         at
> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>    2) Thread[id=6710, name=Thread-5550, state=WAITING,
> group=TGRP-TestStressLockFactories]
>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
> Method)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>         at
> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>         at
> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>    3) Thread[id=6712, name=Thread-5552, state=WAITING,
> group=TGRP-TestStressLockFactories]
>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
> Method)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>         at
> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>         at
> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>    4) Thread[id=6711, name=Thread-5551, state=WAITING,
> group=TGRP-TestStressLockFactories]
>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
> Method)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>         at
> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>         at
> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>         at
> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>         at __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993]:0)
>
>
>
>
> Build Log:
> [...truncated 674 lines...]
> ERROR: The following test(s) have failed:
>   -
> org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory
> (:lucene:core)
>     Test output:
> /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
>     Reproduce with: gradlew :lucene:core:test --tests
> "org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory"
> -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs=
> -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true
> -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1
> -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
>
>   - org.apache.lucene.store.TestStressLockFactories.classMethod
> (:lucene:core)
>     Test output:
> /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
>     Reproduce with: gradlew :lucene:core:test --tests
> "org.apache.lucene.store.TestStressLockFactories.classMethod"
> -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs=
> -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true
> -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1
> -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
>
>
> BUILD SUCCESSFUL in 1h 41m 59s
> 243 actionable tasks: 112 executed, 131 up-to-date
>
> Publishing build scan...
> https://ge.apache.org/s/orksynljk2yp6
>
> Build step 'Invoke Gradle script' changed build result to SUCCESS
> Archiving artifacts
> hudson.FilePath$ValidateAntFileMask$1Cancel
>         at
> hudson.FilePath$ValidateAntFileMask$1.isCaseSensitive(FilePath.java:3300)
>         at
> org.apache.tools.ant.DirectoryScanner.lambda$isIncluded$3(DirectoryScanner.java:1374)
>         at
> java.base/java.util.stream.MatchOps$1MatchSink.accept(MatchOps.java:90)
>         at
> java.base/java.util.Spliterators$ArraySpliterator.tryAdvance(Spliterators.java:958)
>         at
> java.base/java.util.stream.ReferencePipeline.forEachWithCancel(ReferencePipeline.java:127)
>         at
> java.base/java.util.stream.AbstractPipeline.copyIntoWithCancel(AbstractPipeline.java:502)
>         at
> java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:488)
>         at
> java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:474)
>         at
> java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:230)
>         at
> java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:196)
>         at
> java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234)
>         at
> java.base/java.util.stream.ReferencePipeline.anyMatch(ReferencePipeline.java:528)
>         at
> org.apache.tools.ant.DirectoryScanner.isIncluded(DirectoryScanner.java:1374)
>         at
> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1260)
>         at
> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>         at
> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>         at
> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>         at
> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>         at
> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>         at
> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>         at
> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1194)
>         at
> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1156)
>         at
> org.apache.tools.ant.DirectoryScanner.checkIncludePatterns(DirectoryScanner.java:954)
>         at
> org.apache.tools.ant.DirectoryScanner.scan(DirectoryScanner.java:912)
>         at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3313)
> Caused: hudson.FilePath$FileMaskNoMatchesFoundException: no matches found
> within 10000
>         at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3318)
>         at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3196)
>         at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3174)
>         at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3578)
> Also:   hudson.remoting.Channel$CallSiteStackTrace: Remote call to
> lucene-solr-2
>                 at
> hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1784)
>                 at
> hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
>                 at hudson.remoting.Channel.call(Channel.java:1000)
>                 at hudson.FilePath.act(FilePath.java:1192)
>                 at hudson.FilePath.act(FilePath.java:1181)
>                 at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
>                 at
> hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
>                 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:818)
>                 at
> hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
>                 at hudson.model.Build$BuildExecution.post2(Build.java:179)
>                 at
> hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
>                 at hudson.model.Run.execute(Run.java:1925)
>                 at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
>                 at
> hudson.model.ResourceController.execute(ResourceController.java:101)
>                 at hudson.model.Executor.run(Executor.java:442)
> Caused: hudson.FilePath$TunneledInterruptedException
>         at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3580)
>         at hudson.remoting.UserRequest.perform(UserRequest.java:211)
>         at hudson.remoting.UserRequest.perform(UserRequest.java:54)
>         at hudson.remoting.Request$2.run(Request.java:377)
>         at
> hudson.remoting.InterceptingExecutorService.lambda$wrap$0(InterceptingExecutorService.java:78)
>         at
> java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
>         at
> java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
>         at
> java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
>         at java.base/java.lang.Thread.run(Thread.java:829)
> Caused: java.lang.InterruptedException:
> hudson.FilePath$FileMaskNoMatchesFoundException: no matches found within
> 10000
>         at hudson.FilePath.act(FilePath.java:1194)
>         at hudson.FilePath.act(FilePath.java:1181)
>         at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
>         at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
>         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:818)
>         at
> hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
>         at hudson.model.Build$BuildExecution.post2(Build.java:179)
>         at
> hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
>         at hudson.model.Run.execute(Run.java:1925)
>         at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
>         at
> hudson.model.ResourceController.execute(ResourceController.java:101)
>         at hudson.model.Executor.run(Executor.java:442)
> 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-unsubscribe@lucene.apache.org
> For additional commands, e-mail: builds-help@lucene.apache.org

Re: [JENKINS] Lucene » Lucene-NightlyTests-9.x - Build # 665 - Unstable!

Posted by Uwe Schindler <uw...@thetaphi.de>.
Hi,

I commented on the thread. We need to keep the timeout, otherwise a 
failing client (e.g. process doe snot startup) will cause server to hang 
forever. Let's discuss in the isseue.

Instead we need more information if one of the clients did not start in 
time (test starting server and clients should print stderr/stdout of all 
started clients for debugging purposes on failure).

Uwe

Am 02.09.2023 um 13:47 schrieb Michael McCandless:
> OK I opened https://github.com/apache/lucene/pull/12535
>
> Mike McCandless
>
> http://blog.mikemccandless.com
>
>
> On Sat, Sep 2, 2023 at 7:17 AM Michael McCandless 
> <lu...@mikemccandless.com> wrote:
>
>     > The code is just good old socket accept loop as we have all
>     learned it in school when we were fighting to write a small echo
>     server with C.
>
>     LOL this is all my fault from loooong ago, showing my poor
>     understanding of sockets/networking/C echo servers!!
>
>     So it sounds like the client was just super slow in starting up
>     and didn't connect to the server within the timeout.
>
>     So maybe we just remove the timeout entirely (client will
>     eventually start up?), and remove the pointless SO_REUSADDR?  I'll
>     try to whip up a PR.
>
>     Mike McCandless
>
>     http://blog.mikemccandless.com
>
>
>     On Sat, Sep 2, 2023 at 6:53 AM Uwe Schindler <uw...@thetaphi.de> wrote:
>
>         Let's fix this issue with bogus socket reuse. I am not sure
>         why it is there. We touched the code last time around 2012....
>
>         Why does it has a timeout in setver at all? Normally the
>         accept() call should have no timeout. If the client does not
>         start fast enough, of course it runs into timeout.
>
>         The code is just good old socket accept loop as we have all
>         learned it in school when we were fighting to write a small
>         echo server with C. The bug here is the timeout. A timeout
>         should only be in the client and not in the waiting call.
>
>         Uwe
>
>         Uwe
>
>
>         Am 31. August 2023 14:53:44 MESZ schrieb Robert Muir
>         <rc...@gmail.com>:
>
>             I looked at this lockverifyserver and would say its
>             probably just the craziness of this code. it sets 30
>             second socket timeout and intentionally calls accept()
>             when there is nothing yet to accept... well no wonder we
>             see this issue. p.s. why does it set SO_REUSEADDR? no
>             reason to do this leniency when binding to port 0. nuke
>             it. On Thu, Aug 31, 2023 at 8:46 AM Robert Muir
>             <rc...@gmail.com> wrote:
>
>                 probably a bug in some jvm sockets code that called
>                 accept() in its default blocking mode, when there
>                 wasn't any connection to accept? in that case accept()
>                 call will just block and wait for someone to make a
>                 new connection. On Thu, Aug 31, 2023 at 8:16 AM Dawid
>                 Weiss <da...@gmail.com> wrote:
>
>                     https://ge.apache.org/s/orksynljk2yp6/tests/task/:lucene:core:test/details/org.apache.lucene.store.TestStressLockFactories/testSimpleFSLockFactory?top-execution=1
>                     This test took 31 seconds... An extremely slow vm,
>                     perhaps? I don't know what the default connection
>                     timeouts are... it does look weird though. Dawid
>                     On Thu, Aug 31, 2023 at 1:08 PM Michael McCandless
>                     <lu...@mikemccandless.com> wrote:
>
>                         Good grief -- why are we getting
>                         SocketTimeoutException in our
>                         LockVerifyServer's attempt to accept an
>                         incoming connection!? These are all processes
>                         running on the same host ... Mike McCandless
>                         http://blog.mikemccandless.com On Tue, Aug 29,
>                         2023 at 11:17 PM Apache Jenkins Server
>                         <je...@builds.apache.org> wrote:
>
>                             Build:
>                             https://ci-builds.apache.org/job/Lucene/job/Lucene-NightlyTests-9.x/665/
>                             2 tests failed. FAILED:
>                             org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory
>                             Error Message:
>                             java.net.SocketTimeoutException: Accept
>                             timed out Stack Trace:
>                             java.net.SocketTimeoutException: Accept
>                             timed out at
>                             __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993:F325FE2A6E367AC7]:0)
>                             at
>                             java.base/java.net.PlainSocketImpl.socketAccept(Native
>                             Method) at
>                             java.base/java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:474)
>                             at
>                             java.base/java.net.ServerSocket.implAccept(ServerSocket.java:565)
>                             at
>                             java.base/java.net.ServerSocket.accept(ServerSocket.java:533)
>                             at
>                             org.apache.lucene.store.LockVerifyServer.run(LockVerifyServer.java:62)
>                             at
>                             org.apache.lucene.store.TestStressLockFactories.runImpl(TestStressLockFactories.java:53)
>                             at
>                             org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory(TestStressLockFactories.java:104)
>                             at
>                             java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native
>                             Method) at
>                             java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>                             at
>                             java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>                             at
>                             java.base/java.lang.reflect.Method.invoke(Method.java:566)
>                             at
>                             com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1758)
>                             at
>                             com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:946)
>                             at
>                             com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:982)
>                             at
>                             com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:996)
>                             at
>                             org.apache.lucene.tests.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:48)
>                             at
>                             org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>                             at
>                             org.apache.lucene.tests.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
>                             at
>                             org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>                             at
>                             org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>                             at
>                             org.junit.rules.RunRules.evaluate(RunRules.java:20)
>                             at
>                             com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>                             at
>                             com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
>                             at
>                             com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:843)
>                             at
>                             com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:490)
>                             at
>                             com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:955)
>                             at
>                             com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:840)
>                             at
>                             com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:891)
>                             at
>                             com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:902)
>                             at
>                             org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>                             at
>                             com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>                             at
>                             org.apache.lucene.tests.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
>                             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
>                             org.apache.lucene.tests.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
>                             at
>                             org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>                             at
>                             org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>                             at
>                             org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>                             at
>                             org.apache.lucene.tests.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:47)
>                             at
>                             org.junit.rules.RunRules.evaluate(RunRules.java:20)
>                             at
>                             com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>                             at
>                             com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
>                             at
>                             com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:850)
>                             at
>                             java.base/java.lang.Thread.run(Thread.java:829)
>                             FAILED:
>                             org.apache.lucene.store.TestStressLockFactories.classMethod
>                             Error Message:
>                             com.carrotsearch.randomizedtesting.ThreadLeakError:
>                             4 threads leaked from SUITE scope at
>                             org.apache.lucene.store.TestStressLockFactories:
>                             1) Thread[id=6713, name=Thread-5553,
>                             state=WAITING,
>                             group=TGRP-TestStressLockFactories] at
>                             java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>                             <http://java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native>
>                             Method) at
>                             java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>                             <http://java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)>
>                             at
>                             app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>                             2) Thread[id=6710, name=Thread-5550,
>                             state=WAITING,
>                             group=TGRP-TestStressLockFactories] at
>                             java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>                             <http://java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native>
>                             Method) at
>                             java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>                             <http://java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)>
>                             at
>                             app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>                             3) Thread[id=6712, name=Thread-5552,
>                             state=WAITING,
>                             group=TGRP-TestStressLockFactories] at
>                             java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>                             <http://java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native>
>                             Method) at
>                             java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>                             <http://java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)>
>                             at
>                             app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>                             4) Thread[id=6711, name=Thread-5551,
>                             state=WAITING,
>                             group=TGRP-TestStressLockFactories] at
>                             java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>                             <http://java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native>
>                             Method) at
>                             java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>                             <http://java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)>
>                             at
>                             app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>                             Stack Trace:
>                             com.carrotsearch.randomizedtesting.ThreadLeakError:
>                             4 threads leaked from SUITE scope at
>                             org.apache.lucene.store.TestStressLockFactories:
>                             1) Thread[id=6713, name=Thread-5553,
>                             state=WAITING,
>                             group=TGRP-TestStressLockFactories] at
>                             java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>                             <http://java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native>
>                             Method) at
>                             java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>                             <http://java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)>
>                             at
>                             app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>                             2) Thread[id=6710, name=Thread-5550,
>                             state=WAITING,
>                             group=TGRP-TestStressLockFactories] at
>                             java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>                             <http://java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native>
>                             Method) at
>                             java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>                             <http://java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)>
>                             at
>                             app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>                             3) Thread[id=6712, name=Thread-5552,
>                             state=WAITING,
>                             group=TGRP-TestStressLockFactories] at
>                             java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>                             <http://java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native>
>                             Method) at
>                             java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>                             <http://java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)>
>                             at
>                             app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>                             4) Thread[id=6711, name=Thread-5551,
>                             state=WAITING,
>                             group=TGRP-TestStressLockFactories] at
>                             java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>                             <http://java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native>
>                             Method) at
>                             java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>                             <http://java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)>
>                             at
>                             java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>                             <http://java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)>
>                             at
>                             app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>                             at
>                             __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993]:0)
>                             Build Log: [...truncated 674 lines...]
>                             ERROR: The following test(s) have failed:
>                             -
>                             org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory
>                             (:lucene:core) Test output:
>                             /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
>                             Reproduce with: gradlew :lucene:core:test
>                             --tests
>                             "org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory"
>                             -Ptests.jvms=4 -Ptests.haltonfailure=false
>                             -Ptests.jvmargs=
>                             -Ptests.seed=E1AD0D2AD68BA993
>                             -Ptests.multiplier=2 -Ptests.nightly=true
>                             -Ptests.badapples=false -Ptests.gui=true
>                             -Ptests.file.encoding=ISO-8859-1
>                             -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
>                             -
>                             org.apache.lucene.store.TestStressLockFactories.classMethod
>                             (:lucene:core) Test output:
>                             /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
>                             Reproduce with: gradlew :lucene:core:test
>                             --tests
>                             "org.apache.lucene.store.TestStressLockFactories.classMethod"
>                             -Ptests.jvms=4 -Ptests.haltonfailure=false
>                             -Ptests.jvmargs=
>                             -Ptests.seed=E1AD0D2AD68BA993
>                             -Ptests.multiplier=2 -Ptests.nightly=true
>                             -Ptests.badapples=false -Ptests.gui=true
>                             -Ptests.file.encoding=ISO-8859-1
>                             -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
>                             BUILD SUCCESSFUL in 1h 41m 59s 243
>                             actionable tasks: 112 executed, 131
>                             up-to-date Publishing build scan...
>                             https://ge.apache.org/s/orksynljk2yp6
>                             Build step 'Invoke Gradle script' changed
>                             build result to SUCCESS Archiving
>                             artifacts
>                             hudson.FilePath$ValidateAntFileMask$1Cancel
>                             at
>                             hudson.FilePath$ValidateAntFileMask$1.isCaseSensitive(FilePath.java:3300)
>                             at
>                             org.apache.tools.ant.DirectoryScanner.lambda$isIncluded$3(DirectoryScanner.java:1374)
>                             at
>                             java.base/java.util.stream.MatchOps$1MatchSink.accept(MatchOps.java:90)
>                             at
>                             java.base/java.util.Spliterators$ArraySpliterator.tryAdvance(Spliterators.java:958)
>                             at
>                             java.base/java.util.stream.ReferencePipeline.forEachWithCancel(ReferencePipeline.java:127)
>                             at
>                             java.base/java.util.stream.AbstractPipeline.copyIntoWithCancel(AbstractPipeline.java:502)
>                             at
>                             java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:488)
>                             at
>                             java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:474)
>                             at
>                             java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:230)
>                             at
>                             java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:196)
>                             at
>                             java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234)
>                             at
>                             java.base/java.util.stream.ReferencePipeline.anyMatch(ReferencePipeline.java:528)
>                             at
>                             org.apache.tools.ant.DirectoryScanner.isIncluded(DirectoryScanner.java:1374)
>                             at
>                             org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1260)
>                             at
>                             org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>                             at
>                             org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>                             at
>                             org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>                             at
>                             org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>                             at
>                             org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>                             at
>                             org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>                             at
>                             org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1194)
>                             at
>                             org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1156)
>                             at
>                             org.apache.tools.ant.DirectoryScanner.checkIncludePatterns(DirectoryScanner.java:954)
>                             at
>                             org.apache.tools.ant.DirectoryScanner.scan(DirectoryScanner.java:912)
>                             at
>                             hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3313)
>                             Caused:
>                             hudson.FilePath$FileMaskNoMatchesFoundException:
>                             no matches found within 10000 at
>                             hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3318)
>                             at
>                             hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3196)
>                             at
>                             hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3174)
>                             at
>                             hudson.FilePath$FileCallableWrapper.call(FilePath.java:3578)
>                             Also:
>                             hudson.remoting.Channel$CallSiteStackTrace:
>                             Remote call to lucene-solr-2 at
>                             hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1784)
>                             at
>                             hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
>                             at
>                             hudson.remoting.Channel.call(Channel.java:1000)
>                             at hudson.FilePath.act(FilePath.java:1192)
>                             at hudson.FilePath.act(FilePath.java:1181)
>                             at
>                             hudson.FilePath.validateAntFileMask(FilePath.java:3171)
>                             at
>                             hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
>                             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:818)
>                             at
>                             hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
>                             at
>                             hudson.model.Build$BuildExecution.post2(Build.java:179)
>                             at
>                             hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
>                             at hudson.model.Run.execute(Run.java:1925)
>                             at
>                             hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
>                             at
>                             hudson.model.ResourceController.execute(ResourceController.java:101)
>                             at
>                             hudson.model.Executor.run(Executor.java:442)
>                             Caused:
>                             hudson.FilePath$TunneledInterruptedException
>                             at
>                             hudson.FilePath$FileCallableWrapper.call(FilePath.java:3580)
>                             at
>                             hudson.remoting.UserRequest.perform(UserRequest.java:211)
>                             at
>                             hudson.remoting.UserRequest.perform(UserRequest.java:54)
>                             at
>                             hudson.remoting.Request$2.run(Request.java:377)
>                             at
>                             hudson.remoting.InterceptingExecutorService.lambda$wrap$0(InterceptingExecutorService.java:78)
>                             at
>                             java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
>                             at
>                             java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
>                             at
>                             java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
>                             at
>                             java.base/java.lang.Thread.run(Thread.java:829)
>                             Caused: java.lang.InterruptedException:
>                             hudson.FilePath$FileMaskNoMatchesFoundException:
>                             no matches found within 10000 at
>                             hudson.FilePath.act(FilePath.java:1194) at
>                             hudson.FilePath.act(FilePath.java:1181) at
>                             hudson.FilePath.validateAntFileMask(FilePath.java:3171)
>                             at
>                             hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
>                             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:818)
>                             at
>                             hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
>                             at
>                             hudson.model.Build$BuildExecution.post2(Build.java:179)
>                             at
>                             hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
>                             at hudson.model.Run.execute(Run.java:1925)
>                             at
>                             hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
>                             at
>                             hudson.model.ResourceController.execute(ResourceController.java:101)
>                             at
>                             hudson.model.Executor.run(Executor.java:442)
>                             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-unsubscribe@lucene.apache.org For
>                             additional commands, e-mail:
>                             builds-help@lucene.apache.org 
>
>             ------------------------------------------------------------------------
>             To unsubscribe, e-mail:
>             builds-unsubscribe@lucene.apache.org For additional
>             commands, e-mail: builds-help@lucene.apache.org
>
>         --
>         Uwe Schindler
>         Achterdiek 19, 28357 Bremen
>         https://www.thetaphi.de
>
-- 
Uwe Schindler
Achterdiek 19, D-28357 Bremen
https://www.thetaphi.de
eMail:uwe@thetaphi.de

Re: [JENKINS] Lucene » Lucene-NightlyTests-9.x - Build # 665 - Unstable!

Posted by Michael McCandless <lu...@mikemccandless.com>.
OK I opened https://github.com/apache/lucene/pull/12535

Mike McCandless

http://blog.mikemccandless.com


On Sat, Sep 2, 2023 at 7:17 AM Michael McCandless <lu...@mikemccandless.com>
wrote:

> > The code is just good old socket accept loop as we have all learned it
> in school when we were fighting to write a small echo server with C.
>
> LOL this is all my fault from loooong ago, showing my poor understanding
> of sockets/networking/C echo servers!!
>
> So it sounds like the client was just super slow in starting up and didn't
> connect to the server within the timeout.
>
> So maybe we just remove the timeout entirely (client will eventually start
> up?), and remove the pointless SO_REUSADDR?  I'll try to whip up a PR.
>
> Mike McCandless
>
> http://blog.mikemccandless.com
>
>
> On Sat, Sep 2, 2023 at 6:53 AM Uwe Schindler <uw...@thetaphi.de> wrote:
>
>> Let's fix this issue with bogus socket reuse. I am not sure why it is
>> there. We touched the code last time around 2012....
>>
>> Why does it has a timeout in setver at all? Normally the accept() call
>> should have no timeout. If the client does not start fast enough, of course
>> it runs into timeout.
>>
>> The code is just good old socket accept loop as we have all learned it in
>> school when we were fighting to write a small echo server with C. The bug
>> here is the timeout. A timeout should only be in the client and not in the
>> waiting call.
>>
>> Uwe
>>
>> Uwe
>>
>>
>> Am 31. August 2023 14:53:44 MESZ schrieb Robert Muir <rc...@gmail.com>:
>>
>>> I looked at this lockverifyserver and would say its probably just the
>>> craziness of this code.
>>>
>>> it sets 30 second socket timeout and intentionally calls accept() when
>>> there is nothing yet to accept... well no wonder we see this issue.
>>>
>>> p.s. why does it set SO_REUSEADDR? no reason to do this leniency when
>>> binding to port 0. nuke it.
>>>
>>> On Thu, Aug 31, 2023 at 8:46 AM Robert Muir <rc...@gmail.com> wrote:
>>>
>>>>
>>>>  probably a bug in some jvm sockets code that called accept() in its
>>>>  default blocking mode, when there wasn't any connection to accept? in
>>>>  that case accept() call will just block and wait for someone to make a
>>>>  new connection.
>>>>
>>>>  On Thu, Aug 31, 2023 at 8:16 AM Dawid Weiss <da...@gmail.com> wrote:
>>>>
>>>>>
>>>>>
>>>>>  https://ge.apache.org/s/orksynljk2yp6/tests/task/:lucene:core:test/details/org.apache.lucene.store.TestStressLockFactories/testSimpleFSLockFactory?top-execution=1
>>>>>
>>>>>  This test took 31 seconds... An extremely slow vm, perhaps? I don't know what the default connection timeouts are... it does look weird though.
>>>>>
>>>>>  Dawid
>>>>>
>>>>>  On Thu, Aug 31, 2023 at 1:08 PM Michael McCandless <lu...@mikemccandless.com> wrote:
>>>>>
>>>>>>
>>>>>>  Good grief -- why are we getting SocketTimeoutException in our LockVerifyServer's attempt to accept an incoming connection!?  These are all processes running on the same host ...
>>>>>>
>>>>>>  Mike McCandless
>>>>>>
>>>>>>  http://blog.mikemccandless.com
>>>>>>
>>>>>>
>>>>>>  On Tue, Aug 29, 2023 at 11:17 PM Apache Jenkins Server <je...@builds.apache.org> wrote:
>>>>>>
>>>>>>>
>>>>>>>  Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-NightlyTests-9.x/665/
>>>>>>>
>>>>>>>  2 tests failed.
>>>>>>>  FAILED:  org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory
>>>>>>>
>>>>>>>  Error Message:
>>>>>>>  java.net.SocketTimeoutException: Accept timed out
>>>>>>>
>>>>>>>  Stack Trace:
>>>>>>>  java.net.SocketTimeoutException: Accept timed out
>>>>>>>          at __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993:F325FE2A6E367AC7]:0)
>>>>>>>          at java.base/java.net.PlainSocketImpl.socketAccept(Native Method)
>>>>>>>          at java.base/java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:474)
>>>>>>>          at java.base/java.net.ServerSocket.implAccept(ServerSocket.java:565)
>>>>>>>          at java.base/java.net.ServerSocket.accept(ServerSocket.java:533)
>>>>>>>          at org.apache.lucene.store.LockVerifyServer.run(LockVerifyServer.java:62)
>>>>>>>          at org.apache.lucene.store.TestStressLockFactories.runImpl(TestStressLockFactories.java:53)
>>>>>>>          at org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory(TestStressLockFactories.java:104)
>>>>>>>          at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>>>>>>>          at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>>>>>>>          at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>>>>>>>          at java.base/java.lang.reflect.Method.invoke(Method.java:566)
>>>>>>>          at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1758)
>>>>>>>          at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:946)
>>>>>>>          at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:982)
>>>>>>>          at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:996)
>>>>>>>          at org.apache.lucene.tests.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:48)
>>>>>>>          at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>>>>>>          at org.apache.lucene.tests.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
>>>>>>>          at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>>>>>>>          at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>>>>>>>          at org.junit.rules.RunRules.evaluate(RunRules.java:20)
>>>>>>>          at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>>>>>>          at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
>>>>>>>          at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:843)
>>>>>>>          at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:490)
>>>>>>>          at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:955)
>>>>>>>          at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:840)
>>>>>>>          at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:891)
>>>>>>>          at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:902)
>>>>>>>          at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>>>>>>          at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>>>>>>          at org.apache.lucene.tests.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
>>>>>>>          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 org.apache.lucene.tests.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
>>>>>>>          at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>>>>>>          at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>>>>>>>          at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>>>>>>>          at org.apache.lucene.tests.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:47)
>>>>>>>          at org.junit.rules.RunRules.evaluate(RunRules.java:20)
>>>>>>>          at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>>>>>>          at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
>>>>>>>          at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:850)
>>>>>>>          at java.base/java.lang.Thread.run(Thread.java:829)
>>>>>>>
>>>>>>>
>>>>>>>  FAILED:  org.apache.lucene.store.TestStressLockFactories.classMethod
>>>>>>>
>>>>>>>  Error Message:
>>>>>>>  com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.lucene.store.TestStressLockFactories:
>>>>>>>     1) Thread[id=6713, name=Thread-5553, state=WAITING, group=TGRP-TestStressLockFactories]
>>>>>>>          at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>>>>>          at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>>>>>     2) Thread[id=6710, name=Thread-5550, state=WAITING, group=TGRP-TestStressLockFactories]
>>>>>>>          at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>>>>>          at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>>>>>     3) Thread[id=6712, name=Thread-5552, state=WAITING, group=TGRP-TestStressLockFactories]
>>>>>>>          at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>>>>>          at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>>>>>     4) Thread[id=6711, name=Thread-5551, state=WAITING, group=TGRP-TestStressLockFactories]
>>>>>>>          at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>>>>>          at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>>>>>
>>>>>>>  Stack Trace:
>>>>>>>  com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.lucene.store.TestStressLockFactories:
>>>>>>>     1) Thread[id=6713, name=Thread-5553, state=WAITING, group=TGRP-TestStressLockFactories]
>>>>>>>          at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>>>>>          at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>>>>>     2) Thread[id=6710, name=Thread-5550, state=WAITING, group=TGRP-TestStressLockFactories]
>>>>>>>          at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>>>>>          at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>>>>>     3) Thread[id=6712, name=Thread-5552, state=WAITING, group=TGRP-TestStressLockFactories]
>>>>>>>          at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>>>>>          at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>>>>>     4) Thread[id=6711, name=Thread-5551, state=WAITING, group=TGRP-TestStressLockFactories]
>>>>>>>          at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>>>>>          at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>>>>>          at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>>>>>          at __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993]:0)
>>>>>>>
>>>>>>>
>>>>>>>
>>>>>>>
>>>>>>>  Build Log:
>>>>>>>  [...truncated 674 lines...]
>>>>>>>  ERROR: The following test(s) have failed:
>>>>>>>    - org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory (:lucene:core)
>>>>>>>      Test output: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
>>>>>>>      Reproduce with: gradlew :lucene:core:test --tests "org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs= -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1 -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
>>>>>>>
>>>>>>>    - org.apache.lucene.store.TestStressLockFactories.classMethod (:lucene:core)
>>>>>>>      Test output: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
>>>>>>>      Reproduce with: gradlew :lucene:core:test --tests "org.apache.lucene.store.TestStressLockFactories.classMethod" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs= -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1 -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
>>>>>>>
>>>>>>>
>>>>>>>  BUILD SUCCESSFUL in 1h 41m 59s
>>>>>>>  243 actionable tasks: 112 executed, 131 up-to-date
>>>>>>>
>>>>>>>  Publishing build scan...
>>>>>>>  https://ge.apache.org/s/orksynljk2yp6
>>>>>>>
>>>>>>>  Build step 'Invoke Gradle script' changed build result to SUCCESS
>>>>>>>  Archiving artifacts
>>>>>>>  hudson.FilePath$ValidateAntFileMask$1Cancel
>>>>>>>          at hudson.FilePath$ValidateAntFileMask$1.isCaseSensitive(FilePath.java:3300)
>>>>>>>          at org.apache.tools.ant.DirectoryScanner.lambda$isIncluded$3(DirectoryScanner.java:1374)
>>>>>>>          at java.base/java.util.stream.MatchOps$1MatchSink.accept(MatchOps.java:90)
>>>>>>>          at java.base/java.util.Spliterators$ArraySpliterator.tryAdvance(Spliterators.java:958)
>>>>>>>          at java.base/java.util.stream.ReferencePipeline.forEachWithCancel(ReferencePipeline.java:127)
>>>>>>>          at java.base/java.util.stream.AbstractPipeline.copyIntoWithCancel(AbstractPipeline.java:502)
>>>>>>>          at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:488)
>>>>>>>          at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:474)
>>>>>>>          at java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:230)
>>>>>>>          at java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:196)
>>>>>>>          at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234)
>>>>>>>          at java.base/java.util.stream.ReferencePipeline.anyMatch(ReferencePipeline.java:528)
>>>>>>>          at org.apache.tools.ant.DirectoryScanner.isIncluded(DirectoryScanner.java:1374)
>>>>>>>          at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1260)
>>>>>>>          at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>>>>>          at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>>>>>          at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>>>>>          at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>>>>>          at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>>>>>          at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>>>>>          at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1194)
>>>>>>>          at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1156)
>>>>>>>          at org.apache.tools.ant.DirectoryScanner.checkIncludePatterns(DirectoryScanner.java:954)
>>>>>>>          at org.apache.tools.ant.DirectoryScanner.scan(DirectoryScanner.java:912)
>>>>>>>          at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3313)
>>>>>>>  Caused: hudson.FilePath$FileMaskNoMatchesFoundException: no matches found within 10000
>>>>>>>          at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3318)
>>>>>>>          at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3196)
>>>>>>>          at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3174)
>>>>>>>          at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3578)
>>>>>>>  Also:   hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene-solr-2
>>>>>>>                  at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1784)
>>>>>>>                  at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
>>>>>>>                  at hudson.remoting.Channel.call(Channel.java:1000)
>>>>>>>                  at hudson.FilePath.act(FilePath.java:1192)
>>>>>>>                  at hudson.FilePath.act(FilePath.java:1181)
>>>>>>>                  at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
>>>>>>>                  at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
>>>>>>>                  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:818)
>>>>>>>                  at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
>>>>>>>                  at hudson.model.Build$BuildExecution.post2(Build.java:179)
>>>>>>>                  at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
>>>>>>>                  at hudson.model.Run.execute(Run.java:1925)
>>>>>>>                  at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
>>>>>>>                  at hudson.model.ResourceController.execute(ResourceController.java:101)
>>>>>>>                  at hudson.model.Executor.run(Executor.java:442)
>>>>>>>  Caused: hudson.FilePath$TunneledInterruptedException
>>>>>>>          at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3580)
>>>>>>>          at hudson.remoting.UserRequest.perform(UserRequest.java:211)
>>>>>>>          at hudson.remoting.UserRequest.perform(UserRequest.java:54)
>>>>>>>          at hudson.remoting.Request$2.run(Request.java:377)
>>>>>>>          at hudson.remoting.InterceptingExecutorService.lambda$wrap$0(InterceptingExecutorService.java:78)
>>>>>>>          at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
>>>>>>>          at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
>>>>>>>          at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
>>>>>>>          at java.base/java.lang.Thread.run(Thread.java:829)
>>>>>>>  Caused: java.lang.InterruptedException: hudson.FilePath$FileMaskNoMatchesFoundException: no matches found within 10000
>>>>>>>          at hudson.FilePath.act(FilePath.java:1194)
>>>>>>>          at hudson.FilePath.act(FilePath.java:1181)
>>>>>>>          at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
>>>>>>>          at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
>>>>>>>          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:818)
>>>>>>>          at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
>>>>>>>          at hudson.model.Build$BuildExecution.post2(Build.java:179)
>>>>>>>          at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
>>>>>>>          at hudson.model.Run.execute(Run.java:1925)
>>>>>>>          at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
>>>>>>>          at hudson.model.ResourceController.execute(ResourceController.java:101)
>>>>>>>          at hudson.model.Executor.run(Executor.java:442)
>>>>>>>  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-unsubscribe@lucene.apache.org
>>>>>>>  For additional commands, e-mail: builds-help@lucene.apache.org
>>>>>>>
>>>>>> ------------------------------
>>> To unsubscribe, e-mail: builds-unsubscribe@lucene.apache.org
>>> For additional commands, e-mail: builds-help@lucene.apache.org
>>>
>>> --
>> Uwe Schindler
>> Achterdiek 19, 28357 Bremen
>> https://www.thetaphi.de
>>
>

Re: [JENKINS] Lucene » Lucene-NightlyTests-9.x - Build # 665 - Unstable!

Posted by Michael McCandless <lu...@mikemccandless.com>.
> The code is just good old socket accept loop as we have all learned it in
school when we were fighting to write a small echo server with C.

LOL this is all my fault from loooong ago, showing my poor understanding of
sockets/networking/C echo servers!!

So it sounds like the client was just super slow in starting up and didn't
connect to the server within the timeout.

So maybe we just remove the timeout entirely (client will eventually start
up?), and remove the pointless SO_REUSADDR?  I'll try to whip up a PR.

Mike McCandless

http://blog.mikemccandless.com


On Sat, Sep 2, 2023 at 6:53 AM Uwe Schindler <uw...@thetaphi.de> wrote:

> Let's fix this issue with bogus socket reuse. I am not sure why it is
> there. We touched the code last time around 2012....
>
> Why does it has a timeout in setver at all? Normally the accept() call
> should have no timeout. If the client does not start fast enough, of course
> it runs into timeout.
>
> The code is just good old socket accept loop as we have all learned it in
> school when we were fighting to write a small echo server with C. The bug
> here is the timeout. A timeout should only be in the client and not in the
> waiting call.
>
> Uwe
>
> Uwe
>
>
> Am 31. August 2023 14:53:44 MESZ schrieb Robert Muir <rc...@gmail.com>:
>
>> I looked at this lockverifyserver and would say its probably just the
>> craziness of this code.
>>
>> it sets 30 second socket timeout and intentionally calls accept() when
>> there is nothing yet to accept... well no wonder we see this issue.
>>
>> p.s. why does it set SO_REUSEADDR? no reason to do this leniency when
>> binding to port 0. nuke it.
>>
>> On Thu, Aug 31, 2023 at 8:46 AM Robert Muir <rc...@gmail.com> wrote:
>>
>>>
>>>  probably a bug in some jvm sockets code that called accept() in its
>>>  default blocking mode, when there wasn't any connection to accept? in
>>>  that case accept() call will just block and wait for someone to make a
>>>  new connection.
>>>
>>>  On Thu, Aug 31, 2023 at 8:16 AM Dawid Weiss <da...@gmail.com> wrote:
>>>
>>>>
>>>>
>>>>  https://ge.apache.org/s/orksynljk2yp6/tests/task/:lucene:core:test/details/org.apache.lucene.store.TestStressLockFactories/testSimpleFSLockFactory?top-execution=1
>>>>
>>>>  This test took 31 seconds... An extremely slow vm, perhaps? I don't know what the default connection timeouts are... it does look weird though.
>>>>
>>>>  Dawid
>>>>
>>>>  On Thu, Aug 31, 2023 at 1:08 PM Michael McCandless <lu...@mikemccandless.com> wrote:
>>>>
>>>>>
>>>>>  Good grief -- why are we getting SocketTimeoutException in our LockVerifyServer's attempt to accept an incoming connection!?  These are all processes running on the same host ...
>>>>>
>>>>>  Mike McCandless
>>>>>
>>>>>  http://blog.mikemccandless.com
>>>>>
>>>>>
>>>>>  On Tue, Aug 29, 2023 at 11:17 PM Apache Jenkins Server <je...@builds.apache.org> wrote:
>>>>>
>>>>>>
>>>>>>  Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-NightlyTests-9.x/665/
>>>>>>
>>>>>>  2 tests failed.
>>>>>>  FAILED:  org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory
>>>>>>
>>>>>>  Error Message:
>>>>>>  java.net.SocketTimeoutException: Accept timed out
>>>>>>
>>>>>>  Stack Trace:
>>>>>>  java.net.SocketTimeoutException: Accept timed out
>>>>>>          at __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993:F325FE2A6E367AC7]:0)
>>>>>>          at java.base/java.net.PlainSocketImpl.socketAccept(Native Method)
>>>>>>          at java.base/java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:474)
>>>>>>          at java.base/java.net.ServerSocket.implAccept(ServerSocket.java:565)
>>>>>>          at java.base/java.net.ServerSocket.accept(ServerSocket.java:533)
>>>>>>          at org.apache.lucene.store.LockVerifyServer.run(LockVerifyServer.java:62)
>>>>>>          at org.apache.lucene.store.TestStressLockFactories.runImpl(TestStressLockFactories.java:53)
>>>>>>          at org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory(TestStressLockFactories.java:104)
>>>>>>          at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>>>>>>          at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>>>>>>          at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>>>>>>          at java.base/java.lang.reflect.Method.invoke(Method.java:566)
>>>>>>          at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1758)
>>>>>>          at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:946)
>>>>>>          at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:982)
>>>>>>          at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:996)
>>>>>>          at org.apache.lucene.tests.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:48)
>>>>>>          at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>>>>>          at org.apache.lucene.tests.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
>>>>>>          at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>>>>>>          at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>>>>>>          at org.junit.rules.RunRules.evaluate(RunRules.java:20)
>>>>>>          at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>>>>>          at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
>>>>>>          at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:843)
>>>>>>          at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:490)
>>>>>>          at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:955)
>>>>>>          at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:840)
>>>>>>          at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:891)
>>>>>>          at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:902)
>>>>>>          at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>>>>>          at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>>>>>          at org.apache.lucene.tests.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
>>>>>>          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 org.apache.lucene.tests.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
>>>>>>          at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>>>>>          at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>>>>>>          at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>>>>>>          at org.apache.lucene.tests.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:47)
>>>>>>          at org.junit.rules.RunRules.evaluate(RunRules.java:20)
>>>>>>          at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>>>>>          at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
>>>>>>          at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:850)
>>>>>>          at java.base/java.lang.Thread.run(Thread.java:829)
>>>>>>
>>>>>>
>>>>>>  FAILED:  org.apache.lucene.store.TestStressLockFactories.classMethod
>>>>>>
>>>>>>  Error Message:
>>>>>>  com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.lucene.store.TestStressLockFactories:
>>>>>>     1) Thread[id=6713, name=Thread-5553, state=WAITING, group=TGRP-TestStressLockFactories]
>>>>>>          at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>>>>          at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>>>>     2) Thread[id=6710, name=Thread-5550, state=WAITING, group=TGRP-TestStressLockFactories]
>>>>>>          at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>>>>          at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>>>>     3) Thread[id=6712, name=Thread-5552, state=WAITING, group=TGRP-TestStressLockFactories]
>>>>>>          at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>>>>          at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>>>>     4) Thread[id=6711, name=Thread-5551, state=WAITING, group=TGRP-TestStressLockFactories]
>>>>>>          at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>>>>          at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>>>>
>>>>>>  Stack Trace:
>>>>>>  com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.lucene.store.TestStressLockFactories:
>>>>>>     1) Thread[id=6713, name=Thread-5553, state=WAITING, group=TGRP-TestStressLockFactories]
>>>>>>          at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>>>>          at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>>>>     2) Thread[id=6710, name=Thread-5550, state=WAITING, group=TGRP-TestStressLockFactories]
>>>>>>          at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>>>>          at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>>>>     3) Thread[id=6712, name=Thread-5552, state=WAITING, group=TGRP-TestStressLockFactories]
>>>>>>          at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>>>>          at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>>>>     4) Thread[id=6711, name=Thread-5551, state=WAITING, group=TGRP-TestStressLockFactories]
>>>>>>          at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>>>>          at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>>>>          at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>>>>          at __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993]:0)
>>>>>>
>>>>>>
>>>>>>
>>>>>>
>>>>>>  Build Log:
>>>>>>  [...truncated 674 lines...]
>>>>>>  ERROR: The following test(s) have failed:
>>>>>>    - org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory (:lucene:core)
>>>>>>      Test output: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
>>>>>>      Reproduce with: gradlew :lucene:core:test --tests "org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs= -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1 -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
>>>>>>
>>>>>>    - org.apache.lucene.store.TestStressLockFactories.classMethod (:lucene:core)
>>>>>>      Test output: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
>>>>>>      Reproduce with: gradlew :lucene:core:test --tests "org.apache.lucene.store.TestStressLockFactories.classMethod" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs= -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1 -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
>>>>>>
>>>>>>
>>>>>>  BUILD SUCCESSFUL in 1h 41m 59s
>>>>>>  243 actionable tasks: 112 executed, 131 up-to-date
>>>>>>
>>>>>>  Publishing build scan...
>>>>>>  https://ge.apache.org/s/orksynljk2yp6
>>>>>>
>>>>>>  Build step 'Invoke Gradle script' changed build result to SUCCESS
>>>>>>  Archiving artifacts
>>>>>>  hudson.FilePath$ValidateAntFileMask$1Cancel
>>>>>>          at hudson.FilePath$ValidateAntFileMask$1.isCaseSensitive(FilePath.java:3300)
>>>>>>          at org.apache.tools.ant.DirectoryScanner.lambda$isIncluded$3(DirectoryScanner.java:1374)
>>>>>>          at java.base/java.util.stream.MatchOps$1MatchSink.accept(MatchOps.java:90)
>>>>>>          at java.base/java.util.Spliterators$ArraySpliterator.tryAdvance(Spliterators.java:958)
>>>>>>          at java.base/java.util.stream.ReferencePipeline.forEachWithCancel(ReferencePipeline.java:127)
>>>>>>          at java.base/java.util.stream.AbstractPipeline.copyIntoWithCancel(AbstractPipeline.java:502)
>>>>>>          at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:488)
>>>>>>          at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:474)
>>>>>>          at java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:230)
>>>>>>          at java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:196)
>>>>>>          at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234)
>>>>>>          at java.base/java.util.stream.ReferencePipeline.anyMatch(ReferencePipeline.java:528)
>>>>>>          at org.apache.tools.ant.DirectoryScanner.isIncluded(DirectoryScanner.java:1374)
>>>>>>          at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1260)
>>>>>>          at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>>>>          at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>>>>          at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>>>>          at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>>>>          at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>>>>          at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>>>>          at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1194)
>>>>>>          at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1156)
>>>>>>          at org.apache.tools.ant.DirectoryScanner.checkIncludePatterns(DirectoryScanner.java:954)
>>>>>>          at org.apache.tools.ant.DirectoryScanner.scan(DirectoryScanner.java:912)
>>>>>>          at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3313)
>>>>>>  Caused: hudson.FilePath$FileMaskNoMatchesFoundException: no matches found within 10000
>>>>>>          at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3318)
>>>>>>          at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3196)
>>>>>>          at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3174)
>>>>>>          at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3578)
>>>>>>  Also:   hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene-solr-2
>>>>>>                  at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1784)
>>>>>>                  at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
>>>>>>                  at hudson.remoting.Channel.call(Channel.java:1000)
>>>>>>                  at hudson.FilePath.act(FilePath.java:1192)
>>>>>>                  at hudson.FilePath.act(FilePath.java:1181)
>>>>>>                  at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
>>>>>>                  at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
>>>>>>                  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:818)
>>>>>>                  at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
>>>>>>                  at hudson.model.Build$BuildExecution.post2(Build.java:179)
>>>>>>                  at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
>>>>>>                  at hudson.model.Run.execute(Run.java:1925)
>>>>>>                  at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
>>>>>>                  at hudson.model.ResourceController.execute(ResourceController.java:101)
>>>>>>                  at hudson.model.Executor.run(Executor.java:442)
>>>>>>  Caused: hudson.FilePath$TunneledInterruptedException
>>>>>>          at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3580)
>>>>>>          at hudson.remoting.UserRequest.perform(UserRequest.java:211)
>>>>>>          at hudson.remoting.UserRequest.perform(UserRequest.java:54)
>>>>>>          at hudson.remoting.Request$2.run(Request.java:377)
>>>>>>          at hudson.remoting.InterceptingExecutorService.lambda$wrap$0(InterceptingExecutorService.java:78)
>>>>>>          at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
>>>>>>          at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
>>>>>>          at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
>>>>>>          at java.base/java.lang.Thread.run(Thread.java:829)
>>>>>>  Caused: java.lang.InterruptedException: hudson.FilePath$FileMaskNoMatchesFoundException: no matches found within 10000
>>>>>>          at hudson.FilePath.act(FilePath.java:1194)
>>>>>>          at hudson.FilePath.act(FilePath.java:1181)
>>>>>>          at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
>>>>>>          at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
>>>>>>          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:818)
>>>>>>          at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
>>>>>>          at hudson.model.Build$BuildExecution.post2(Build.java:179)
>>>>>>          at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
>>>>>>          at hudson.model.Run.execute(Run.java:1925)
>>>>>>          at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
>>>>>>          at hudson.model.ResourceController.execute(ResourceController.java:101)
>>>>>>          at hudson.model.Executor.run(Executor.java:442)
>>>>>>  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-unsubscribe@lucene.apache.org
>>>>>>  For additional commands, e-mail: builds-help@lucene.apache.org
>>>>>>
>>>>> ------------------------------
>> To unsubscribe, e-mail: builds-unsubscribe@lucene.apache.org
>> For additional commands, e-mail: builds-help@lucene.apache.org
>>
>> --
> Uwe Schindler
> Achterdiek 19, 28357 Bremen
> https://www.thetaphi.de
>

Re: [JENKINS] Lucene » Lucene-NightlyTests-9.x - Build # 665 - Unstable!

Posted by Uwe Schindler <uw...@thetaphi.de>.
Let's fix this issue with bogus socket reuse. I am not sure why it is there. We touched the code last time around 2012....

Why does it has a timeout in setver at all? Normally the accept() call should have no timeout. If the client does not start fast enough, of course it runs into timeout.

The code is just good old socket accept loop as we have all learned it in school when we were fighting to write a small echo server with C. The bug here is the timeout. A timeout should only be in the client and not in the waiting call.

Uwe

Uwe

Am 31. August 2023 14:53:44 MESZ schrieb Robert Muir <rc...@gmail.com>:
>I looked at this lockverifyserver and would say its probably just the
>craziness of this code.
>
>it sets 30 second socket timeout and intentionally calls accept() when
>there is nothing yet to accept... well no wonder we see this issue.
>
>p.s. why does it set SO_REUSEADDR? no reason to do this leniency when
>binding to port 0. nuke it.
>
>On Thu, Aug 31, 2023 at 8:46 AM Robert Muir <rc...@gmail.com> wrote:
>>
>> probably a bug in some jvm sockets code that called accept() in its
>> default blocking mode, when there wasn't any connection to accept? in
>> that case accept() call will just block and wait for someone to make a
>> new connection.
>>
>> On Thu, Aug 31, 2023 at 8:16 AM Dawid Weiss <da...@gmail.com> wrote:
>> >
>> >
>> > https://ge.apache.org/s/orksynljk2yp6/tests/task/:lucene:core:test/details/org.apache.lucene.store.TestStressLockFactories/testSimpleFSLockFactory?top-execution=1
>> >
>> > This test took 31 seconds... An extremely slow vm, perhaps? I don't know what the default connection timeouts are... it does look weird though.
>> >
>> > Dawid
>> >
>> > On Thu, Aug 31, 2023 at 1:08 PM Michael McCandless <lu...@mikemccandless.com> wrote:
>> >>
>> >> Good grief -- why are we getting SocketTimeoutException in our LockVerifyServer's attempt to accept an incoming connection!?  These are all processes running on the same host ...
>> >>
>> >> Mike McCandless
>> >>
>> >> http://blog.mikemccandless.com
>> >>
>> >>
>> >> On Tue, Aug 29, 2023 at 11:17 PM Apache Jenkins Server <je...@builds.apache.org> wrote:
>> >>>
>> >>> Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-NightlyTests-9.x/665/
>> >>>
>> >>> 2 tests failed.
>> >>> FAILED:  org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory
>> >>>
>> >>> Error Message:
>> >>> java.net.SocketTimeoutException: Accept timed out
>> >>>
>> >>> Stack Trace:
>> >>> java.net.SocketTimeoutException: Accept timed out
>> >>>         at __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993:F325FE2A6E367AC7]:0)
>> >>>         at java.base/java.net.PlainSocketImpl.socketAccept(Native Method)
>> >>>         at java.base/java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:474)
>> >>>         at java.base/java.net.ServerSocket.implAccept(ServerSocket.java:565)
>> >>>         at java.base/java.net.ServerSocket.accept(ServerSocket.java:533)
>> >>>         at org.apache.lucene.store.LockVerifyServer.run(LockVerifyServer.java:62)
>> >>>         at org.apache.lucene.store.TestStressLockFactories.runImpl(TestStressLockFactories.java:53)
>> >>>         at org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory(TestStressLockFactories.java:104)
>> >>>         at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>> >>>         at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>> >>>         at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>> >>>         at java.base/java.lang.reflect.Method.invoke(Method.java:566)
>> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1758)
>> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:946)
>> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:982)
>> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:996)
>> >>>         at org.apache.lucene.tests.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:48)
>> >>>         at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>> >>>         at org.apache.lucene.tests.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
>> >>>         at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>> >>>         at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>> >>>         at org.junit.rules.RunRules.evaluate(RunRules.java:20)
>> >>>         at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>> >>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
>> >>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:843)
>> >>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:490)
>> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:955)
>> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:840)
>> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:891)
>> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:902)
>> >>>         at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>> >>>         at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>> >>>         at org.apache.lucene.tests.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
>> >>>         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 org.apache.lucene.tests.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
>> >>>         at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>> >>>         at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>> >>>         at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>> >>>         at org.apache.lucene.tests.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:47)
>> >>>         at org.junit.rules.RunRules.evaluate(RunRules.java:20)
>> >>>         at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>> >>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
>> >>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:850)
>> >>>         at java.base/java.lang.Thread.run(Thread.java:829)
>> >>>
>> >>>
>> >>> FAILED:  org.apache.lucene.store.TestStressLockFactories.classMethod
>> >>>
>> >>> Error Message:
>> >>> com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.lucene.store.TestStressLockFactories:
>> >>>    1) Thread[id=6713, name=Thread-5553, state=WAITING, group=TGRP-TestStressLockFactories]
>> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>> >>>    2) Thread[id=6710, name=Thread-5550, state=WAITING, group=TGRP-TestStressLockFactories]
>> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>> >>>    3) Thread[id=6712, name=Thread-5552, state=WAITING, group=TGRP-TestStressLockFactories]
>> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>> >>>    4) Thread[id=6711, name=Thread-5551, state=WAITING, group=TGRP-TestStressLockFactories]
>> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>> >>>
>> >>> Stack Trace:
>> >>> com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.lucene.store.TestStressLockFactories:
>> >>>    1) Thread[id=6713, name=Thread-5553, state=WAITING, group=TGRP-TestStressLockFactories]
>> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>> >>>    2) Thread[id=6710, name=Thread-5550, state=WAITING, group=TGRP-TestStressLockFactories]
>> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>> >>>    3) Thread[id=6712, name=Thread-5552, state=WAITING, group=TGRP-TestStressLockFactories]
>> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>> >>>    4) Thread[id=6711, name=Thread-5551, state=WAITING, group=TGRP-TestStressLockFactories]
>> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>> >>>         at __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993]:0)
>> >>>
>> >>>
>> >>>
>> >>>
>> >>> Build Log:
>> >>> [...truncated 674 lines...]
>> >>> ERROR: The following test(s) have failed:
>> >>>   - org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory (:lucene:core)
>> >>>     Test output: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
>> >>>     Reproduce with: gradlew :lucene:core:test --tests "org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs= -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1 -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
>> >>>
>> >>>   - org.apache.lucene.store.TestStressLockFactories.classMethod (:lucene:core)
>> >>>     Test output: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
>> >>>     Reproduce with: gradlew :lucene:core:test --tests "org.apache.lucene.store.TestStressLockFactories.classMethod" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs= -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1 -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
>> >>>
>> >>>
>> >>> BUILD SUCCESSFUL in 1h 41m 59s
>> >>> 243 actionable tasks: 112 executed, 131 up-to-date
>> >>>
>> >>> Publishing build scan...
>> >>> https://ge.apache.org/s/orksynljk2yp6
>> >>>
>> >>> Build step 'Invoke Gradle script' changed build result to SUCCESS
>> >>> Archiving artifacts
>> >>> hudson.FilePath$ValidateAntFileMask$1Cancel
>> >>>         at hudson.FilePath$ValidateAntFileMask$1.isCaseSensitive(FilePath.java:3300)
>> >>>         at org.apache.tools.ant.DirectoryScanner.lambda$isIncluded$3(DirectoryScanner.java:1374)
>> >>>         at java.base/java.util.stream.MatchOps$1MatchSink.accept(MatchOps.java:90)
>> >>>         at java.base/java.util.Spliterators$ArraySpliterator.tryAdvance(Spliterators.java:958)
>> >>>         at java.base/java.util.stream.ReferencePipeline.forEachWithCancel(ReferencePipeline.java:127)
>> >>>         at java.base/java.util.stream.AbstractPipeline.copyIntoWithCancel(AbstractPipeline.java:502)
>> >>>         at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:488)
>> >>>         at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:474)
>> >>>         at java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:230)
>> >>>         at java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:196)
>> >>>         at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234)
>> >>>         at java.base/java.util.stream.ReferencePipeline.anyMatch(ReferencePipeline.java:528)
>> >>>         at org.apache.tools.ant.DirectoryScanner.isIncluded(DirectoryScanner.java:1374)
>> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1260)
>> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1194)
>> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1156)
>> >>>         at org.apache.tools.ant.DirectoryScanner.checkIncludePatterns(DirectoryScanner.java:954)
>> >>>         at org.apache.tools.ant.DirectoryScanner.scan(DirectoryScanner.java:912)
>> >>>         at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3313)
>> >>> Caused: hudson.FilePath$FileMaskNoMatchesFoundException: no matches found within 10000
>> >>>         at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3318)
>> >>>         at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3196)
>> >>>         at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3174)
>> >>>         at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3578)
>> >>> Also:   hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene-solr-2
>> >>>                 at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1784)
>> >>>                 at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
>> >>>                 at hudson.remoting.Channel.call(Channel.java:1000)
>> >>>                 at hudson.FilePath.act(FilePath.java:1192)
>> >>>                 at hudson.FilePath.act(FilePath.java:1181)
>> >>>                 at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
>> >>>                 at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
>> >>>                 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:818)
>> >>>                 at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
>> >>>                 at hudson.model.Build$BuildExecution.post2(Build.java:179)
>> >>>                 at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
>> >>>                 at hudson.model.Run.execute(Run.java:1925)
>> >>>                 at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
>> >>>                 at hudson.model.ResourceController.execute(ResourceController.java:101)
>> >>>                 at hudson.model.Executor.run(Executor.java:442)
>> >>> Caused: hudson.FilePath$TunneledInterruptedException
>> >>>         at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3580)
>> >>>         at hudson.remoting.UserRequest.perform(UserRequest.java:211)
>> >>>         at hudson.remoting.UserRequest.perform(UserRequest.java:54)
>> >>>         at hudson.remoting.Request$2.run(Request.java:377)
>> >>>         at hudson.remoting.InterceptingExecutorService.lambda$wrap$0(InterceptingExecutorService.java:78)
>> >>>         at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
>> >>>         at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
>> >>>         at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
>> >>>         at java.base/java.lang.Thread.run(Thread.java:829)
>> >>> Caused: java.lang.InterruptedException: hudson.FilePath$FileMaskNoMatchesFoundException: no matches found within 10000
>> >>>         at hudson.FilePath.act(FilePath.java:1194)
>> >>>         at hudson.FilePath.act(FilePath.java:1181)
>> >>>         at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
>> >>>         at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
>> >>>         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:818)
>> >>>         at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
>> >>>         at hudson.model.Build$BuildExecution.post2(Build.java:179)
>> >>>         at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
>> >>>         at hudson.model.Run.execute(Run.java:1925)
>> >>>         at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
>> >>>         at hudson.model.ResourceController.execute(ResourceController.java:101)
>> >>>         at hudson.model.Executor.run(Executor.java:442)
>> >>> 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-unsubscribe@lucene.apache.org
>> >>> For additional commands, e-mail: builds-help@lucene.apache.org
>
>---------------------------------------------------------------------
>To unsubscribe, e-mail: builds-unsubscribe@lucene.apache.org
>For additional commands, e-mail: builds-help@lucene.apache.org
>

--
Uwe Schindler
Achterdiek 19, 28357 Bremen
https://www.thetaphi.de

Re: [JENKINS] Lucene » Lucene-NightlyTests-9.x - Build # 665 - Unstable!

Posted by Robert Muir <rc...@gmail.com>.
I looked at this lockverifyserver and would say its probably just the
craziness of this code.

it sets 30 second socket timeout and intentionally calls accept() when
there is nothing yet to accept... well no wonder we see this issue.

p.s. why does it set SO_REUSEADDR? no reason to do this leniency when
binding to port 0. nuke it.

On Thu, Aug 31, 2023 at 8:46 AM Robert Muir <rc...@gmail.com> wrote:
>
> probably a bug in some jvm sockets code that called accept() in its
> default blocking mode, when there wasn't any connection to accept? in
> that case accept() call will just block and wait for someone to make a
> new connection.
>
> On Thu, Aug 31, 2023 at 8:16 AM Dawid Weiss <da...@gmail.com> wrote:
> >
> >
> > https://ge.apache.org/s/orksynljk2yp6/tests/task/:lucene:core:test/details/org.apache.lucene.store.TestStressLockFactories/testSimpleFSLockFactory?top-execution=1
> >
> > This test took 31 seconds... An extremely slow vm, perhaps? I don't know what the default connection timeouts are... it does look weird though.
> >
> > Dawid
> >
> > On Thu, Aug 31, 2023 at 1:08 PM Michael McCandless <lu...@mikemccandless.com> wrote:
> >>
> >> Good grief -- why are we getting SocketTimeoutException in our LockVerifyServer's attempt to accept an incoming connection!?  These are all processes running on the same host ...
> >>
> >> Mike McCandless
> >>
> >> http://blog.mikemccandless.com
> >>
> >>
> >> On Tue, Aug 29, 2023 at 11:17 PM Apache Jenkins Server <je...@builds.apache.org> wrote:
> >>>
> >>> Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-NightlyTests-9.x/665/
> >>>
> >>> 2 tests failed.
> >>> FAILED:  org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory
> >>>
> >>> Error Message:
> >>> java.net.SocketTimeoutException: Accept timed out
> >>>
> >>> Stack Trace:
> >>> java.net.SocketTimeoutException: Accept timed out
> >>>         at __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993:F325FE2A6E367AC7]:0)
> >>>         at java.base/java.net.PlainSocketImpl.socketAccept(Native Method)
> >>>         at java.base/java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:474)
> >>>         at java.base/java.net.ServerSocket.implAccept(ServerSocket.java:565)
> >>>         at java.base/java.net.ServerSocket.accept(ServerSocket.java:533)
> >>>         at org.apache.lucene.store.LockVerifyServer.run(LockVerifyServer.java:62)
> >>>         at org.apache.lucene.store.TestStressLockFactories.runImpl(TestStressLockFactories.java:53)
> >>>         at org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory(TestStressLockFactories.java:104)
> >>>         at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> >>>         at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> >>>         at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> >>>         at java.base/java.lang.reflect.Method.invoke(Method.java:566)
> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1758)
> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:946)
> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:982)
> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:996)
> >>>         at org.apache.lucene.tests.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:48)
> >>>         at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
> >>>         at org.apache.lucene.tests.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
> >>>         at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
> >>>         at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
> >>>         at org.junit.rules.RunRules.evaluate(RunRules.java:20)
> >>>         at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
> >>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
> >>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:843)
> >>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:490)
> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:955)
> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:840)
> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:891)
> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:902)
> >>>         at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
> >>>         at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
> >>>         at org.apache.lucene.tests.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
> >>>         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 org.apache.lucene.tests.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
> >>>         at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
> >>>         at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
> >>>         at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
> >>>         at org.apache.lucene.tests.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:47)
> >>>         at org.junit.rules.RunRules.evaluate(RunRules.java:20)
> >>>         at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
> >>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
> >>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:850)
> >>>         at java.base/java.lang.Thread.run(Thread.java:829)
> >>>
> >>>
> >>> FAILED:  org.apache.lucene.store.TestStressLockFactories.classMethod
> >>>
> >>> Error Message:
> >>> com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.lucene.store.TestStressLockFactories:
> >>>    1) Thread[id=6713, name=Thread-5553, state=WAITING, group=TGRP-TestStressLockFactories]
> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
> >>>    2) Thread[id=6710, name=Thread-5550, state=WAITING, group=TGRP-TestStressLockFactories]
> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
> >>>    3) Thread[id=6712, name=Thread-5552, state=WAITING, group=TGRP-TestStressLockFactories]
> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
> >>>    4) Thread[id=6711, name=Thread-5551, state=WAITING, group=TGRP-TestStressLockFactories]
> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
> >>>
> >>> Stack Trace:
> >>> com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.lucene.store.TestStressLockFactories:
> >>>    1) Thread[id=6713, name=Thread-5553, state=WAITING, group=TGRP-TestStressLockFactories]
> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
> >>>    2) Thread[id=6710, name=Thread-5550, state=WAITING, group=TGRP-TestStressLockFactories]
> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
> >>>    3) Thread[id=6712, name=Thread-5552, state=WAITING, group=TGRP-TestStressLockFactories]
> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
> >>>    4) Thread[id=6711, name=Thread-5551, state=WAITING, group=TGRP-TestStressLockFactories]
> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
> >>>         at __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993]:0)
> >>>
> >>>
> >>>
> >>>
> >>> Build Log:
> >>> [...truncated 674 lines...]
> >>> ERROR: The following test(s) have failed:
> >>>   - org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory (:lucene:core)
> >>>     Test output: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
> >>>     Reproduce with: gradlew :lucene:core:test --tests "org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs= -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1 -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
> >>>
> >>>   - org.apache.lucene.store.TestStressLockFactories.classMethod (:lucene:core)
> >>>     Test output: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
> >>>     Reproduce with: gradlew :lucene:core:test --tests "org.apache.lucene.store.TestStressLockFactories.classMethod" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs= -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1 -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
> >>>
> >>>
> >>> BUILD SUCCESSFUL in 1h 41m 59s
> >>> 243 actionable tasks: 112 executed, 131 up-to-date
> >>>
> >>> Publishing build scan...
> >>> https://ge.apache.org/s/orksynljk2yp6
> >>>
> >>> Build step 'Invoke Gradle script' changed build result to SUCCESS
> >>> Archiving artifacts
> >>> hudson.FilePath$ValidateAntFileMask$1Cancel
> >>>         at hudson.FilePath$ValidateAntFileMask$1.isCaseSensitive(FilePath.java:3300)
> >>>         at org.apache.tools.ant.DirectoryScanner.lambda$isIncluded$3(DirectoryScanner.java:1374)
> >>>         at java.base/java.util.stream.MatchOps$1MatchSink.accept(MatchOps.java:90)
> >>>         at java.base/java.util.Spliterators$ArraySpliterator.tryAdvance(Spliterators.java:958)
> >>>         at java.base/java.util.stream.ReferencePipeline.forEachWithCancel(ReferencePipeline.java:127)
> >>>         at java.base/java.util.stream.AbstractPipeline.copyIntoWithCancel(AbstractPipeline.java:502)
> >>>         at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:488)
> >>>         at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:474)
> >>>         at java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:230)
> >>>         at java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:196)
> >>>         at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234)
> >>>         at java.base/java.util.stream.ReferencePipeline.anyMatch(ReferencePipeline.java:528)
> >>>         at org.apache.tools.ant.DirectoryScanner.isIncluded(DirectoryScanner.java:1374)
> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1260)
> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1194)
> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1156)
> >>>         at org.apache.tools.ant.DirectoryScanner.checkIncludePatterns(DirectoryScanner.java:954)
> >>>         at org.apache.tools.ant.DirectoryScanner.scan(DirectoryScanner.java:912)
> >>>         at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3313)
> >>> Caused: hudson.FilePath$FileMaskNoMatchesFoundException: no matches found within 10000
> >>>         at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3318)
> >>>         at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3196)
> >>>         at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3174)
> >>>         at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3578)
> >>> Also:   hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene-solr-2
> >>>                 at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1784)
> >>>                 at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
> >>>                 at hudson.remoting.Channel.call(Channel.java:1000)
> >>>                 at hudson.FilePath.act(FilePath.java:1192)
> >>>                 at hudson.FilePath.act(FilePath.java:1181)
> >>>                 at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
> >>>                 at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
> >>>                 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:818)
> >>>                 at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
> >>>                 at hudson.model.Build$BuildExecution.post2(Build.java:179)
> >>>                 at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
> >>>                 at hudson.model.Run.execute(Run.java:1925)
> >>>                 at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
> >>>                 at hudson.model.ResourceController.execute(ResourceController.java:101)
> >>>                 at hudson.model.Executor.run(Executor.java:442)
> >>> Caused: hudson.FilePath$TunneledInterruptedException
> >>>         at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3580)
> >>>         at hudson.remoting.UserRequest.perform(UserRequest.java:211)
> >>>         at hudson.remoting.UserRequest.perform(UserRequest.java:54)
> >>>         at hudson.remoting.Request$2.run(Request.java:377)
> >>>         at hudson.remoting.InterceptingExecutorService.lambda$wrap$0(InterceptingExecutorService.java:78)
> >>>         at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
> >>>         at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
> >>>         at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
> >>>         at java.base/java.lang.Thread.run(Thread.java:829)
> >>> Caused: java.lang.InterruptedException: hudson.FilePath$FileMaskNoMatchesFoundException: no matches found within 10000
> >>>         at hudson.FilePath.act(FilePath.java:1194)
> >>>         at hudson.FilePath.act(FilePath.java:1181)
> >>>         at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
> >>>         at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
> >>>         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:818)
> >>>         at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
> >>>         at hudson.model.Build$BuildExecution.post2(Build.java:179)
> >>>         at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
> >>>         at hudson.model.Run.execute(Run.java:1925)
> >>>         at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
> >>>         at hudson.model.ResourceController.execute(ResourceController.java:101)
> >>>         at hudson.model.Executor.run(Executor.java:442)
> >>> 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-unsubscribe@lucene.apache.org
> >>> For additional commands, e-mail: builds-help@lucene.apache.org

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


Re: [JENKINS] Lucene » Lucene-NightlyTests-9.x - Build # 665 - Unstable!

Posted by Robert Muir <rc...@gmail.com>.
I looked at this lockverifyserver and would say its probably just the
craziness of this code.

it sets 30 second socket timeout and intentionally calls accept() when
there is nothing yet to accept... well no wonder we see this issue.

p.s. why does it set SO_REUSEADDR? no reason to do this leniency when
binding to port 0. nuke it.

On Thu, Aug 31, 2023 at 8:46 AM Robert Muir <rc...@gmail.com> wrote:
>
> probably a bug in some jvm sockets code that called accept() in its
> default blocking mode, when there wasn't any connection to accept? in
> that case accept() call will just block and wait for someone to make a
> new connection.
>
> On Thu, Aug 31, 2023 at 8:16 AM Dawid Weiss <da...@gmail.com> wrote:
> >
> >
> > https://ge.apache.org/s/orksynljk2yp6/tests/task/:lucene:core:test/details/org.apache.lucene.store.TestStressLockFactories/testSimpleFSLockFactory?top-execution=1
> >
> > This test took 31 seconds... An extremely slow vm, perhaps? I don't know what the default connection timeouts are... it does look weird though.
> >
> > Dawid
> >
> > On Thu, Aug 31, 2023 at 1:08 PM Michael McCandless <lu...@mikemccandless.com> wrote:
> >>
> >> Good grief -- why are we getting SocketTimeoutException in our LockVerifyServer's attempt to accept an incoming connection!?  These are all processes running on the same host ...
> >>
> >> Mike McCandless
> >>
> >> http://blog.mikemccandless.com
> >>
> >>
> >> On Tue, Aug 29, 2023 at 11:17 PM Apache Jenkins Server <je...@builds.apache.org> wrote:
> >>>
> >>> Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-NightlyTests-9.x/665/
> >>>
> >>> 2 tests failed.
> >>> FAILED:  org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory
> >>>
> >>> Error Message:
> >>> java.net.SocketTimeoutException: Accept timed out
> >>>
> >>> Stack Trace:
> >>> java.net.SocketTimeoutException: Accept timed out
> >>>         at __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993:F325FE2A6E367AC7]:0)
> >>>         at java.base/java.net.PlainSocketImpl.socketAccept(Native Method)
> >>>         at java.base/java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:474)
> >>>         at java.base/java.net.ServerSocket.implAccept(ServerSocket.java:565)
> >>>         at java.base/java.net.ServerSocket.accept(ServerSocket.java:533)
> >>>         at org.apache.lucene.store.LockVerifyServer.run(LockVerifyServer.java:62)
> >>>         at org.apache.lucene.store.TestStressLockFactories.runImpl(TestStressLockFactories.java:53)
> >>>         at org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory(TestStressLockFactories.java:104)
> >>>         at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> >>>         at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> >>>         at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> >>>         at java.base/java.lang.reflect.Method.invoke(Method.java:566)
> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1758)
> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:946)
> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:982)
> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:996)
> >>>         at org.apache.lucene.tests.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:48)
> >>>         at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
> >>>         at org.apache.lucene.tests.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
> >>>         at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
> >>>         at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
> >>>         at org.junit.rules.RunRules.evaluate(RunRules.java:20)
> >>>         at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
> >>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
> >>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:843)
> >>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:490)
> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:955)
> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:840)
> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:891)
> >>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:902)
> >>>         at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
> >>>         at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
> >>>         at org.apache.lucene.tests.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
> >>>         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 org.apache.lucene.tests.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
> >>>         at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
> >>>         at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
> >>>         at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
> >>>         at org.apache.lucene.tests.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:47)
> >>>         at org.junit.rules.RunRules.evaluate(RunRules.java:20)
> >>>         at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
> >>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
> >>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:850)
> >>>         at java.base/java.lang.Thread.run(Thread.java:829)
> >>>
> >>>
> >>> FAILED:  org.apache.lucene.store.TestStressLockFactories.classMethod
> >>>
> >>> Error Message:
> >>> com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.lucene.store.TestStressLockFactories:
> >>>    1) Thread[id=6713, name=Thread-5553, state=WAITING, group=TGRP-TestStressLockFactories]
> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
> >>>    2) Thread[id=6710, name=Thread-5550, state=WAITING, group=TGRP-TestStressLockFactories]
> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
> >>>    3) Thread[id=6712, name=Thread-5552, state=WAITING, group=TGRP-TestStressLockFactories]
> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
> >>>    4) Thread[id=6711, name=Thread-5551, state=WAITING, group=TGRP-TestStressLockFactories]
> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
> >>>
> >>> Stack Trace:
> >>> com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.lucene.store.TestStressLockFactories:
> >>>    1) Thread[id=6713, name=Thread-5553, state=WAITING, group=TGRP-TestStressLockFactories]
> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
> >>>    2) Thread[id=6710, name=Thread-5550, state=WAITING, group=TGRP-TestStressLockFactories]
> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
> >>>    3) Thread[id=6712, name=Thread-5552, state=WAITING, group=TGRP-TestStressLockFactories]
> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
> >>>    4) Thread[id=6711, name=Thread-5551, state=WAITING, group=TGRP-TestStressLockFactories]
> >>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
> >>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
> >>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
> >>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
> >>>         at __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993]:0)
> >>>
> >>>
> >>>
> >>>
> >>> Build Log:
> >>> [...truncated 674 lines...]
> >>> ERROR: The following test(s) have failed:
> >>>   - org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory (:lucene:core)
> >>>     Test output: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
> >>>     Reproduce with: gradlew :lucene:core:test --tests "org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs= -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1 -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
> >>>
> >>>   - org.apache.lucene.store.TestStressLockFactories.classMethod (:lucene:core)
> >>>     Test output: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
> >>>     Reproduce with: gradlew :lucene:core:test --tests "org.apache.lucene.store.TestStressLockFactories.classMethod" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs= -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1 -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
> >>>
> >>>
> >>> BUILD SUCCESSFUL in 1h 41m 59s
> >>> 243 actionable tasks: 112 executed, 131 up-to-date
> >>>
> >>> Publishing build scan...
> >>> https://ge.apache.org/s/orksynljk2yp6
> >>>
> >>> Build step 'Invoke Gradle script' changed build result to SUCCESS
> >>> Archiving artifacts
> >>> hudson.FilePath$ValidateAntFileMask$1Cancel
> >>>         at hudson.FilePath$ValidateAntFileMask$1.isCaseSensitive(FilePath.java:3300)
> >>>         at org.apache.tools.ant.DirectoryScanner.lambda$isIncluded$3(DirectoryScanner.java:1374)
> >>>         at java.base/java.util.stream.MatchOps$1MatchSink.accept(MatchOps.java:90)
> >>>         at java.base/java.util.Spliterators$ArraySpliterator.tryAdvance(Spliterators.java:958)
> >>>         at java.base/java.util.stream.ReferencePipeline.forEachWithCancel(ReferencePipeline.java:127)
> >>>         at java.base/java.util.stream.AbstractPipeline.copyIntoWithCancel(AbstractPipeline.java:502)
> >>>         at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:488)
> >>>         at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:474)
> >>>         at java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:230)
> >>>         at java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:196)
> >>>         at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234)
> >>>         at java.base/java.util.stream.ReferencePipeline.anyMatch(ReferencePipeline.java:528)
> >>>         at org.apache.tools.ant.DirectoryScanner.isIncluded(DirectoryScanner.java:1374)
> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1260)
> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1194)
> >>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1156)
> >>>         at org.apache.tools.ant.DirectoryScanner.checkIncludePatterns(DirectoryScanner.java:954)
> >>>         at org.apache.tools.ant.DirectoryScanner.scan(DirectoryScanner.java:912)
> >>>         at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3313)
> >>> Caused: hudson.FilePath$FileMaskNoMatchesFoundException: no matches found within 10000
> >>>         at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3318)
> >>>         at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3196)
> >>>         at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3174)
> >>>         at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3578)
> >>> Also:   hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene-solr-2
> >>>                 at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1784)
> >>>                 at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
> >>>                 at hudson.remoting.Channel.call(Channel.java:1000)
> >>>                 at hudson.FilePath.act(FilePath.java:1192)
> >>>                 at hudson.FilePath.act(FilePath.java:1181)
> >>>                 at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
> >>>                 at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
> >>>                 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:818)
> >>>                 at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
> >>>                 at hudson.model.Build$BuildExecution.post2(Build.java:179)
> >>>                 at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
> >>>                 at hudson.model.Run.execute(Run.java:1925)
> >>>                 at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
> >>>                 at hudson.model.ResourceController.execute(ResourceController.java:101)
> >>>                 at hudson.model.Executor.run(Executor.java:442)
> >>> Caused: hudson.FilePath$TunneledInterruptedException
> >>>         at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3580)
> >>>         at hudson.remoting.UserRequest.perform(UserRequest.java:211)
> >>>         at hudson.remoting.UserRequest.perform(UserRequest.java:54)
> >>>         at hudson.remoting.Request$2.run(Request.java:377)
> >>>         at hudson.remoting.InterceptingExecutorService.lambda$wrap$0(InterceptingExecutorService.java:78)
> >>>         at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
> >>>         at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
> >>>         at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
> >>>         at java.base/java.lang.Thread.run(Thread.java:829)
> >>> Caused: java.lang.InterruptedException: hudson.FilePath$FileMaskNoMatchesFoundException: no matches found within 10000
> >>>         at hudson.FilePath.act(FilePath.java:1194)
> >>>         at hudson.FilePath.act(FilePath.java:1181)
> >>>         at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
> >>>         at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
> >>>         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:818)
> >>>         at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
> >>>         at hudson.model.Build$BuildExecution.post2(Build.java:179)
> >>>         at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
> >>>         at hudson.model.Run.execute(Run.java:1925)
> >>>         at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
> >>>         at hudson.model.ResourceController.execute(ResourceController.java:101)
> >>>         at hudson.model.Executor.run(Executor.java:442)
> >>> 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-unsubscribe@lucene.apache.org
> >>> For additional commands, e-mail: builds-help@lucene.apache.org

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


Re: [JENKINS] Lucene » Lucene-NightlyTests-9.x - Build # 665 - Unstable!

Posted by Robert Muir <rc...@gmail.com>.
probably a bug in some jvm sockets code that called accept() in its
default blocking mode, when there wasn't any connection to accept? in
that case accept() call will just block and wait for someone to make a
new connection.

On Thu, Aug 31, 2023 at 8:16 AM Dawid Weiss <da...@gmail.com> wrote:
>
>
> https://ge.apache.org/s/orksynljk2yp6/tests/task/:lucene:core:test/details/org.apache.lucene.store.TestStressLockFactories/testSimpleFSLockFactory?top-execution=1
>
> This test took 31 seconds... An extremely slow vm, perhaps? I don't know what the default connection timeouts are... it does look weird though.
>
> Dawid
>
> On Thu, Aug 31, 2023 at 1:08 PM Michael McCandless <lu...@mikemccandless.com> wrote:
>>
>> Good grief -- why are we getting SocketTimeoutException in our LockVerifyServer's attempt to accept an incoming connection!?  These are all processes running on the same host ...
>>
>> Mike McCandless
>>
>> http://blog.mikemccandless.com
>>
>>
>> On Tue, Aug 29, 2023 at 11:17 PM Apache Jenkins Server <je...@builds.apache.org> wrote:
>>>
>>> Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-NightlyTests-9.x/665/
>>>
>>> 2 tests failed.
>>> FAILED:  org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory
>>>
>>> Error Message:
>>> java.net.SocketTimeoutException: Accept timed out
>>>
>>> Stack Trace:
>>> java.net.SocketTimeoutException: Accept timed out
>>>         at __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993:F325FE2A6E367AC7]:0)
>>>         at java.base/java.net.PlainSocketImpl.socketAccept(Native Method)
>>>         at java.base/java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:474)
>>>         at java.base/java.net.ServerSocket.implAccept(ServerSocket.java:565)
>>>         at java.base/java.net.ServerSocket.accept(ServerSocket.java:533)
>>>         at org.apache.lucene.store.LockVerifyServer.run(LockVerifyServer.java:62)
>>>         at org.apache.lucene.store.TestStressLockFactories.runImpl(TestStressLockFactories.java:53)
>>>         at org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory(TestStressLockFactories.java:104)
>>>         at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>>>         at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>>>         at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>>>         at java.base/java.lang.reflect.Method.invoke(Method.java:566)
>>>         at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1758)
>>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:946)
>>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:982)
>>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:996)
>>>         at org.apache.lucene.tests.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:48)
>>>         at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>>         at org.apache.lucene.tests.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
>>>         at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>>>         at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>>>         at org.junit.rules.RunRules.evaluate(RunRules.java:20)
>>>         at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
>>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:843)
>>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:490)
>>>         at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:955)
>>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:840)
>>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:891)
>>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:902)
>>>         at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>>         at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>>         at org.apache.lucene.tests.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
>>>         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 org.apache.lucene.tests.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
>>>         at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>>         at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>>>         at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>>>         at org.apache.lucene.tests.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:47)
>>>         at org.junit.rules.RunRules.evaluate(RunRules.java:20)
>>>         at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
>>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:850)
>>>         at java.base/java.lang.Thread.run(Thread.java:829)
>>>
>>>
>>> FAILED:  org.apache.lucene.store.TestStressLockFactories.classMethod
>>>
>>> Error Message:
>>> com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.lucene.store.TestStressLockFactories:
>>>    1) Thread[id=6713, name=Thread-5553, state=WAITING, group=TGRP-TestStressLockFactories]
>>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>    2) Thread[id=6710, name=Thread-5550, state=WAITING, group=TGRP-TestStressLockFactories]
>>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>    3) Thread[id=6712, name=Thread-5552, state=WAITING, group=TGRP-TestStressLockFactories]
>>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>    4) Thread[id=6711, name=Thread-5551, state=WAITING, group=TGRP-TestStressLockFactories]
>>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>
>>> Stack Trace:
>>> com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.lucene.store.TestStressLockFactories:
>>>    1) Thread[id=6713, name=Thread-5553, state=WAITING, group=TGRP-TestStressLockFactories]
>>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>    2) Thread[id=6710, name=Thread-5550, state=WAITING, group=TGRP-TestStressLockFactories]
>>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>    3) Thread[id=6712, name=Thread-5552, state=WAITING, group=TGRP-TestStressLockFactories]
>>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>    4) Thread[id=6711, name=Thread-5551, state=WAITING, group=TGRP-TestStressLockFactories]
>>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>         at __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993]:0)
>>>
>>>
>>>
>>>
>>> Build Log:
>>> [...truncated 674 lines...]
>>> ERROR: The following test(s) have failed:
>>>   - org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory (:lucene:core)
>>>     Test output: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
>>>     Reproduce with: gradlew :lucene:core:test --tests "org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs= -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1 -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
>>>
>>>   - org.apache.lucene.store.TestStressLockFactories.classMethod (:lucene:core)
>>>     Test output: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
>>>     Reproduce with: gradlew :lucene:core:test --tests "org.apache.lucene.store.TestStressLockFactories.classMethod" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs= -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1 -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
>>>
>>>
>>> BUILD SUCCESSFUL in 1h 41m 59s
>>> 243 actionable tasks: 112 executed, 131 up-to-date
>>>
>>> Publishing build scan...
>>> https://ge.apache.org/s/orksynljk2yp6
>>>
>>> Build step 'Invoke Gradle script' changed build result to SUCCESS
>>> Archiving artifacts
>>> hudson.FilePath$ValidateAntFileMask$1Cancel
>>>         at hudson.FilePath$ValidateAntFileMask$1.isCaseSensitive(FilePath.java:3300)
>>>         at org.apache.tools.ant.DirectoryScanner.lambda$isIncluded$3(DirectoryScanner.java:1374)
>>>         at java.base/java.util.stream.MatchOps$1MatchSink.accept(MatchOps.java:90)
>>>         at java.base/java.util.Spliterators$ArraySpliterator.tryAdvance(Spliterators.java:958)
>>>         at java.base/java.util.stream.ReferencePipeline.forEachWithCancel(ReferencePipeline.java:127)
>>>         at java.base/java.util.stream.AbstractPipeline.copyIntoWithCancel(AbstractPipeline.java:502)
>>>         at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:488)
>>>         at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:474)
>>>         at java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:230)
>>>         at java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:196)
>>>         at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234)
>>>         at java.base/java.util.stream.ReferencePipeline.anyMatch(ReferencePipeline.java:528)
>>>         at org.apache.tools.ant.DirectoryScanner.isIncluded(DirectoryScanner.java:1374)
>>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1260)
>>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1194)
>>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1156)
>>>         at org.apache.tools.ant.DirectoryScanner.checkIncludePatterns(DirectoryScanner.java:954)
>>>         at org.apache.tools.ant.DirectoryScanner.scan(DirectoryScanner.java:912)
>>>         at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3313)
>>> Caused: hudson.FilePath$FileMaskNoMatchesFoundException: no matches found within 10000
>>>         at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3318)
>>>         at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3196)
>>>         at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3174)
>>>         at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3578)
>>> Also:   hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene-solr-2
>>>                 at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1784)
>>>                 at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
>>>                 at hudson.remoting.Channel.call(Channel.java:1000)
>>>                 at hudson.FilePath.act(FilePath.java:1192)
>>>                 at hudson.FilePath.act(FilePath.java:1181)
>>>                 at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
>>>                 at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
>>>                 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:818)
>>>                 at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
>>>                 at hudson.model.Build$BuildExecution.post2(Build.java:179)
>>>                 at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
>>>                 at hudson.model.Run.execute(Run.java:1925)
>>>                 at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
>>>                 at hudson.model.ResourceController.execute(ResourceController.java:101)
>>>                 at hudson.model.Executor.run(Executor.java:442)
>>> Caused: hudson.FilePath$TunneledInterruptedException
>>>         at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3580)
>>>         at hudson.remoting.UserRequest.perform(UserRequest.java:211)
>>>         at hudson.remoting.UserRequest.perform(UserRequest.java:54)
>>>         at hudson.remoting.Request$2.run(Request.java:377)
>>>         at hudson.remoting.InterceptingExecutorService.lambda$wrap$0(InterceptingExecutorService.java:78)
>>>         at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
>>>         at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
>>>         at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
>>>         at java.base/java.lang.Thread.run(Thread.java:829)
>>> Caused: java.lang.InterruptedException: hudson.FilePath$FileMaskNoMatchesFoundException: no matches found within 10000
>>>         at hudson.FilePath.act(FilePath.java:1194)
>>>         at hudson.FilePath.act(FilePath.java:1181)
>>>         at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
>>>         at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
>>>         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:818)
>>>         at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
>>>         at hudson.model.Build$BuildExecution.post2(Build.java:179)
>>>         at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
>>>         at hudson.model.Run.execute(Run.java:1925)
>>>         at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
>>>         at hudson.model.ResourceController.execute(ResourceController.java:101)
>>>         at hudson.model.Executor.run(Executor.java:442)
>>> 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-unsubscribe@lucene.apache.org
>>> For additional commands, e-mail: builds-help@lucene.apache.org

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


Re: [JENKINS] Lucene » Lucene-NightlyTests-9.x - Build # 665 - Unstable!

Posted by Robert Muir <rc...@gmail.com>.
probably a bug in some jvm sockets code that called accept() in its
default blocking mode, when there wasn't any connection to accept? in
that case accept() call will just block and wait for someone to make a
new connection.

On Thu, Aug 31, 2023 at 8:16 AM Dawid Weiss <da...@gmail.com> wrote:
>
>
> https://ge.apache.org/s/orksynljk2yp6/tests/task/:lucene:core:test/details/org.apache.lucene.store.TestStressLockFactories/testSimpleFSLockFactory?top-execution=1
>
> This test took 31 seconds... An extremely slow vm, perhaps? I don't know what the default connection timeouts are... it does look weird though.
>
> Dawid
>
> On Thu, Aug 31, 2023 at 1:08 PM Michael McCandless <lu...@mikemccandless.com> wrote:
>>
>> Good grief -- why are we getting SocketTimeoutException in our LockVerifyServer's attempt to accept an incoming connection!?  These are all processes running on the same host ...
>>
>> Mike McCandless
>>
>> http://blog.mikemccandless.com
>>
>>
>> On Tue, Aug 29, 2023 at 11:17 PM Apache Jenkins Server <je...@builds.apache.org> wrote:
>>>
>>> Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-NightlyTests-9.x/665/
>>>
>>> 2 tests failed.
>>> FAILED:  org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory
>>>
>>> Error Message:
>>> java.net.SocketTimeoutException: Accept timed out
>>>
>>> Stack Trace:
>>> java.net.SocketTimeoutException: Accept timed out
>>>         at __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993:F325FE2A6E367AC7]:0)
>>>         at java.base/java.net.PlainSocketImpl.socketAccept(Native Method)
>>>         at java.base/java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:474)
>>>         at java.base/java.net.ServerSocket.implAccept(ServerSocket.java:565)
>>>         at java.base/java.net.ServerSocket.accept(ServerSocket.java:533)
>>>         at org.apache.lucene.store.LockVerifyServer.run(LockVerifyServer.java:62)
>>>         at org.apache.lucene.store.TestStressLockFactories.runImpl(TestStressLockFactories.java:53)
>>>         at org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory(TestStressLockFactories.java:104)
>>>         at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>>>         at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>>>         at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>>>         at java.base/java.lang.reflect.Method.invoke(Method.java:566)
>>>         at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1758)
>>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:946)
>>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:982)
>>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:996)
>>>         at org.apache.lucene.tests.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:48)
>>>         at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>>         at org.apache.lucene.tests.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
>>>         at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>>>         at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>>>         at org.junit.rules.RunRules.evaluate(RunRules.java:20)
>>>         at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
>>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:843)
>>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:490)
>>>         at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:955)
>>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:840)
>>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:891)
>>>         at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:902)
>>>         at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>>         at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>>         at org.apache.lucene.tests.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
>>>         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 org.apache.lucene.tests.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
>>>         at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>>         at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>>>         at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>>>         at org.apache.lucene.tests.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:47)
>>>         at org.junit.rules.RunRules.evaluate(RunRules.java:20)
>>>         at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
>>>         at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:850)
>>>         at java.base/java.lang.Thread.run(Thread.java:829)
>>>
>>>
>>> FAILED:  org.apache.lucene.store.TestStressLockFactories.classMethod
>>>
>>> Error Message:
>>> com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.lucene.store.TestStressLockFactories:
>>>    1) Thread[id=6713, name=Thread-5553, state=WAITING, group=TGRP-TestStressLockFactories]
>>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>    2) Thread[id=6710, name=Thread-5550, state=WAITING, group=TGRP-TestStressLockFactories]
>>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>    3) Thread[id=6712, name=Thread-5552, state=WAITING, group=TGRP-TestStressLockFactories]
>>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>    4) Thread[id=6711, name=Thread-5551, state=WAITING, group=TGRP-TestStressLockFactories]
>>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>
>>> Stack Trace:
>>> com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.lucene.store.TestStressLockFactories:
>>>    1) Thread[id=6713, name=Thread-5553, state=WAITING, group=TGRP-TestStressLockFactories]
>>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>    2) Thread[id=6710, name=Thread-5550, state=WAITING, group=TGRP-TestStressLockFactories]
>>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>    3) Thread[id=6712, name=Thread-5552, state=WAITING, group=TGRP-TestStressLockFactories]
>>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>    4) Thread[id=6711, name=Thread-5551, state=WAITING, group=TGRP-TestStressLockFactories]
>>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native Method)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>>         at java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>>         at java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>>         at app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>>         at __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993]:0)
>>>
>>>
>>>
>>>
>>> Build Log:
>>> [...truncated 674 lines...]
>>> ERROR: The following test(s) have failed:
>>>   - org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory (:lucene:core)
>>>     Test output: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
>>>     Reproduce with: gradlew :lucene:core:test --tests "org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs= -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1 -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
>>>
>>>   - org.apache.lucene.store.TestStressLockFactories.classMethod (:lucene:core)
>>>     Test output: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
>>>     Reproduce with: gradlew :lucene:core:test --tests "org.apache.lucene.store.TestStressLockFactories.classMethod" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs= -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1 -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
>>>
>>>
>>> BUILD SUCCESSFUL in 1h 41m 59s
>>> 243 actionable tasks: 112 executed, 131 up-to-date
>>>
>>> Publishing build scan...
>>> https://ge.apache.org/s/orksynljk2yp6
>>>
>>> Build step 'Invoke Gradle script' changed build result to SUCCESS
>>> Archiving artifacts
>>> hudson.FilePath$ValidateAntFileMask$1Cancel
>>>         at hudson.FilePath$ValidateAntFileMask$1.isCaseSensitive(FilePath.java:3300)
>>>         at org.apache.tools.ant.DirectoryScanner.lambda$isIncluded$3(DirectoryScanner.java:1374)
>>>         at java.base/java.util.stream.MatchOps$1MatchSink.accept(MatchOps.java:90)
>>>         at java.base/java.util.Spliterators$ArraySpliterator.tryAdvance(Spliterators.java:958)
>>>         at java.base/java.util.stream.ReferencePipeline.forEachWithCancel(ReferencePipeline.java:127)
>>>         at java.base/java.util.stream.AbstractPipeline.copyIntoWithCancel(AbstractPipeline.java:502)
>>>         at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:488)
>>>         at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:474)
>>>         at java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:230)
>>>         at java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:196)
>>>         at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234)
>>>         at java.base/java.util.stream.ReferencePipeline.anyMatch(ReferencePipeline.java:528)
>>>         at org.apache.tools.ant.DirectoryScanner.isIncluded(DirectoryScanner.java:1374)
>>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1260)
>>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1194)
>>>         at org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1156)
>>>         at org.apache.tools.ant.DirectoryScanner.checkIncludePatterns(DirectoryScanner.java:954)
>>>         at org.apache.tools.ant.DirectoryScanner.scan(DirectoryScanner.java:912)
>>>         at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3313)
>>> Caused: hudson.FilePath$FileMaskNoMatchesFoundException: no matches found within 10000
>>>         at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3318)
>>>         at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3196)
>>>         at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3174)
>>>         at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3578)
>>> Also:   hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene-solr-2
>>>                 at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1784)
>>>                 at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
>>>                 at hudson.remoting.Channel.call(Channel.java:1000)
>>>                 at hudson.FilePath.act(FilePath.java:1192)
>>>                 at hudson.FilePath.act(FilePath.java:1181)
>>>                 at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
>>>                 at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
>>>                 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:818)
>>>                 at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
>>>                 at hudson.model.Build$BuildExecution.post2(Build.java:179)
>>>                 at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
>>>                 at hudson.model.Run.execute(Run.java:1925)
>>>                 at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
>>>                 at hudson.model.ResourceController.execute(ResourceController.java:101)
>>>                 at hudson.model.Executor.run(Executor.java:442)
>>> Caused: hudson.FilePath$TunneledInterruptedException
>>>         at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3580)
>>>         at hudson.remoting.UserRequest.perform(UserRequest.java:211)
>>>         at hudson.remoting.UserRequest.perform(UserRequest.java:54)
>>>         at hudson.remoting.Request$2.run(Request.java:377)
>>>         at hudson.remoting.InterceptingExecutorService.lambda$wrap$0(InterceptingExecutorService.java:78)
>>>         at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
>>>         at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
>>>         at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
>>>         at java.base/java.lang.Thread.run(Thread.java:829)
>>> Caused: java.lang.InterruptedException: hudson.FilePath$FileMaskNoMatchesFoundException: no matches found within 10000
>>>         at hudson.FilePath.act(FilePath.java:1194)
>>>         at hudson.FilePath.act(FilePath.java:1181)
>>>         at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
>>>         at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
>>>         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:818)
>>>         at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
>>>         at hudson.model.Build$BuildExecution.post2(Build.java:179)
>>>         at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
>>>         at hudson.model.Run.execute(Run.java:1925)
>>>         at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
>>>         at hudson.model.ResourceController.execute(ResourceController.java:101)
>>>         at hudson.model.Executor.run(Executor.java:442)
>>> 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-unsubscribe@lucene.apache.org
>>> For additional commands, e-mail: builds-help@lucene.apache.org

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


Re: [JENKINS] Lucene » Lucene-NightlyTests-9.x - Build # 665 - Unstable!

Posted by Dawid Weiss <da...@gmail.com>.
https://ge.apache.org/s/orksynljk2yp6/tests/task/:lucene:core:test/details/org.apache.lucene.store.TestStressLockFactories/testSimpleFSLockFactory?top-execution=1

This test took 31 seconds... An extremely slow vm, perhaps? I don't know
what the default connection timeouts are... it does look weird though.

Dawid

On Thu, Aug 31, 2023 at 1:08 PM Michael McCandless <
lucene@mikemccandless.com> wrote:

> Good grief -- why are we getting SocketTimeoutException in our
> LockVerifyServer's attempt to accept an incoming connection!?  These are
> all processes running on the same host ...
>
> Mike McCandless
>
> http://blog.mikemccandless.com
>
>
> On Tue, Aug 29, 2023 at 11:17 PM Apache Jenkins Server <
> jenkins@builds.apache.org> wrote:
>
>> Build:
>> https://ci-builds.apache.org/job/Lucene/job/Lucene-NightlyTests-9.x/665/
>>
>> 2 tests failed.
>> FAILED:
>> org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory
>>
>> Error Message:
>> java.net.SocketTimeoutException: Accept timed out
>>
>> Stack Trace:
>> java.net.SocketTimeoutException: Accept timed out
>>         at
>> __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993:F325FE2A6E367AC7]:0)
>>         at java.base/java.net.PlainSocketImpl.socketAccept(Native Method)
>>         at java.base/java.net
>> .AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:474)
>>         at java.base/java.net
>> .ServerSocket.implAccept(ServerSocket.java:565)
>>         at java.base/java.net.ServerSocket.accept(ServerSocket.java:533)
>>         at
>> org.apache.lucene.store.LockVerifyServer.run(LockVerifyServer.java:62)
>>         at
>> org.apache.lucene.store.TestStressLockFactories.runImpl(TestStressLockFactories.java:53)
>>         at
>> org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory(TestStressLockFactories.java:104)
>>         at
>> java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native
>> Method)
>>         at
>> java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>>         at
>> java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>>         at java.base/java.lang.reflect.Method.invoke(Method.java:566)
>>         at
>> com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1758)
>>         at
>> com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:946)
>>         at
>> com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:982)
>>         at
>> com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:996)
>>         at
>> org.apache.lucene.tests.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:48)
>>         at
>> org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>         at
>> org.apache.lucene.tests.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
>>         at
>> org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>>         at
>> org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>>         at org.junit.rules.RunRules.evaluate(RunRules.java:20)
>>         at
>> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>         at
>> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
>>         at
>> com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:843)
>>         at
>> com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:490)
>>         at
>> com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:955)
>>         at
>> com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:840)
>>         at
>> com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:891)
>>         at
>> com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:902)
>>         at
>> org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>         at
>> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>         at
>> org.apache.lucene.tests.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
>>         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
>> org.apache.lucene.tests.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
>>         at
>> org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>         at
>> org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>>         at
>> org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>>         at
>> org.apache.lucene.tests.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:47)
>>         at org.junit.rules.RunRules.evaluate(RunRules.java:20)
>>         at
>> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>         at
>> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
>>         at
>> com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:850)
>>         at java.base/java.lang.Thread.run(Thread.java:829)
>>
>>
>> FAILED:  org.apache.lucene.store.TestStressLockFactories.classMethod
>>
>> Error Message:
>> com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from
>> SUITE scope at org.apache.lucene.store.TestStressLockFactories:
>>    1) Thread[id=6713, name=Thread-5553, state=WAITING,
>> group=TGRP-TestStressLockFactories]
>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>> Method)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>         at
>> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>    2) Thread[id=6710, name=Thread-5550, state=WAITING,
>> group=TGRP-TestStressLockFactories]
>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>> Method)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>         at
>> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>    3) Thread[id=6712, name=Thread-5552, state=WAITING,
>> group=TGRP-TestStressLockFactories]
>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>> Method)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>         at
>> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>    4) Thread[id=6711, name=Thread-5551, state=WAITING,
>> group=TGRP-TestStressLockFactories]
>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>> Method)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>         at
>> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>
>> Stack Trace:
>> com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from
>> SUITE scope at org.apache.lucene.store.TestStressLockFactories:
>>    1) Thread[id=6713, name=Thread-5553, state=WAITING,
>> group=TGRP-TestStressLockFactories]
>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>> Method)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>         at
>> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>    2) Thread[id=6710, name=Thread-5550, state=WAITING,
>> group=TGRP-TestStressLockFactories]
>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>> Method)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>         at
>> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>    3) Thread[id=6712, name=Thread-5552, state=WAITING,
>> group=TGRP-TestStressLockFactories]
>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>> Method)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>         at
>> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>    4) Thread[id=6711, name=Thread-5551, state=WAITING,
>> group=TGRP-TestStressLockFactories]
>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>> Method)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>         at
>> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>         at __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993]:0)
>>
>>
>>
>>
>> Build Log:
>> [...truncated 674 lines...]
>> ERROR: The following test(s) have failed:
>>   -
>> org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory
>> (:lucene:core)
>>     Test output:
>> /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
>>     Reproduce with: gradlew :lucene:core:test --tests
>> "org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory"
>> -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs=
>> -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true
>> -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1
>> -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
>>
>>   - org.apache.lucene.store.TestStressLockFactories.classMethod
>> (:lucene:core)
>>     Test output:
>> /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
>>     Reproduce with: gradlew :lucene:core:test --tests
>> "org.apache.lucene.store.TestStressLockFactories.classMethod"
>> -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs=
>> -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true
>> -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1
>> -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
>>
>>
>> BUILD SUCCESSFUL in 1h 41m 59s
>> 243 actionable tasks: 112 executed, 131 up-to-date
>>
>> Publishing build scan...
>> https://ge.apache.org/s/orksynljk2yp6
>>
>> Build step 'Invoke Gradle script' changed build result to SUCCESS
>> Archiving artifacts
>> hudson.FilePath$ValidateAntFileMask$1Cancel
>>         at
>> hudson.FilePath$ValidateAntFileMask$1.isCaseSensitive(FilePath.java:3300)
>>         at
>> org.apache.tools.ant.DirectoryScanner.lambda$isIncluded$3(DirectoryScanner.java:1374)
>>         at
>> java.base/java.util.stream.MatchOps$1MatchSink.accept(MatchOps.java:90)
>>         at
>> java.base/java.util.Spliterators$ArraySpliterator.tryAdvance(Spliterators.java:958)
>>         at
>> java.base/java.util.stream.ReferencePipeline.forEachWithCancel(ReferencePipeline.java:127)
>>         at
>> java.base/java.util.stream.AbstractPipeline.copyIntoWithCancel(AbstractPipeline.java:502)
>>         at
>> java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:488)
>>         at
>> java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:474)
>>         at
>> java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:230)
>>         at
>> java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:196)
>>         at
>> java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234)
>>         at
>> java.base/java.util.stream.ReferencePipeline.anyMatch(ReferencePipeline.java:528)
>>         at
>> org.apache.tools.ant.DirectoryScanner.isIncluded(DirectoryScanner.java:1374)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1260)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1194)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1156)
>>         at
>> org.apache.tools.ant.DirectoryScanner.checkIncludePatterns(DirectoryScanner.java:954)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scan(DirectoryScanner.java:912)
>>         at
>> hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3313)
>> Caused: hudson.FilePath$FileMaskNoMatchesFoundException: no matches found
>> within 10000
>>         at
>> hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3318)
>>         at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3196)
>>         at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3174)
>>         at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3578)
>> Also:   hudson.remoting.Channel$CallSiteStackTrace: Remote call to
>> lucene-solr-2
>>                 at
>> hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1784)
>>                 at
>> hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
>>                 at hudson.remoting.Channel.call(Channel.java:1000)
>>                 at hudson.FilePath.act(FilePath.java:1192)
>>                 at hudson.FilePath.act(FilePath.java:1181)
>>                 at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
>>                 at
>> hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
>>                 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:818)
>>                 at
>> hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
>>                 at hudson.model.Build$BuildExecution.post2(Build.java:179)
>>                 at
>> hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
>>                 at hudson.model.Run.execute(Run.java:1925)
>>                 at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
>>                 at
>> hudson.model.ResourceController.execute(ResourceController.java:101)
>>                 at hudson.model.Executor.run(Executor.java:442)
>> Caused: hudson.FilePath$TunneledInterruptedException
>>         at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3580)
>>         at hudson.remoting.UserRequest.perform(UserRequest.java:211)
>>         at hudson.remoting.UserRequest.perform(UserRequest.java:54)
>>         at hudson.remoting.Request$2.run(Request.java:377)
>>         at
>> hudson.remoting.InterceptingExecutorService.lambda$wrap$0(InterceptingExecutorService.java:78)
>>         at
>> java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
>>         at
>> java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
>>         at
>> java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
>>         at java.base/java.lang.Thread.run(Thread.java:829)
>> Caused: java.lang.InterruptedException:
>> hudson.FilePath$FileMaskNoMatchesFoundException: no matches found within
>> 10000
>>         at hudson.FilePath.act(FilePath.java:1194)
>>         at hudson.FilePath.act(FilePath.java:1181)
>>         at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
>>         at
>> hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
>>         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:818)
>>         at
>> hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
>>         at hudson.model.Build$BuildExecution.post2(Build.java:179)
>>         at
>> hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
>>         at hudson.model.Run.execute(Run.java:1925)
>>         at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
>>         at
>> hudson.model.ResourceController.execute(ResourceController.java:101)
>>         at hudson.model.Executor.run(Executor.java:442)
>> 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-unsubscribe@lucene.apache.org
>> For additional commands, e-mail: builds-help@lucene.apache.org
>
>

Re: [JENKINS] Lucene » Lucene-NightlyTests-9.x - Build # 665 - Unstable!

Posted by Dawid Weiss <da...@gmail.com>.
https://ge.apache.org/s/orksynljk2yp6/tests/task/:lucene:core:test/details/org.apache.lucene.store.TestStressLockFactories/testSimpleFSLockFactory?top-execution=1

This test took 31 seconds... An extremely slow vm, perhaps? I don't know
what the default connection timeouts are... it does look weird though.

Dawid

On Thu, Aug 31, 2023 at 1:08 PM Michael McCandless <
lucene@mikemccandless.com> wrote:

> Good grief -- why are we getting SocketTimeoutException in our
> LockVerifyServer's attempt to accept an incoming connection!?  These are
> all processes running on the same host ...
>
> Mike McCandless
>
> http://blog.mikemccandless.com
>
>
> On Tue, Aug 29, 2023 at 11:17 PM Apache Jenkins Server <
> jenkins@builds.apache.org> wrote:
>
>> Build:
>> https://ci-builds.apache.org/job/Lucene/job/Lucene-NightlyTests-9.x/665/
>>
>> 2 tests failed.
>> FAILED:
>> org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory
>>
>> Error Message:
>> java.net.SocketTimeoutException: Accept timed out
>>
>> Stack Trace:
>> java.net.SocketTimeoutException: Accept timed out
>>         at
>> __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993:F325FE2A6E367AC7]:0)
>>         at java.base/java.net.PlainSocketImpl.socketAccept(Native Method)
>>         at java.base/java.net
>> .AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:474)
>>         at java.base/java.net
>> .ServerSocket.implAccept(ServerSocket.java:565)
>>         at java.base/java.net.ServerSocket.accept(ServerSocket.java:533)
>>         at
>> org.apache.lucene.store.LockVerifyServer.run(LockVerifyServer.java:62)
>>         at
>> org.apache.lucene.store.TestStressLockFactories.runImpl(TestStressLockFactories.java:53)
>>         at
>> org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory(TestStressLockFactories.java:104)
>>         at
>> java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native
>> Method)
>>         at
>> java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>>         at
>> java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>>         at java.base/java.lang.reflect.Method.invoke(Method.java:566)
>>         at
>> com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1758)
>>         at
>> com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:946)
>>         at
>> com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:982)
>>         at
>> com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:996)
>>         at
>> org.apache.lucene.tests.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:48)
>>         at
>> org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>         at
>> org.apache.lucene.tests.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
>>         at
>> org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>>         at
>> org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>>         at org.junit.rules.RunRules.evaluate(RunRules.java:20)
>>         at
>> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>         at
>> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
>>         at
>> com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:843)
>>         at
>> com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:490)
>>         at
>> com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:955)
>>         at
>> com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:840)
>>         at
>> com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:891)
>>         at
>> com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:902)
>>         at
>> org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>         at
>> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>         at
>> org.apache.lucene.tests.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
>>         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
>> org.apache.lucene.tests.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
>>         at
>> org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
>>         at
>> org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
>>         at
>> org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
>>         at
>> org.apache.lucene.tests.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:47)
>>         at org.junit.rules.RunRules.evaluate(RunRules.java:20)
>>         at
>> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>         at
>> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
>>         at
>> com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:850)
>>         at java.base/java.lang.Thread.run(Thread.java:829)
>>
>>
>> FAILED:  org.apache.lucene.store.TestStressLockFactories.classMethod
>>
>> Error Message:
>> com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from
>> SUITE scope at org.apache.lucene.store.TestStressLockFactories:
>>    1) Thread[id=6713, name=Thread-5553, state=WAITING,
>> group=TGRP-TestStressLockFactories]
>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>> Method)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>         at
>> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>    2) Thread[id=6710, name=Thread-5550, state=WAITING,
>> group=TGRP-TestStressLockFactories]
>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>> Method)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>         at
>> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>    3) Thread[id=6712, name=Thread-5552, state=WAITING,
>> group=TGRP-TestStressLockFactories]
>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>> Method)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>         at
>> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>    4) Thread[id=6711, name=Thread-5551, state=WAITING,
>> group=TGRP-TestStressLockFactories]
>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>> Method)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>         at
>> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>
>> Stack Trace:
>> com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from
>> SUITE scope at org.apache.lucene.store.TestStressLockFactories:
>>    1) Thread[id=6713, name=Thread-5553, state=WAITING,
>> group=TGRP-TestStressLockFactories]
>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>> Method)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>         at
>> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>    2) Thread[id=6710, name=Thread-5550, state=WAITING,
>> group=TGRP-TestStressLockFactories]
>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>> Method)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>         at
>> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>    3) Thread[id=6712, name=Thread-5552, state=WAITING,
>> group=TGRP-TestStressLockFactories]
>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>> Method)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>         at
>> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>    4) Thread[id=6711, name=Thread-5551, state=WAITING,
>> group=TGRP-TestStressLockFactories]
>>         at java.base@11.0.16.1/jdk.internal.misc.Unsafe.park(Native
>> Method)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:885)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1039)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1345)
>>         at
>> java.base@11.0.16.1/java.util.concurrent.CountDownLatch.await(CountDownLatch.java:232)
>>         at
>> app//org.apache.lucene.store.LockVerifyServer$1.run(LockVerifyServer.java:74)
>>         at __randomizedtesting.SeedInfo.seed([E1AD0D2AD68BA993]:0)
>>
>>
>>
>>
>> Build Log:
>> [...truncated 674 lines...]
>> ERROR: The following test(s) have failed:
>>   -
>> org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory
>> (:lucene:core)
>>     Test output:
>> /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
>>     Reproduce with: gradlew :lucene:core:test --tests
>> "org.apache.lucene.store.TestStressLockFactories.testSimpleFSLockFactory"
>> -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs=
>> -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true
>> -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1
>> -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
>>
>>   - org.apache.lucene.store.TestStressLockFactories.classMethod
>> (:lucene:core)
>>     Test output:
>> /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/checkout/lucene/core/build/test-results/test/outputs/OUTPUT-org.apache.lucene.store.TestStressLockFactories.txt
>>     Reproduce with: gradlew :lucene:core:test --tests
>> "org.apache.lucene.store.TestStressLockFactories.classMethod"
>> -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs=
>> -Ptests.seed=E1AD0D2AD68BA993 -Ptests.multiplier=2 -Ptests.nightly=true
>> -Ptests.badapples=false -Ptests.gui=true -Ptests.file.encoding=ISO-8859-1
>> -Ptests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-NightlyTests-9.x/test-data/enwiki.random.lines.txt
>>
>>
>> BUILD SUCCESSFUL in 1h 41m 59s
>> 243 actionable tasks: 112 executed, 131 up-to-date
>>
>> Publishing build scan...
>> https://ge.apache.org/s/orksynljk2yp6
>>
>> Build step 'Invoke Gradle script' changed build result to SUCCESS
>> Archiving artifacts
>> hudson.FilePath$ValidateAntFileMask$1Cancel
>>         at
>> hudson.FilePath$ValidateAntFileMask$1.isCaseSensitive(FilePath.java:3300)
>>         at
>> org.apache.tools.ant.DirectoryScanner.lambda$isIncluded$3(DirectoryScanner.java:1374)
>>         at
>> java.base/java.util.stream.MatchOps$1MatchSink.accept(MatchOps.java:90)
>>         at
>> java.base/java.util.Spliterators$ArraySpliterator.tryAdvance(Spliterators.java:958)
>>         at
>> java.base/java.util.stream.ReferencePipeline.forEachWithCancel(ReferencePipeline.java:127)
>>         at
>> java.base/java.util.stream.AbstractPipeline.copyIntoWithCancel(AbstractPipeline.java:502)
>>         at
>> java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:488)
>>         at
>> java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:474)
>>         at
>> java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:230)
>>         at
>> java.base/java.util.stream.MatchOps$MatchOp.evaluateSequential(MatchOps.java:196)
>>         at
>> java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234)
>>         at
>> java.base/java.util.stream.ReferencePipeline.anyMatch(ReferencePipeline.java:528)
>>         at
>> org.apache.tools.ant.DirectoryScanner.isIncluded(DirectoryScanner.java:1374)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1260)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1267)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1194)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scandir(DirectoryScanner.java:1156)
>>         at
>> org.apache.tools.ant.DirectoryScanner.checkIncludePatterns(DirectoryScanner.java:954)
>>         at
>> org.apache.tools.ant.DirectoryScanner.scan(DirectoryScanner.java:912)
>>         at
>> hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3313)
>> Caused: hudson.FilePath$FileMaskNoMatchesFoundException: no matches found
>> within 10000
>>         at
>> hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:3318)
>>         at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3196)
>>         at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:3174)
>>         at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3578)
>> Also:   hudson.remoting.Channel$CallSiteStackTrace: Remote call to
>> lucene-solr-2
>>                 at
>> hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1784)
>>                 at
>> hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
>>                 at hudson.remoting.Channel.call(Channel.java:1000)
>>                 at hudson.FilePath.act(FilePath.java:1192)
>>                 at hudson.FilePath.act(FilePath.java:1181)
>>                 at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
>>                 at
>> hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
>>                 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:818)
>>                 at
>> hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
>>                 at hudson.model.Build$BuildExecution.post2(Build.java:179)
>>                 at
>> hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
>>                 at hudson.model.Run.execute(Run.java:1925)
>>                 at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
>>                 at
>> hudson.model.ResourceController.execute(ResourceController.java:101)
>>                 at hudson.model.Executor.run(Executor.java:442)
>> Caused: hudson.FilePath$TunneledInterruptedException
>>         at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3580)
>>         at hudson.remoting.UserRequest.perform(UserRequest.java:211)
>>         at hudson.remoting.UserRequest.perform(UserRequest.java:54)
>>         at hudson.remoting.Request$2.run(Request.java:377)
>>         at
>> hudson.remoting.InterceptingExecutorService.lambda$wrap$0(InterceptingExecutorService.java:78)
>>         at
>> java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
>>         at
>> java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
>>         at
>> java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
>>         at java.base/java.lang.Thread.run(Thread.java:829)
>> Caused: java.lang.InterruptedException:
>> hudson.FilePath$FileMaskNoMatchesFoundException: no matches found within
>> 10000
>>         at hudson.FilePath.act(FilePath.java:1194)
>>         at hudson.FilePath.act(FilePath.java:1181)
>>         at hudson.FilePath.validateAntFileMask(FilePath.java:3171)
>>         at
>> hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:271)
>>         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:818)
>>         at
>> hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
>>         at hudson.model.Build$BuildExecution.post2(Build.java:179)
>>         at
>> hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
>>         at hudson.model.Run.execute(Run.java:1925)
>>         at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
>>         at
>> hudson.model.ResourceController.execute(ResourceController.java:101)
>>         at hudson.model.Executor.run(Executor.java:442)
>> 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-unsubscribe@lucene.apache.org
>> For additional commands, e-mail: builds-help@lucene.apache.org
>
>