-
Bug
-
Resolution: Fixed
-
P4
-
17, 20, 21
-
b20
-
x86_64
-
linux, os_x
The following test failed in the JDK20 CI:
gtest/AsyncLogGtest.java
Here's a log file snippet:
#section:main
----------messages:(8/384)----------
command: main GTestWrapper --gtest_filter=AsyncLogTest* -Xlog:async
reason: User specified action: run main/native GTestWrapper --gtest_filter=AsyncLogTest* -Xlog:async
started: Sun Nov 20 00:21:58 UTC 2022
Mode: agentvm
Agent id: 9
Additional exports to unnamed modules from @modules: java.base/jdk.internal.misc
finished: Sun Nov 20 00:21:59 UTC 2022
elapsed time (seconds): 0.901
----------configuration:(15/1896)----------
<snip>
----------System.out:(48/2406)----------
Command line: [/opt/mach5/mesos/work_dir/jib-master/install/jdk-20+25-1855/linux-x64-open.test/hotspot/gtest/server/gtestLauncher -jdk /opt/mach5/mesos/work_dir/jib-master/install/jdk-20+25-1855/linux-x64-open.jdk/jdk-20 --gtest_output=xml:test_result.xml --gtest_catch_exceptions=0 --gtest_filter=AsyncLogTest* -Xlog:async]
[2022-11-20T00:21:58.948021094Z] Gathering output for process 2105500
[2022-11-20T00:21:59.027231203Z] Waiting for completion for process 2105500
[2022-11-20T00:21:59.028549366Z] Waiting for completion finished for process 2105500
Output and diagnostic info for process 2105500 was saved into 'pid-2105500-output.log'
Note: Google Test filter = AsyncLogTest*
[==========] Running 6 tests from 1 test case.
[----------] Global test environment set-up.
[----------] 6 tests from AsyncLogTest
[ RUN ] AsyncLogTest.asynclog_vm
[0.078s][warning][logging] 1Warning
[0.078s][error ][logging] 1Error
[ OK ] AsyncLogTest.asynclog_vm (2 ms)
[ RUN ] AsyncLogTest.logMessage_vm
[ OK ] AsyncLogTest.logMessage_vm (1 ms)
[ RUN ] AsyncLogTest.logBuffer_vm
[ OK ] AsyncLogTest.logBuffer_vm (0 ms)
[ RUN ] AsyncLogTest.droppingMessage_vm
[ OK ] AsyncLogTest.droppingMessage_vm (1 ms)
[ RUN ] AsyncLogTest.stdoutOutput_vm
open/test/hotspot/gtest/logging/test_asynclog.cpp:268: Failure
Value of: file_contains_substring(TestLogFileName, "LogStreamWithAsyncLogImpl")
Actual: false
Expected: true
open/test/hotspot/gtest/logging/test_asynclog.cpp:269: Failure
Value of: file_contains_substring(TestLogFileName, "logStream msg1-msg2-msg3")
Actual: false
Expected: true
open/test/hotspot/gtest/logging/test_asynclog.cpp:270: Failure
Value of: file_contains_substring(TestLogFileName, "logStream newline")
Actual: false
Expected: true
[ FAILED ] AsyncLogTest.stdoutOutput_vm (1 ms)
[ RUN ] AsyncLogTest.stderrOutput_vm
[ OK ] AsyncLogTest.stderrOutput_vm (1 ms)
[----------] 6 tests from AsyncLogTest (83 ms total)
[----------] Global test environment tear-down
[==========] 6 tests from 1 test case ran. (83 ms total)
[ PASSED ] 5 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] AsyncLogTest.stdoutOutput_vm
1 FAILED TEST
ERROR: RUN_ALL_TESTS() failed. Error 1
[2022-11-20T00:21:59.033912868Z] Waiting for completion for process 2105500
[2022-11-20T00:21:59.034670902Z] Waiting for completion finished for process 2105500
----------System.err:(10/646)----------
java.lang.AssertionError: gtest execution failed; exit code = 2. the failed tests: [AsyncLogTest::stdoutOutput_vm, AsyncLogTest::stdoutOutput_vm, AsyncLogTest::stdoutOutput_vm]
at GTestWrapper.main(GTestWrapper.java:98)
at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104)
at java.base/java.lang.reflect.Method.invoke(Method.java:578)
at com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:312)
at java.base/java.lang.Thread.run(Thread.java:1591)
JavaTest Message: Test threw exception: java.lang.AssertionError
gtest/AsyncLogGtest.java
Here's a log file snippet:
#section:main
----------messages:(8/384)----------
command: main GTestWrapper --gtest_filter=AsyncLogTest* -Xlog:async
reason: User specified action: run main/native GTestWrapper --gtest_filter=AsyncLogTest* -Xlog:async
started: Sun Nov 20 00:21:58 UTC 2022
Mode: agentvm
Agent id: 9
Additional exports to unnamed modules from @modules: java.base/jdk.internal.misc
finished: Sun Nov 20 00:21:59 UTC 2022
elapsed time (seconds): 0.901
----------configuration:(15/1896)----------
<snip>
----------System.out:(48/2406)----------
Command line: [/opt/mach5/mesos/work_dir/jib-master/install/jdk-20+25-1855/linux-x64-open.test/hotspot/gtest/server/gtestLauncher -jdk /opt/mach5/mesos/work_dir/jib-master/install/jdk-20+25-1855/linux-x64-open.jdk/jdk-20 --gtest_output=xml:test_result.xml --gtest_catch_exceptions=0 --gtest_filter=AsyncLogTest* -Xlog:async]
[2022-11-20T00:21:58.948021094Z] Gathering output for process 2105500
[2022-11-20T00:21:59.027231203Z] Waiting for completion for process 2105500
[2022-11-20T00:21:59.028549366Z] Waiting for completion finished for process 2105500
Output and diagnostic info for process 2105500 was saved into 'pid-2105500-output.log'
Note: Google Test filter = AsyncLogTest*
[==========] Running 6 tests from 1 test case.
[----------] Global test environment set-up.
[----------] 6 tests from AsyncLogTest
[ RUN ] AsyncLogTest.asynclog_vm
[0.078s][warning][logging] 1Warning
[0.078s][error ][logging] 1Error
[ OK ] AsyncLogTest.asynclog_vm (2 ms)
[ RUN ] AsyncLogTest.logMessage_vm
[ OK ] AsyncLogTest.logMessage_vm (1 ms)
[ RUN ] AsyncLogTest.logBuffer_vm
[ OK ] AsyncLogTest.logBuffer_vm (0 ms)
[ RUN ] AsyncLogTest.droppingMessage_vm
[ OK ] AsyncLogTest.droppingMessage_vm (1 ms)
[ RUN ] AsyncLogTest.stdoutOutput_vm
open/test/hotspot/gtest/logging/test_asynclog.cpp:268: Failure
Value of: file_contains_substring(TestLogFileName, "LogStreamWithAsyncLogImpl")
Actual: false
Expected: true
open/test/hotspot/gtest/logging/test_asynclog.cpp:269: Failure
Value of: file_contains_substring(TestLogFileName, "logStream msg1-msg2-msg3")
Actual: false
Expected: true
open/test/hotspot/gtest/logging/test_asynclog.cpp:270: Failure
Value of: file_contains_substring(TestLogFileName, "logStream newline")
Actual: false
Expected: true
[ FAILED ] AsyncLogTest.stdoutOutput_vm (1 ms)
[ RUN ] AsyncLogTest.stderrOutput_vm
[ OK ] AsyncLogTest.stderrOutput_vm (1 ms)
[----------] 6 tests from AsyncLogTest (83 ms total)
[----------] Global test environment tear-down
[==========] 6 tests from 1 test case ran. (83 ms total)
[ PASSED ] 5 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] AsyncLogTest.stdoutOutput_vm
1 FAILED TEST
ERROR: RUN_ALL_TESTS() failed. Error 1
[2022-11-20T00:21:59.033912868Z] Waiting for completion for process 2105500
[2022-11-20T00:21:59.034670902Z] Waiting for completion finished for process 2105500
----------System.err:(10/646)----------
java.lang.AssertionError: gtest execution failed; exit code = 2. the failed tests: [AsyncLogTest::stdoutOutput_vm, AsyncLogTest::stdoutOutput_vm, AsyncLogTest::stdoutOutput_vm]
at GTestWrapper.main(GTestWrapper.java:98)
at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104)
at java.base/java.lang.reflect.Method.invoke(Method.java:578)
at com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:312)
at java.base/java.lang.Thread.run(Thread.java:1591)
JavaTest Message: Test threw exception: java.lang.AssertionError
- relates to
-
JDK-8309067 gtest/AsyncLogGtest.java fails again in stderrOutput_vm
- Resolved