[2026-02-06T23:27:51.467Z] Running test renaissance-philosophers_0 ... [2026-02-06T23:27:51.467Z] =============================================== [2026-02-06T23:27:51.467Z] renaissance-philosophers_0 Start Time: Fri Feb 6 23:27:50 2026 Epoch Time (ms): 1770420470523 [2026-02-06T23:27:51.467Z] variation: NoOptions [2026-02-06T23:27:51.467Z] JVM_OPTIONS: [2026-02-06T23:27:51.467Z] { \ [2026-02-06T23:27:51.467Z] echo ""; echo "TEST SETUP:"; \ [2026-02-06T23:27:51.467Z] echo "Nothing to be done for setup."; \ [2026-02-06T23:27:51.467Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17704189445556/renaissance-philosophers_0"; \ [2026-02-06T23:27:51.467Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17704189445556/renaissance-philosophers_0"; \ [2026-02-06T23:27:51.467Z] echo ""; echo "TESTING:"; \ [2026-02-06T23:27:51.467Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/jdkbinary/j2sdk-image/bin/java" --add-opens java.base/java.lang=ALL-UNNAMED --add-opens java.base/java.util=ALL-UNNAMED --add-opens java.base/java.util.concurrent=ALL-UNNAMED --add-opens java.base/java.nio=ALL-UNNAMED --add-opens java.base/sun.nio.ch=ALL-UNNAMED --add-opens java.base/java.lang.invoke=ALL-UNNAMED -jar "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17704189445556/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2026-02-06T23:27:51.468Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17704189445556/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-06T23:27:51.468Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-06T23:27:51.468Z] echo "Nothing to be done for teardown."; \ [2026-02-06T23:27:51.468Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17704189445556/TestTargetResult"; [2026-02-06T23:27:51.468Z] [2026-02-06T23:27:51.468Z] TEST SETUP: [2026-02-06T23:27:51.468Z] Nothing to be done for setup. [2026-02-06T23:27:51.468Z] [2026-02-06T23:27:51.468Z] TESTING: [2026-02-06T23:27:52.441Z] ====== philosophers (scala) [default], iteration 0 started ====== [2026-02-06T23:27:52.441Z] GC before operation: completed in 15.527 ms, heap usage 15.074 MB -> 4.205 MB. [2026-02-06T23:27:57.905Z] Camera thread performed 122 scans. [2026-02-06T23:27:57.905Z] ====== philosophers (scala) [default], iteration 0 completed (5933.043 ms) ====== [2026-02-06T23:27:57.905Z] ====== philosophers (scala) [default], iteration 1 started ====== [2026-02-06T23:27:57.905Z] GC before operation: completed in 20.873 ms, heap usage 9.245 MB -> 4.613 MB. [2026-02-06T23:28:03.368Z] Camera thread performed 122 scans. [2026-02-06T23:28:03.368Z] ====== philosophers (scala) [default], iteration 1 completed (5471.628 ms) ====== [2026-02-06T23:28:03.368Z] ====== philosophers (scala) [default], iteration 2 started ====== [2026-02-06T23:28:03.368Z] GC before operation: completed in 12.554 ms, heap usage 18.946 MB -> 4.617 MB. [2026-02-06T23:28:08.833Z] Camera thread performed 122 scans. [2026-02-06T23:28:08.833Z] ====== philosophers (scala) [default], iteration 2 completed (5252.822 ms) ====== [2026-02-06T23:28:08.833Z] ====== philosophers (scala) [default], iteration 3 started ====== [2026-02-06T23:28:08.833Z] GC before operation: completed in 16.580 ms, heap usage 10.505 MB -> 4.619 MB. [2026-02-06T23:28:14.297Z] Camera thread performed 122 scans. [2026-02-06T23:28:14.297Z] ====== philosophers (scala) [default], iteration 3 completed (5153.889 ms) ====== [2026-02-06T23:28:14.297Z] ====== philosophers (scala) [default], iteration 4 started ====== [2026-02-06T23:28:14.297Z] GC before operation: completed in 13.536 ms, heap usage 37.632 MB -> 4.620 MB. [2026-02-06T23:28:18.518Z] Camera thread performed 122 scans. [2026-02-06T23:28:18.518Z] ====== philosophers (scala) [default], iteration 4 completed (4637.986 ms) ====== [2026-02-06T23:28:18.518Z] ====== philosophers (scala) [default], iteration 5 started ====== [2026-02-06T23:28:18.518Z] GC before operation: completed in 15.139 ms, heap usage 10.751 MB -> 4.621 MB. [2026-02-06T23:28:24.159Z] Camera thread performed 122 scans. [2026-02-06T23:28:24.159Z] ====== philosophers (scala) [default], iteration 5 completed (5208.397 ms) ====== [2026-02-06T23:28:24.159Z] ====== philosophers (scala) [default], iteration 6 started ====== [2026-02-06T23:28:24.159Z] GC before operation: completed in 15.786 ms, heap usage 18.013 MB -> 4.622 MB. [2026-02-06T23:28:29.632Z] Camera thread performed 122 scans. [2026-02-06T23:28:29.633Z] ====== philosophers (scala) [default], iteration 6 completed (5638.032 ms) ====== [2026-02-06T23:28:29.633Z] ====== philosophers (scala) [default], iteration 7 started ====== [2026-02-06T23:28:29.633Z] GC before operation: completed in 14.966 ms, heap usage 17.904 MB -> 4.622 MB. [2026-02-06T23:28:35.098Z] Camera thread performed 122 scans. [2026-02-06T23:28:35.098Z] ====== philosophers (scala) [default], iteration 7 completed (5686.651 ms) ====== [2026-02-06T23:28:35.098Z] ====== philosophers (scala) [default], iteration 8 started ====== [2026-02-06T23:28:35.098Z] GC before operation: completed in 12.473 ms, heap usage 20.568 MB -> 4.622 MB. [2026-02-06T23:28:40.560Z] Camera thread performed 122 scans. [2026-02-06T23:28:40.560Z] ====== philosophers (scala) [default], iteration 8 completed (5337.218 ms) ====== [2026-02-06T23:28:40.560Z] ====== philosophers (scala) [default], iteration 9 started ====== [2026-02-06T23:28:40.560Z] GC before operation: completed in 13.121 ms, heap usage 13.950 MB -> 4.622 MB. [2026-02-06T23:28:46.022Z] Camera thread performed 122 scans. [2026-02-06T23:28:46.022Z] ====== philosophers (scala) [default], iteration 9 completed (5454.038 ms) ====== [2026-02-06T23:28:46.022Z] ====== philosophers (scala) [default], iteration 10 started ====== [2026-02-06T23:28:46.022Z] GC before operation: completed in 16.507 ms, heap usage 16.823 MB -> 4.622 MB. [2026-02-06T23:28:51.486Z] Camera thread performed 122 scans. [2026-02-06T23:28:51.486Z] ====== philosophers (scala) [default], iteration 10 completed (5160.709 ms) ====== [2026-02-06T23:28:51.486Z] ====== philosophers (scala) [default], iteration 11 started ====== [2026-02-06T23:28:51.486Z] GC before operation: completed in 15.361 ms, heap usage 15.914 MB -> 4.623 MB. [2026-02-06T23:28:56.949Z] Camera thread performed 122 scans. [2026-02-06T23:28:56.949Z] ====== philosophers (scala) [default], iteration 11 completed (5754.979 ms) ====== [2026-02-06T23:28:56.949Z] ====== philosophers (scala) [default], iteration 12 started ====== [2026-02-06T23:28:56.949Z] GC before operation: completed in 15.468 ms, heap usage 11.798 MB -> 4.624 MB. [2026-02-06T23:29:03.763Z] Camera thread performed 122 scans. [2026-02-06T23:29:03.763Z] ====== philosophers (scala) [default], iteration 12 completed (5877.775 ms) ====== [2026-02-06T23:29:03.763Z] ====== philosophers (scala) [default], iteration 13 started ====== [2026-02-06T23:29:03.763Z] GC before operation: completed in 12.246 ms, heap usage 5.936 MB -> 4.624 MB. [2026-02-06T23:29:09.225Z] Camera thread performed 122 scans. [2026-02-06T23:29:09.225Z] ====== philosophers (scala) [default], iteration 13 completed (5979.245 ms) ====== [2026-02-06T23:29:09.225Z] ====== philosophers (scala) [default], iteration 14 started ====== [2026-02-06T23:29:09.226Z] GC before operation: completed in 15.284 ms, heap usage 14.159 MB -> 4.624 MB. [2026-02-06T23:29:14.694Z] Camera thread performed 122 scans. [2026-02-06T23:29:14.694Z] ====== philosophers (scala) [default], iteration 14 completed (5386.609 ms) ====== [2026-02-06T23:29:14.694Z] ====== philosophers (scala) [default], iteration 15 started ====== [2026-02-06T23:29:14.694Z] GC before operation: completed in 15.593 ms, heap usage 25.126 MB -> 4.624 MB. [2026-02-06T23:29:20.159Z] Camera thread performed 122 scans. [2026-02-06T23:29:20.159Z] ====== philosophers (scala) [default], iteration 15 completed (6103.050 ms) ====== [2026-02-06T23:29:20.159Z] ====== philosophers (scala) [default], iteration 16 started ====== [2026-02-06T23:29:20.159Z] GC before operation: completed in 12.021 ms, heap usage 20.665 MB -> 4.624 MB. [2026-02-06T23:29:25.790Z] Camera thread performed 122 scans. [2026-02-06T23:29:25.790Z] ====== philosophers (scala) [default], iteration 16 completed (5590.101 ms) ====== [2026-02-06T23:29:25.790Z] ====== philosophers (scala) [default], iteration 17 started ====== [2026-02-06T23:29:25.790Z] GC before operation: completed in 15.448 ms, heap usage 5.199 MB -> 4.625 MB. [2026-02-06T23:29:31.249Z] Camera thread performed 122 scans. [2026-02-06T23:29:31.250Z] ====== philosophers (scala) [default], iteration 17 completed (5642.889 ms) ====== [2026-02-06T23:29:31.250Z] ====== philosophers (scala) [default], iteration 18 started ====== [2026-02-06T23:29:31.250Z] GC before operation: completed in 14.869 ms, heap usage 22.886 MB -> 4.624 MB. [2026-02-06T23:29:36.719Z] Camera thread performed 122 scans. [2026-02-06T23:29:36.719Z] ====== philosophers (scala) [default], iteration 18 completed (5069.588 ms) ====== [2026-02-06T23:29:36.719Z] ====== philosophers (scala) [default], iteration 19 started ====== [2026-02-06T23:29:36.719Z] GC before operation: completed in 18.677 ms, heap usage 6.142 MB -> 4.625 MB. [2026-02-06T23:29:42.185Z] Camera thread performed 122 scans. [2026-02-06T23:29:42.185Z] ====== philosophers (scala) [default], iteration 19 completed (5325.697 ms) ====== [2026-02-06T23:29:42.185Z] ====== philosophers (scala) [default], iteration 20 started ====== [2026-02-06T23:29:42.185Z] GC before operation: completed in 13.346 ms, heap usage 17.562 MB -> 4.624 MB. [2026-02-06T23:29:47.648Z] Camera thread performed 122 scans. [2026-02-06T23:29:47.648Z] ====== philosophers (scala) [default], iteration 20 completed (5196.347 ms) ====== [2026-02-06T23:29:47.648Z] ====== philosophers (scala) [default], iteration 21 started ====== [2026-02-06T23:29:47.648Z] GC before operation: completed in 13.373 ms, heap usage 6.766 MB -> 4.625 MB. [2026-02-06T23:29:53.114Z] Camera thread performed 122 scans. [2026-02-06T23:29:53.114Z] ====== philosophers (scala) [default], iteration 21 completed (5550.967 ms) ====== [2026-02-06T23:29:53.114Z] ====== philosophers (scala) [default], iteration 22 started ====== [2026-02-06T23:29:53.114Z] GC before operation: completed in 15.274 ms, heap usage 16.159 MB -> 4.625 MB. [2026-02-06T23:29:58.575Z] Camera thread performed 122 scans. [2026-02-06T23:29:58.575Z] ====== philosophers (scala) [default], iteration 22 completed (5080.768 ms) ====== [2026-02-06T23:29:58.575Z] ====== philosophers (scala) [default], iteration 23 started ====== [2026-02-06T23:29:58.575Z] GC before operation: completed in 12.105 ms, heap usage 19.779 MB -> 4.625 MB. [2026-02-06T23:30:02.831Z] Camera thread performed 122 scans. [2026-02-06T23:30:02.831Z] ====== philosophers (scala) [default], iteration 23 completed (5291.046 ms) ====== [2026-02-06T23:30:02.831Z] ====== philosophers (scala) [default], iteration 24 started ====== [2026-02-06T23:30:02.831Z] GC before operation: completed in 16.896 ms, heap usage 19.971 MB -> 4.625 MB. [2026-02-06T23:30:09.636Z] Camera thread performed 122 scans. [2026-02-06T23:30:09.636Z] ====== philosophers (scala) [default], iteration 24 completed (5747.491 ms) ====== [2026-02-06T23:30:09.636Z] ====== philosophers (scala) [default], iteration 25 started ====== [2026-02-06T23:30:09.636Z] GC before operation: completed in 15.837 ms, heap usage 17.801 MB -> 4.625 MB. [2026-02-06T23:30:15.112Z] Camera thread performed 122 scans. [2026-02-06T23:30:15.112Z] ====== philosophers (scala) [default], iteration 25 completed (5295.414 ms) ====== [2026-02-06T23:30:15.112Z] ====== philosophers (scala) [default], iteration 26 started ====== [2026-02-06T23:30:15.112Z] GC before operation: completed in 13.256 ms, heap usage 29.421 MB -> 4.625 MB. [2026-02-06T23:30:19.336Z] Camera thread performed 122 scans. [2026-02-06T23:30:19.336Z] ====== philosophers (scala) [default], iteration 26 completed (5261.107 ms) ====== [2026-02-06T23:30:19.336Z] ====== philosophers (scala) [default], iteration 27 started ====== [2026-02-06T23:30:19.336Z] GC before operation: completed in 15.377 ms, heap usage 10.754 MB -> 4.625 MB. [2026-02-06T23:30:25.008Z] Camera thread performed 122 scans. [2026-02-06T23:30:25.008Z] ====== philosophers (scala) [default], iteration 27 completed (5334.466 ms) ====== [2026-02-06T23:30:25.008Z] ====== philosophers (scala) [default], iteration 28 started ====== [2026-02-06T23:30:25.008Z] GC before operation: completed in 12.045 ms, heap usage 21.474 MB -> 4.625 MB. [2026-02-06T23:30:31.815Z] Camera thread performed 122 scans. [2026-02-06T23:30:31.815Z] ====== philosophers (scala) [default], iteration 28 completed (6153.486 ms) ====== [2026-02-06T23:30:31.815Z] ====== philosophers (scala) [default], iteration 29 started ====== [2026-02-06T23:30:31.815Z] GC before operation: completed in 15.401 ms, heap usage 12.141 MB -> 4.625 MB. [2026-02-06T23:30:37.280Z] Camera thread performed 122 scans. [2026-02-06T23:30:37.280Z] ====== philosophers (scala) [default], iteration 29 completed (5410.173 ms) ====== [2026-02-06T23:30:37.280Z] ----------------------------------- [2026-02-06T23:30:37.280Z] renaissance-philosophers_0_PASSED [2026-02-06T23:30:37.280Z] ----------------------------------- [2026-02-06T23:30:37.280Z] [2026-02-06T23:30:37.280Z] TEST TEARDOWN: [2026-02-06T23:30:37.280Z] Nothing to be done for teardown. [2026-02-06T23:30:37.281Z] renaissance-philosophers_0 Finish Time: Fri Feb 6 23:30:36 2026 Epoch Time (ms): 1770420636247