You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Uwe Schindler <uw...@thetaphi.de> on 2023/09/02 10:53:25 UTC
Re: [JENKINS] Lucene » Lucene-NightlyTests-9.x - Build # 665 - Unstable!
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>.
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
>