java/util/stream/test/org/openjdk/tests/java/util/stream/WhileOpTest.java timed out

The following test failed in the JDK15 CI:

java/util/stream/test/org/openjdk/tests/java/util/stream/WhileOpTest.java

Here's a snippet from the log file:

test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("ArrayList.asList:pseudorandom", java.util.stream.TestData$AbstractTestData$RefTestData@776cc8e): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@7c897db0): success
config java.util.stream.LoggingTestCase.before(): success
Timeout refired 960 times
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("ArrayList:pseudorandom", java.util.stream.TestData$AbstractTestData$RefTestData@700d427): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@7dfea9d0): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("DelegatingStream(ArrayList):pseudorandom", java.util.stream.TestData$AbstractTestData$RefTestData@5de13f21): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@6258f784): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("ArrayList.Sublist:pseudorandom", java.util.stream.TestData$AbstractTestData$RefTestData@47676ef5): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@50f2e11e): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("LinkedList:pseudorandom", java.util.stream.TestData$AbstractTestData$RefTestData@6b981363): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@20fce875): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("HashSet:pseudorandom", java.util.stream.TestData$AbstractTestData$RefTestData@4e04607): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@2f4cec7d): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("LinkedHashSet:pseudorandom", java.util.stream.TestData$AbstractTestData$RefTestData@792583c0): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@4a0f872): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("TreeSet:pseudorandom", java.util.stream.TestData$AbstractTestData$RefTestData@109e54b4): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@68ce6d9f): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("SpinedBuffer:pseudorandom", java.util.stream.TestData$AbstractTestData$RefTestData@764a50d3): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@35d3b48c): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("array:empty", RefTestData[array:empty]): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@3626b528): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("ArrayList.asList:empty", java.util.stream.TestData$AbstractTestData$RefTestData@4dfbec00): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@6e1bf81d): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("ArrayList:empty", RefTestData[ArrayList:empty]): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@5debb360): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("DelegatingStream(ArrayList):empty", java.util.stream.TestData$AbstractTestData$RefTestData@3921ae28): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@3b171ce): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("ArrayList.Sublist:empty", java.util.stream.TestData$AbstractTestData$RefTestData@3782bbf8): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@793fd4f9): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("LinkedList:empty", RefTestData[LinkedList:empty]): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@553bac75): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("HashSet:empty", RefTestData[HashSet:empty]): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@35a129d2): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("LinkedHashSet:empty", java.util.stream.TestData$AbstractTestData$RefTestData@198191a7): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@6d0e9a50): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("TreeSet:empty", RefTestData[TreeSet:empty]): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@743783ef): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("SpinedBuffer:empty", java.util.stream.TestData$AbstractTestData$RefTestData@4d50e2e): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@2cb2da47): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("array:0..1", RefTestData[array:0..1]): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@6f43e600): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("ArrayList.asList:0..1", java.util.stream.TestData$AbstractTestData$RefTestData@35e0f598): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@1bbdeb10): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("ArrayList:0..1", RefTestData[ArrayList:0..1]): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@67aa0062): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("DelegatingStream(ArrayList):0..1", java.util.stream.TestData$AbstractTestData$RefTestData@292c313a): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@37d04b6): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("ArrayList.Sublist:0..1", java.util.stream.TestData$AbstractTestData$RefTestData@2bdc687d): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@292d16fb): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("LinkedList:0..1", RefTestData[LinkedList:0..1]): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@7ec32b0f): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("HashSet:0..1", RefTestData[HashSet:0..1]): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@22b7379b): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("LinkedHashSet:0..1", java.util.stream.TestData$AbstractTestData$RefTestData@5ae9c4a): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@78a28f37): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("TreeSet:0..1", RefTestData[TreeSet:0..1]): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@59b2a5a1): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("SpinedBuffer:0..1", RefTestData[SpinedBuffer:0..1]): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@28bf9b9c): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("array:0..10", RefTestData[array:0..10]): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@2fc6babf): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("ArrayList.asList:0..10", java.util.stream.TestData$AbstractTestData$RefTestData@651b450): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@1d3eaf76): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("ArrayList:0..10", RefTestData[ArrayList:0..10]): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@673c8fe2): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("DelegatingStream(ArrayList):0..10", java.util.stream.TestData$AbstractTestData$RefTestData@10b8fa7d): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@52fc00a7): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("ArrayList.Sublist:0..10", java.util.stream.TestData$AbstractTestData$RefTestData@310f56d0): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@6db06d20): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("LinkedList:0..10", RefTestData[LinkedList:0..10]): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@405c37a): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("HashSet:0..10", RefTestData[HashSet:0..10]): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@7e020239): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("LinkedHashSet:0..10", java.util.stream.TestData$AbstractTestData$RefTestData@21e3661f): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@a96218f): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("TreeSet:0..10", RefTestData[TreeSet:0..10]): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@2cf2da82): success
config java.util.stream.LoggingTestCase.before(): success
test org.openjdk.tests.java.util.stream.WhileOpTest.testTakeWhileOps("SpinedBuffer:0..10", java.util.stream.TestData$AbstractTestData$RefTestData@4a8fd408): success
config java.util.stream.LoggingTestCase.after(org.testng.internal.TestResult@35b7ea96): success

===============================================
java/util/stream/test/org/openjdk/tests/java/util/stream/WhileOpTest.java
Total tests run: 275, Failures: 0, Skips: 0
===============================================

----------System.err:(1/15)----------
STATUS:Passed.
----------rerun:(40/4411)*----------


Please notice that the test hits the timeout factor:

Timeout refired 960 times

and continues executing while the JTREG timeout handler is running
and eventually finishes and passes as shown by:

STATUS:Passed.

The test was previously modified by the following bug fix:

    JDK-8134459 java/util/stream/test/org/openjdk/tests/java/util/stream/WhileOpTest.java timed out

and that fix changed the invocation line to:

@run main/timeout=240

With a default timeout factor of 4, we have a total timeout value
of 960 seconds/16 minutes. The elapsed run time is:

elapsed time (seconds): 2122.312

which is more than double the 16 minutes.

I'm not sure what happened in this run, but it sure was slow.