[2025-01-11T02:00:35.427Z] Running test jdk_lang_1 ... [2025-01-11T02:00:35.427Z] =============================================== [2025-01-11T02:00:35.427Z] jdk_lang_1 Start Time: Sat Jan 11 02:00:34 2025 Epoch Time (ms): 1736560834750 [2025-01-11T02:00:35.427Z] variation: Mode650 [2025-01-11T02:00:35.427Z] JVM_OPTIONS: -XX:-UseCompressedOops [2025-01-11T02:00:35.427Z] { \ [2025-01-11T02:00:35.427Z] echo ""; echo "TEST SETUP:"; \ [2025-01-11T02:00:35.427Z] echo "Nothing to be done for setup."; \ [2025-01-11T02:00:35.427Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17365475154770/jdk_lang_1"; \ [2025-01-11T02:00:35.427Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17365475154770/jdk_lang_1"; \ [2025-01-11T02:00:35.427Z] echo ""; echo "TESTING:"; \ [2025-01-11T02:00:35.427Z] "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image/bin/java" -Xmx512m -jar "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../../jvmtest/openjdk/jtreg/lib/jtreg.jar" \ [2025-01-11T02:00:35.427Z] -agentvm -a -ea -esa -v:fail,error,time,nopass -retain:fail,error,*.dmp,javacore.*,heapdump.*,*.trc -ignore:quiet -timeoutFactor:8 -xml:verify -concurrency:1 -nativepath:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/openjdk-test-image/jdk/jtreg/native" -vmoptions:"-Xmx512m -XX:-UseCompressedOops " \ [2025-01-11T02:00:35.427Z] \ [2025-01-11T02:00:35.427Z] -w ""/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17365475154770/jdk_lang_1"/work" \ [2025-01-11T02:00:35.427Z] -r ""/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17365475154770/jdk_lang_1"/report" \ [2025-01-11T02:00:35.427Z] -jdk:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image" \ [2025-01-11T02:00:35.427Z] -exclude:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk/ProblemList.txt" \ [2025-01-11T02:00:35.427Z] -exclude:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../../jvmtest/openjdk/excludes/ProblemList_openjdk25.txt" \ [2025-01-11T02:00:35.427Z] \ [2025-01-11T02:00:35.427Z] \ [2025-01-11T02:00:35.427Z] "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk:jdk_lang"; \ [2025-01-11T02:00:35.428Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "jdk_lang_1""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/..; else echo "-----------------------------------"; echo "jdk_lang_1""_FAILED"; echo "-----------------------------------"; fi; \ [2025-01-11T02:00:35.428Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-01-11T02:00:35.428Z] echo "Nothing to be done for teardown."; \ [2025-01-11T02:00:35.428Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17365475154770/TestTargetResult"; [2025-01-11T02:00:35.428Z] [2025-01-11T02:00:35.428Z] TEST SETUP: [2025-01-11T02:00:35.428Z] Nothing to be done for setup. [2025-01-11T02:00:35.428Z] [2025-01-11T02:00:35.428Z] TESTING: [2025-01-11T02:00:36.222Z] Directory "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17365475154770/jdk_lang_1/work" not found: creating [2025-01-11T02:00:36.222Z] Directory "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17365475154770/jdk_lang_1/report" not found: creating [2025-01-11T02:00:41.869Z] XML output with verification to /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17365475154770/jdk_lang_1/work [2025-01-11T02:16:14.388Z] -------------------------------------------------- [2025-01-11T02:16:14.388Z] TEST: java/lang/ProcessHandle/InfoTest.java [2025-01-11T02:16:14.388Z] TEST JDK: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image [2025-01-11T02:16:14.388Z] [2025-01-11T02:16:14.388Z] ACTION: build -- Passed. All files up to date [2025-01-11T02:16:14.388Z] REASON: User specified action: run build jdk.test.lib.Utils jdk.test.lib.Asserts jdk.test.lib.JDKToolFinder jdk.test.lib.JDKToolLauncher jdk.test.lib.Platform jdk.test.lib.process.* [2025-01-11T02:16:14.388Z] TIME: 0.002 seconds [2025-01-11T02:16:14.388Z] messages: [2025-01-11T02:16:14.388Z] command: build jdk.test.lib.Utils jdk.test.lib.Asserts jdk.test.lib.JDKToolFinder jdk.test.lib.JDKToolLauncher jdk.test.lib.Platform jdk.test.lib.process.* [2025-01-11T02:16:14.388Z] reason: User specified action: run build jdk.test.lib.Utils jdk.test.lib.Asserts jdk.test.lib.JDKToolFinder jdk.test.lib.JDKToolLauncher jdk.test.lib.Platform jdk.test.lib.process.* [2025-01-11T02:16:14.388Z] started: Sat Jan 11 02:15:44 GMT 2025 [2025-01-11T02:16:14.388Z] finished: Sat Jan 11 02:15:44 GMT 2025 [2025-01-11T02:16:14.388Z] elapsed time (seconds): 0.002 [2025-01-11T02:16:14.388Z] [2025-01-11T02:16:14.388Z] ACTION: build -- Passed. Build successful [2025-01-11T02:16:14.388Z] REASON: Named class compiled on demand [2025-01-11T02:16:14.388Z] TIME: 1.872 seconds [2025-01-11T02:16:14.388Z] messages: [2025-01-11T02:16:14.388Z] command: build InfoTest [2025-01-11T02:16:14.388Z] reason: Named class compiled on demand [2025-01-11T02:16:14.388Z] started: Sat Jan 11 02:15:44 GMT 2025 [2025-01-11T02:16:14.388Z] Test directory: [2025-01-11T02:16:14.388Z] compile: InfoTest [2025-01-11T02:16:14.388Z] finished: Sat Jan 11 02:15:46 GMT 2025 [2025-01-11T02:16:14.388Z] elapsed time (seconds): 1.872 [2025-01-11T02:16:14.388Z] [2025-01-11T02:16:14.388Z] ACTION: compile -- Passed. Compilation successful [2025-01-11T02:16:14.388Z] REASON: .class file out of date or does not exist [2025-01-11T02:16:14.388Z] TIME: 1.872 seconds [2025-01-11T02:16:14.388Z] messages: [2025-01-11T02:16:14.388Z] command: compile /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/lang/ProcessHandle/InfoTest.java [2025-01-11T02:16:14.388Z] reason: .class file out of date or does not exist [2025-01-11T02:16:14.388Z] started: Sat Jan 11 02:15:44 GMT 2025 [2025-01-11T02:16:14.388Z] Additional options from @modules: --add-modules java.base,jdk.management --add-exports java.base/jdk.internal.misc=ALL-UNNAMED [2025-01-11T02:16:14.388Z] Mode: othervm [2025-01-11T02:16:14.388Z] finished: Sat Jan 11 02:15:46 GMT 2025 [2025-01-11T02:16:14.388Z] elapsed time (seconds): 1.872 [2025-01-11T02:16:14.388Z] configuration: [2025-01-11T02:16:14.388Z] javac compilation environment [2025-01-11T02:16:14.388Z] add modules: java.base jdk.management [2025-01-11T02:16:14.389Z] add exports: java.base/jdk.internal.misc ALL-UNNAMED [2025-01-11T02:16:14.389Z] source path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/lang/ProcessHandle [2025-01-11T02:16:14.389Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/lib [2025-01-11T02:16:14.389Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/lang/ProcessHandle [2025-01-11T02:16:14.389Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17365475154770/jdk_lang_1/work/classes/java/lang/ProcessHandle/InfoTest.d [2025-01-11T02:16:14.389Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17365475154770/jdk_lang_1/work/classes/test/lib [2025-01-11T02:16:14.389Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/testng-7.3.0.jar [2025-01-11T02:16:14.389Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/guice-5.1.0.jar [2025-01-11T02:16:14.389Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/jcommander-1.82.jar [2025-01-11T02:16:14.389Z] [2025-01-11T02:16:14.389Z] rerun: [2025-01-11T02:16:14.389Z] cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17365475154770/jdk_lang_1/work/java/lang/ProcessHandle/InfoTest && \ [2025-01-11T02:16:14.389Z] DISPLAY=unix:0 \ [2025-01-11T02:16:14.389Z] HOME=/home/jenkins \ [2025-01-11T02:16:14.389Z] LANG=C \ [2025-01-11T02:16:14.389Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-01-11T02:16:14.389Z] TZ=UTC0 \ [2025-01-11T02:16:14.389Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image/bin/javac \ [2025-01-11T02:16:14.389Z] -J-ea \ [2025-01-11T02:16:14.389Z] -J-esa \ [2025-01-11T02:16:14.389Z] -J-Xmx512m \ [2025-01-11T02:16:14.389Z] -J-XX:-UseCompressedOops \ [2025-01-11T02:16:14.389Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m -XX:-UseCompressedOops' \ [2025-01-11T02:16:14.389Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:-UseCompressedOops' \ [2025-01-11T02:16:14.389Z] -J-Dtest.compiler.opts= \ [2025-01-11T02:16:14.389Z] -J-Dtest.java.opts= \ [2025-01-11T02:16:14.389Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image \ [2025-01-11T02:16:14.389Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image \ [2025-01-11T02:16:14.389Z] -J-Dtest.timeout.factor=8.0 \ [2025-01-11T02:16:14.389Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-01-11T02:16:14.389Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-01-11T02:16:14.389Z] -J-Dtest.name=java/lang/ProcessHandle/InfoTest.java \ [2025-01-11T02:16:14.389Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/lang/ProcessHandle/InfoTest.java \ [2025-01-11T02:16:14.389Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/lang/ProcessHandle \ [2025-01-11T02:16:14.389Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/lang/ProcessHandle:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2025-01-11T02:16:14.389Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17365475154770/jdk_lang_1/work/classes/java/lang/ProcessHandle/InfoTest.d \ [2025-01-11T02:16:14.389Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17365475154770/jdk_lang_1/work/classes/java/lang/ProcessHandle/InfoTest.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17365475154770/jdk_lang_1/work/classes/test/lib \ [2025-01-11T02:16:14.389Z] -J-Dtest.modules='java.base/jdk.internal.misc jdk.management' \ [2025-01-11T02:16:14.389Z] @/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17365475154770/jdk_lang_1/work/java/lang/ProcessHandle/InfoTest.d/compile.0.jta [2025-01-11T02:16:14.389Z] STDOUT: [2025-01-11T02:16:14.389Z] STDERR: [2025-01-11T02:16:14.389Z] [2025-01-11T02:16:14.389Z] ACTION: testng -- Failed. Execution failed: `main' threw exception: java.lang.Exception: failures: 1 [2025-01-11T02:16:14.389Z] REASON: User specified action: run testng InfoTest [2025-01-11T02:16:14.389Z] TIME: 15.374 seconds [2025-01-11T02:16:14.389Z] messages: [2025-01-11T02:16:14.389Z] command: testng InfoTest [2025-01-11T02:16:14.389Z] reason: User specified action: run testng InfoTest [2025-01-11T02:16:14.389Z] started: Sat Jan 11 02:15:46 GMT 2025 [2025-01-11T02:16:14.389Z] Mode: othervm [2025-01-11T02:16:14.389Z] Additional options from @modules: --add-modules java.base,jdk.management --add-exports java.base/jdk.internal.misc=ALL-UNNAMED [2025-01-11T02:16:14.389Z] finished: Sat Jan 11 02:16:01 GMT 2025 [2025-01-11T02:16:14.389Z] elapsed time (seconds): 15.374 [2025-01-11T02:16:14.389Z] configuration: [2025-01-11T02:16:14.389Z] Boot Layer [2025-01-11T02:16:14.389Z] add modules: java.base jdk.management [2025-01-11T02:16:14.389Z] add exports: java.base/jdk.internal.misc ALL-UNNAMED [2025-01-11T02:16:14.389Z] [2025-01-11T02:16:14.389Z] STDOUT: [2025-01-11T02:16:14.389Z] Note: when run in samevm mode the cputime of the test runner is included. [2025-01-11T02:16:14.389Z] info: [user: Optional[jenkins], cmdLine: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2, startTime: Optional[2025-01-11T02:15:46Z], totalTime: Optional[PT0.070104609S]] [2025-01-11T02:16:14.389Z] test InfoTest.test1(): failure [2025-01-11T02:16:14.389Z] java.lang.AssertionError: reported cputime less than expected: PT0.2S, actual: Optional[PT0.070104609S] [2025-01-11T02:16:14.389Z] at org.testng.Assert.fail(Assert.java:99) [2025-01-11T02:16:14.389Z] at InfoTest.test1(InfoTest.java:110) [2025-01-11T02:16:14.389Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104) [2025-01-11T02:16:14.389Z] at java.base/java.lang.reflect.Method.invoke(Method.java:565) [2025-01-11T02:16:14.389Z] at org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:132) [2025-01-11T02:16:14.389Z] at org.testng.internal.TestInvoker.invokeMethod(TestInvoker.java:599) [2025-01-11T02:16:14.389Z] at org.testng.internal.TestInvoker.invokeTestMethod(TestInvoker.java:174) [2025-01-11T02:16:14.389Z] at org.testng.internal.MethodRunner.runInSequence(MethodRunner.java:46) [2025-01-11T02:16:14.389Z] at org.testng.internal.TestInvoker$MethodInvocationAgent.invoke(TestInvoker.java:822) [2025-01-11T02:16:14.389Z] at org.testng.internal.TestInvoker.invokeTestMethods(TestInvoker.java:147) [2025-01-11T02:16:14.389Z] at org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:146) [2025-01-11T02:16:14.389Z] at org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:128) [2025-01-11T02:16:14.389Z] at java.base/java.util.ArrayList.forEach(ArrayList.java:1604) [2025-01-11T02:16:14.389Z] at org.testng.TestRunner.privateRun(TestRunner.java:764) [2025-01-11T02:16:14.389Z] at org.testng.TestRunner.run(TestRunner.java:585) [2025-01-11T02:16:14.389Z] at org.testng.SuiteRunner.runTest(SuiteRunner.java:384) [2025-01-11T02:16:14.389Z] at org.testng.SuiteRunner.runSequentially(SuiteRunner.java:378) [2025-01-11T02:16:14.389Z] at org.testng.SuiteRunner.privateRun(SuiteRunner.java:337) [2025-01-11T02:16:14.389Z] at org.testng.SuiteRunner.run(SuiteRunner.java:286) [2025-01-11T02:16:14.389Z] at org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:53) [2025-01-11T02:16:14.389Z] at org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:96) [2025-01-11T02:16:14.389Z] at org.testng.TestNG.runSuitesSequentially(TestNG.java:1218) [2025-01-11T02:16:14.389Z] at org.testng.TestNG.runSuitesLocally(TestNG.java:1140) [2025-01-11T02:16:14.389Z] at org.testng.TestNG.runSuites(TestNG.java:1069) [2025-01-11T02:16:14.389Z] at org.testng.TestNG.run(TestNG.java:1037) [2025-01-11T02:16:14.389Z] at com.sun.javatest.regtest.agent.TestNGRunner.main(TestNGRunner.java:102) [2025-01-11T02:16:14.389Z] at com.sun.javatest.regtest.agent.TestNGRunner.main(TestNGRunner.java:58) [2025-01-11T02:16:14.389Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104) [2025-01-11T02:16:14.389Z] at java.base/java.lang.reflect.Method.invoke(Method.java:565) [2025-01-11T02:16:14.389Z] at com.sun.javatest.regtest.agent.MainWrapper$MainTask.run(MainWrapper.java:138) [2025-01-11T02:16:14.389Z] at java.base/java.lang.Thread.run(Thread.java:1447) [2025-01-11T02:16:14.389Z] info: [user: Optional[jenkins], cmdLine: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2, startTime: Optional[2025-01-11T02:15:46Z], totalTime: Optional[PT0.311297343S]] [2025-01-11T02:16:14.389Z] info.totalCPU: 311297343, childCpuTime: 270000000, diff: -41297343 [2025-01-11T02:16:14.389Z] info: [user: Optional[jenkins], cmdLine: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2, startTime: Optional[2025-01-11T02:15:46Z], totalTime: Optional[PT0.424036906S]] [2025-01-11T02:16:14.389Z] info.totalCPU: 424036906, childCpuTime: 400000000, diff: -24036906 [2025-01-11T02:16:14.389Z] info: [user: Optional[jenkins], cmdLine: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2, startTime: Optional[2025-01-11T02:15:46Z], totalTime: Optional[PT0.520269539S]] [2025-01-11T02:16:14.389Z] info.totalCPU: 520269539, childCpuTime: 510000000, diff: -10269539 [2025-01-11T02:16:14.389Z] info: [user: Optional[jenkins], cmdLine: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2, startTime: Optional[2025-01-11T02:15:46Z], totalTime: Optional[PT0.63222471S]] [2025-01-11T02:16:14.389Z] info.totalCPU: 632224710, childCpuTime: 620000000, diff: -12224710 [2025-01-11T02:16:14.389Z] info: [user: Optional[jenkins], cmdLine: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2, startTime: Optional[2025-01-11T02:15:46Z], totalTime: Optional[PT0.733404101S]] [2025-01-11T02:16:14.389Z] info.totalCPU: 733404101, childCpuTime: 730000000, diff: -3404101 [2025-01-11T02:16:14.389Z] info: [user: Optional[jenkins], cmdLine: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2, startTime: Optional[2025-01-11T02:15:46Z], totalTime: Optional[PT0.838726203S]] [2025-01-11T02:16:14.389Z] info.totalCPU: 838726203, childCpuTime: 830000000, diff: -8726203 [2025-01-11T02:16:14.389Z] info: [user: Optional[jenkins], cmdLine: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2, startTime: Optional[2025-01-11T02:15:46Z], totalTime: Optional[PT0.936527859S]] [2025-01-11T02:16:14.389Z] info.totalCPU: 936527859, childCpuTime: 930000000, diff: -6527859 [2025-01-11T02:16:14.389Z] info: [user: Optional[jenkins], cmdLine: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2, startTime: Optional[2025-01-11T02:15:46Z], totalTime: Optional[PT1.035238992S]] [2025-01-11T02:16:14.389Z] info.totalCPU: 1035238992, childCpuTime: 1030000000, diff: -5238992 [2025-01-11T02:16:14.389Z] info: [user: Optional[jenkins], cmdLine: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2, startTime: Optional[2025-01-11T02:15:46Z], totalTime: Optional[PT1.13871482S]] [2025-01-11T02:16:14.389Z] info.totalCPU: 1138714820, childCpuTime: 1130000000, diff: -8714820 [2025-01-11T02:16:14.389Z] info: [user: Optional[jenkins], cmdLine: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2, startTime: Optional[2025-01-11T02:15:46Z], totalTime: Optional[PT1.234348062S]] [2025-01-11T02:16:14.389Z] info.totalCPU: 1234348062, childCpuTime: 1230000000, diff: -4348062 [2025-01-11T02:16:14.389Z] test InfoTest.test2(): success [2025-01-11T02:16:14.389Z] info: [user: Optional[jenkins], cmdLine: sleep 240, startTime: Optional[2025-01-11T02:15:58Z], totalTime: Optional[PT0S]] [2025-01-11T02:16:14.389Z] info: [user: Optional[jenkins], cmdLine: sleep 256, startTime: Optional[2025-01-11T02:15:59Z], totalTime: Optional[PT0S]] [2025-01-11T02:16:14.389Z] test InfoTest.test3(): success [2025-01-11T02:16:14.389Z] total1 vs. mbean: PT0.818479117S, getProcessCpuTime: PT0.8S, diff: PT-0.018479117S [2025-01-11T02:16:14.389Z] total2 vs. mbean: PT0.818815843S, getProcessCpuTime: PT0.81S, diff: PT-0.008815843S [2025-01-11T02:16:14.389Z] test InfoTest.test4(): success [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 810000000, diff: -8815843 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 820000000, diff: 1184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 820000000, diff: 1184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 820000000, diff: 1184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 820000000, diff: 1184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 820000000, diff: 1184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 820000000, diff: 1184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 830000000, diff: 11184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 830000000, diff: 11184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 830000000, diff: 11184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 830000000, diff: 11184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 830000000, diff: 11184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 830000000, diff: 11184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 830000000, diff: 11184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 840000000, diff: 21184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 840000000, diff: 21184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 840000000, diff: 21184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 840000000, diff: 21184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 840000000, diff: 21184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 840000000, diff: 21184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 840000000, diff: 21184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 840000000, diff: 21184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 840000000, diff: 21184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 840000000, diff: 21184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 840000000, diff: 21184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 840000000, diff: 21184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 840000000, diff: 21184157 [2025-01-11T02:16:14.389Z] infoTotal: 818815843, beanCpu: 840000000, diff: 21184157 [2025-01-11T02:16:14.390Z] infoTotal: 818815843, beanCpu: 840000000, diff: 21184157 [2025-01-11T02:16:14.390Z] infoTotal: 818815843, beanCpu: 840000000, diff: 21184157 [2025-01-11T02:16:14.390Z] test InfoTest.test5(): success [2025-01-11T02:16:14.390Z] [2025-01-11T02:16:14.390Z] =============================================== [2025-01-11T02:16:14.390Z] java/lang/ProcessHandle/InfoTest.java [2025-01-11T02:16:14.390Z] Total tests run: 5, Passes: 4, Failures: 1, Skips: 0 [2025-01-11T02:16:14.390Z] =============================================== [2025-01-11T02:16:14.390Z] [2025-01-11T02:16:14.390Z] STDERR: [2025-01-11T02:16:14.390Z] java.lang.Exception: failures: 1 [2025-01-11T02:16:14.390Z] at com.sun.javatest.regtest.agent.TestNGRunner.main(TestNGRunner.java:104) [2025-01-11T02:16:14.390Z] at com.sun.javatest.regtest.agent.TestNGRunner.main(TestNGRunner.java:58) [2025-01-11T02:16:14.390Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104) [2025-01-11T02:16:14.390Z] at java.base/java.lang.reflect.Method.invoke(Method.java:565) [2025-01-11T02:16:14.390Z] at com.sun.javatest.regtest.agent.MainWrapper$MainTask.run(MainWrapper.java:138) [2025-01-11T02:16:14.390Z] at java.base/java.lang.Thread.run(Thread.java:1447) [2025-01-11T02:16:14.390Z] [2025-01-11T02:16:14.390Z] JavaTest Message: Test threw exception: java.lang.Exception: failures: 1 [2025-01-11T02:16:14.390Z] JavaTest Message: shutting down test [2025-01-11T02:16:14.390Z] [2025-01-11T02:16:14.390Z] STATUS:Failed.`main' threw exception: java.lang.Exception: failures: 1 [2025-01-11T02:16:14.390Z] rerun: [2025-01-11T02:16:14.390Z] cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17365475154770/jdk_lang_1/work/java/lang/ProcessHandle/InfoTest && \ [2025-01-11T02:16:14.390Z] DISPLAY=unix:0 \ [2025-01-11T02:16:14.390Z] HOME=/home/jenkins \ [2025-01-11T02:16:14.390Z] LANG=C \ [2025-01-11T02:16:14.390Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-01-11T02:16:14.390Z] TZ=UTC0 \ [2025-01-11T02:16:14.390Z] CLASSPATH=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17365475154770/jdk_lang_1/work/classes/java/lang/ProcessHandle/InfoTest.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/lang/ProcessHandle:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17365475154770/jdk_lang_1/work/classes/test/lib:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/lib:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/testng-7.3.0.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/guice-5.1.0.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/jcommander-1.82.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/jtreg.jar \ [2025-01-11T02:16:14.390Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image/bin/java \ [2025-01-11T02:16:14.390Z] -Dtest.vm.opts='-ea -esa -Xmx512m -XX:-UseCompressedOops' \ [2025-01-11T02:16:14.390Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:-UseCompressedOops' \ [2025-01-11T02:16:14.390Z] -Dtest.compiler.opts= \ [2025-01-11T02:16:14.390Z] -Dtest.java.opts= \ [2025-01-11T02:16:14.390Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image \ [2025-01-11T02:16:14.390Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image \ [2025-01-11T02:16:14.390Z] -Dtest.timeout.factor=8.0 \ [2025-01-11T02:16:14.390Z] -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-01-11T02:16:14.390Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-01-11T02:16:14.390Z] -Dtest.name=java/lang/ProcessHandle/InfoTest.java \ [2025-01-11T02:16:14.390Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/lang/ProcessHandle/InfoTest.java \ [2025-01-11T02:16:14.390Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/lang/ProcessHandle \ [2025-01-11T02:16:14.390Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/lang/ProcessHandle:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2025-01-11T02:16:14.390Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17365475154770/jdk_lang_1/work/classes/java/lang/ProcessHandle/InfoTest.d \ [2025-01-11T02:16:14.390Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17365475154770/jdk_lang_1/work/classes/java/lang/ProcessHandle/InfoTest.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17365475154770/jdk_lang_1/work/classes/test/lib \ [2025-01-11T02:16:14.390Z] -Dtest.modules='java.base/jdk.internal.misc jdk.management' \ [2025-01-11T02:16:14.390Z] --add-modules java.base,jdk.management \ [2025-01-11T02:16:14.390Z] --add-exports java.base/jdk.internal.misc=ALL-UNNAMED \ [2025-01-11T02:16:14.390Z] -ea \ [2025-01-11T02:16:14.390Z] -esa \ [2025-01-11T02:16:14.390Z] -Xmx512m \ [2025-01-11T02:16:14.390Z] -XX:-UseCompressedOops \ [2025-01-11T02:16:14.390Z] -Djava.library.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-01-11T02:16:14.390Z] com.sun.javatest.regtest.agent.MainWrapper /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17365475154770/jdk_lang_1/work/java/lang/ProcessHandle/InfoTest.d/testng.1.jta java/lang/ProcessHandle/InfoTest.java false InfoTest [2025-01-11T02:16:14.390Z] [2025-01-11T02:16:14.390Z] TEST RESULT: Failed. Execution failed: `main' threw exception: java.lang.Exception: failures: 1 [2025-01-11T02:16:14.390Z] -------------------------------------------------- [2025-01-11T03:05:29.332Z] Test results: passed: 1,034; failed: 1 [2025-01-11T03:05:35.209Z] Report written to /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17365475154770/jdk_lang_1/report/html/report.html [2025-01-11T03:05:35.209Z] Results written to /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17365475154770/jdk_lang_1/work [2025-01-11T03:05:35.209Z] Error: Some tests failed or other problems occurred. [2025-01-11T03:05:35.209Z] ----------------------------------- [2025-01-11T03:05:35.209Z] jdk_lang_1_FAILED [2025-01-11T03:05:35.209Z] ----------------------------------- [2025-01-11T03:05:35.209Z] [2025-01-11T03:05:35.209Z] TEST TEARDOWN: [2025-01-11T03:05:35.209Z] Nothing to be done for teardown. [2025-01-11T03:05:35.209Z] jdk_lang_1 Finish Time: Sat Jan 11 03:05:34 2025 Epoch Time (ms): 1736564734597