[2025-12-04T01:32:20.909Z] Running test renaissance-philosophers_0 ... [2025-12-04T01:32:20.909Z] =============================================== [2025-12-04T01:32:20.909Z] renaissance-philosophers_0 Start Time: Thu Dec 4 01:32:20 2025 Epoch Time (ms): 1764811940447 [2025-12-04T01:32:20.909Z] variation: NoOptions [2025-12-04T01:32:20.909Z] JVM_OPTIONS: [2025-12-04T01:32:20.909Z] { \ [2025-12-04T01:32:20.909Z] echo ""; echo "TEST SETUP:"; \ [2025-12-04T01:32:20.909Z] echo "Nothing to be done for setup."; \ [2025-12-04T01:32:20.909Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_1/aqa-tests/TKG/../TKG/output_17648110234990/renaissance-philosophers_0"; \ [2025-12-04T01:32:20.909Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_1/aqa-tests/TKG/../TKG/output_17648110234990/renaissance-philosophers_0"; \ [2025-12-04T01:32:20.909Z] echo ""; echo "TESTING:"; \ [2025-12-04T01:32:20.909Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_1/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_x86-64_linux_testList_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_1/aqa-tests/TKG/../TKG/output_17648110234990/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2025-12-04T01:32:20.909Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_1/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_1/aqa-tests/TKG/../TKG/output_17648110234990/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-04T01:32:20.909Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-04T01:32:20.909Z] echo "Nothing to be done for teardown."; \ [2025-12-04T01:32:20.909Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_1/aqa-tests/TKG/../TKG/output_17648110234990/TestTargetResult"; [2025-12-04T01:32:20.909Z] [2025-12-04T01:32:20.909Z] TEST SETUP: [2025-12-04T01:32:20.909Z] Nothing to be done for setup. [2025-12-04T01:32:20.909Z] [2025-12-04T01:32:20.909Z] TESTING: [2025-12-04T01:32:21.582Z] ====== philosophers (scala) [default], iteration 0 started ====== [2025-12-04T01:32:21.582Z] GC before operation: completed in 15.133 ms, heap usage 5.675 MB -> 4.188 MB. [2025-12-04T01:32:24.424Z] Camera thread performed 122 scans. [2025-12-04T01:32:24.424Z] ====== philosophers (scala) [default], iteration 0 completed (2392.252 ms) ====== [2025-12-04T01:32:24.424Z] ====== philosophers (scala) [default], iteration 1 started ====== [2025-12-04T01:32:24.424Z] GC before operation: completed in 29.910 ms, heap usage 40.483 MB -> 4.613 MB. [2025-12-04T01:32:24.751Z] Camera thread performed 122 scans. [2025-12-04T01:32:24.751Z] ====== philosophers (scala) [default], iteration 1 completed (749.360 ms) ====== [2025-12-04T01:32:24.751Z] ====== philosophers (scala) [default], iteration 2 started ====== [2025-12-04T01:32:24.751Z] GC before operation: completed in 12.238 ms, heap usage 18.478 MB -> 4.612 MB. [2025-12-04T01:32:25.426Z] Camera thread performed 122 scans. [2025-12-04T01:32:25.426Z] ====== philosophers (scala) [default], iteration 2 completed (683.679 ms) ====== [2025-12-04T01:32:25.426Z] ====== philosophers (scala) [default], iteration 3 started ====== [2025-12-04T01:32:25.426Z] GC before operation: completed in 12.683 ms, heap usage 30.958 MB -> 4.613 MB. [2025-12-04T01:32:26.099Z] Camera thread performed 122 scans. [2025-12-04T01:32:26.099Z] ====== philosophers (scala) [default], iteration 3 completed (682.520 ms) ====== [2025-12-04T01:32:26.099Z] ====== philosophers (scala) [default], iteration 4 started ====== [2025-12-04T01:32:26.099Z] GC before operation: completed in 13.892 ms, heap usage 16.418 MB -> 4.613 MB. [2025-12-04T01:32:26.769Z] Camera thread performed 122 scans. [2025-12-04T01:32:26.769Z] ====== philosophers (scala) [default], iteration 4 completed (730.193 ms) ====== [2025-12-04T01:32:26.769Z] ====== philosophers (scala) [default], iteration 5 started ====== [2025-12-04T01:32:26.769Z] GC before operation: completed in 24.624 ms, heap usage 23.864 MB -> 4.617 MB. [2025-12-04T01:32:27.860Z] Camera thread performed 122 scans. [2025-12-04T01:32:27.860Z] ====== philosophers (scala) [default], iteration 5 completed (798.642 ms) ====== [2025-12-04T01:32:27.860Z] ====== philosophers (scala) [default], iteration 6 started ====== [2025-12-04T01:32:27.860Z] GC before operation: completed in 12.593 ms, heap usage 10.821 MB -> 4.617 MB. [2025-12-04T01:32:28.542Z] Camera thread performed 122 scans. [2025-12-04T01:32:28.542Z] ====== philosophers (scala) [default], iteration 6 completed (703.738 ms) ====== [2025-12-04T01:32:28.542Z] ====== philosophers (scala) [default], iteration 7 started ====== [2025-12-04T01:32:28.542Z] GC before operation: completed in 13.384 ms, heap usage 16.296 MB -> 4.618 MB. [2025-12-04T01:32:29.216Z] Camera thread performed 122 scans. [2025-12-04T01:32:29.216Z] ====== philosophers (scala) [default], iteration 7 completed (671.047 ms) ====== [2025-12-04T01:32:29.216Z] ====== philosophers (scala) [default], iteration 8 started ====== [2025-12-04T01:32:29.216Z] GC before operation: completed in 14.180 ms, heap usage 53.757 MB -> 4.618 MB. [2025-12-04T01:32:29.888Z] Camera thread performed 122 scans. [2025-12-04T01:32:29.888Z] ====== philosophers (scala) [default], iteration 8 completed (675.524 ms) ====== [2025-12-04T01:32:29.888Z] ====== philosophers (scala) [default], iteration 9 started ====== [2025-12-04T01:32:29.888Z] GC before operation: completed in 13.621 ms, heap usage 39.750 MB -> 4.619 MB. [2025-12-04T01:32:30.561Z] Camera thread performed 122 scans. [2025-12-04T01:32:30.561Z] ====== philosophers (scala) [default], iteration 9 completed (663.226 ms) ====== [2025-12-04T01:32:30.561Z] ====== philosophers (scala) [default], iteration 10 started ====== [2025-12-04T01:32:30.561Z] GC before operation: completed in 13.486 ms, heap usage 30.743 MB -> 4.620 MB. [2025-12-04T01:32:31.233Z] Camera thread performed 122 scans. [2025-12-04T01:32:31.233Z] ====== philosophers (scala) [default], iteration 10 completed (678.702 ms) ====== [2025-12-04T01:32:31.233Z] ====== philosophers (scala) [default], iteration 11 started ====== [2025-12-04T01:32:31.233Z] GC before operation: completed in 13.838 ms, heap usage 44.248 MB -> 4.620 MB. [2025-12-04T01:32:31.907Z] Camera thread performed 122 scans. [2025-12-04T01:32:31.907Z] ====== philosophers (scala) [default], iteration 11 completed (690.781 ms) ====== [2025-12-04T01:32:31.907Z] ====== philosophers (scala) [default], iteration 12 started ====== [2025-12-04T01:32:31.907Z] GC before operation: completed in 15.143 ms, heap usage 23.257 MB -> 4.620 MB. [2025-12-04T01:32:32.579Z] Camera thread performed 122 scans. [2025-12-04T01:32:32.579Z] ====== philosophers (scala) [default], iteration 12 completed (678.622 ms) ====== [2025-12-04T01:32:32.579Z] ====== philosophers (scala) [default], iteration 13 started ====== [2025-12-04T01:32:32.579Z] GC before operation: completed in 15.574 ms, heap usage 66.245 MB -> 4.621 MB. [2025-12-04T01:32:33.249Z] Camera thread performed 122 scans. [2025-12-04T01:32:33.250Z] ====== philosophers (scala) [default], iteration 13 completed (676.437 ms) ====== [2025-12-04T01:32:33.250Z] ====== philosophers (scala) [default], iteration 14 started ====== [2025-12-04T01:32:33.250Z] GC before operation: completed in 13.391 ms, heap usage 22.249 MB -> 4.620 MB. [2025-12-04T01:32:33.924Z] Camera thread performed 122 scans. [2025-12-04T01:32:33.924Z] ====== philosophers (scala) [default], iteration 14 completed (695.425 ms) ====== [2025-12-04T01:32:33.924Z] ====== philosophers (scala) [default], iteration 15 started ====== [2025-12-04T01:32:33.924Z] GC before operation: completed in 13.153 ms, heap usage 9.706 MB -> 4.621 MB. [2025-12-04T01:32:34.662Z] Camera thread performed 122 scans. [2025-12-04T01:32:34.662Z] ====== philosophers (scala) [default], iteration 15 completed (726.361 ms) ====== [2025-12-04T01:32:34.662Z] ====== philosophers (scala) [default], iteration 16 started ====== [2025-12-04T01:32:34.662Z] GC before operation: completed in 15.423 ms, heap usage 61.244 MB -> 4.621 MB. [2025-12-04T01:32:35.332Z] Camera thread performed 122 scans. [2025-12-04T01:32:35.332Z] ====== philosophers (scala) [default], iteration 16 completed (671.108 ms) ====== [2025-12-04T01:32:35.332Z] ====== philosophers (scala) [default], iteration 17 started ====== [2025-12-04T01:32:35.332Z] GC before operation: completed in 16.175 ms, heap usage 55.745 MB -> 4.621 MB. [2025-12-04T01:32:36.011Z] Camera thread performed 122 scans. [2025-12-04T01:32:36.011Z] ====== philosophers (scala) [default], iteration 17 completed (675.431 ms) ====== [2025-12-04T01:32:36.011Z] ====== philosophers (scala) [default], iteration 18 started ====== [2025-12-04T01:32:36.011Z] GC before operation: completed in 13.344 ms, heap usage 55.247 MB -> 4.621 MB. [2025-12-04T01:32:36.681Z] Camera thread performed 122 scans. [2025-12-04T01:32:36.681Z] ====== philosophers (scala) [default], iteration 18 completed (687.801 ms) ====== [2025-12-04T01:32:36.681Z] ====== philosophers (scala) [default], iteration 19 started ====== [2025-12-04T01:32:36.681Z] GC before operation: completed in 13.346 ms, heap usage 6.754 MB -> 4.621 MB. [2025-12-04T01:32:37.352Z] Camera thread performed 122 scans. [2025-12-04T01:32:37.352Z] ====== philosophers (scala) [default], iteration 19 completed (697.714 ms) ====== [2025-12-04T01:32:37.352Z] ====== philosophers (scala) [default], iteration 20 started ====== [2025-12-04T01:32:37.352Z] GC before operation: completed in 13.775 ms, heap usage 39.255 MB -> 4.621 MB. [2025-12-04T01:32:38.441Z] Camera thread performed 122 scans. [2025-12-04T01:32:38.441Z] ====== philosophers (scala) [default], iteration 20 completed (714.686 ms) ====== [2025-12-04T01:32:38.441Z] ====== philosophers (scala) [default], iteration 21 started ====== [2025-12-04T01:32:38.441Z] GC before operation: completed in 15.888 ms, heap usage 55.251 MB -> 4.622 MB. [2025-12-04T01:32:38.752Z] Camera thread performed 122 scans. [2025-12-04T01:32:38.752Z] ====== philosophers (scala) [default], iteration 21 completed (697.974 ms) ====== [2025-12-04T01:32:38.752Z] ====== philosophers (scala) [default], iteration 22 started ====== [2025-12-04T01:32:39.062Z] GC before operation: completed in 15.728 ms, heap usage 17.757 MB -> 4.622 MB. [2025-12-04T01:32:39.733Z] Camera thread performed 122 scans. [2025-12-04T01:32:39.733Z] ====== philosophers (scala) [default], iteration 22 completed (716.795 ms) ====== [2025-12-04T01:32:39.733Z] ====== philosophers (scala) [default], iteration 23 started ====== [2025-12-04T01:32:39.733Z] GC before operation: completed in 12.442 ms, heap usage 23.746 MB -> 4.622 MB. [2025-12-04T01:32:40.403Z] Camera thread performed 122 scans. [2025-12-04T01:32:40.403Z] ====== philosophers (scala) [default], iteration 23 completed (692.569 ms) ====== [2025-12-04T01:32:40.403Z] ====== philosophers (scala) [default], iteration 24 started ====== [2025-12-04T01:32:40.403Z] GC before operation: completed in 15.413 ms, heap usage 59.754 MB -> 4.622 MB. [2025-12-04T01:32:41.074Z] Camera thread performed 122 scans. [2025-12-04T01:32:41.074Z] ====== philosophers (scala) [default], iteration 24 completed (680.121 ms) ====== [2025-12-04T01:32:41.074Z] ====== philosophers (scala) [default], iteration 25 started ====== [2025-12-04T01:32:41.074Z] GC before operation: completed in 14.331 ms, heap usage 54.749 MB -> 4.622 MB. [2025-12-04T01:32:41.746Z] Camera thread performed 122 scans. [2025-12-04T01:32:41.746Z] ====== philosophers (scala) [default], iteration 25 completed (681.782 ms) ====== [2025-12-04T01:32:41.746Z] ====== philosophers (scala) [default], iteration 26 started ====== [2025-12-04T01:32:41.746Z] GC before operation: completed in 13.327 ms, heap usage 18.752 MB -> 4.622 MB. [2025-12-04T01:32:42.416Z] Camera thread performed 122 scans. [2025-12-04T01:32:42.416Z] ====== philosophers (scala) [default], iteration 26 completed (685.083 ms) ====== [2025-12-04T01:32:42.416Z] ====== philosophers (scala) [default], iteration 27 started ====== [2025-12-04T01:32:42.416Z] GC before operation: completed in 14.777 ms, heap usage 18.749 MB -> 4.623 MB. [2025-12-04T01:32:43.089Z] Camera thread performed 122 scans. [2025-12-04T01:32:43.089Z] ====== philosophers (scala) [default], iteration 27 completed (672.893 ms) ====== [2025-12-04T01:32:43.089Z] ====== philosophers (scala) [default], iteration 28 started ====== [2025-12-04T01:32:43.089Z] GC before operation: completed in 13.798 ms, heap usage 10.753 MB -> 4.623 MB. [2025-12-04T01:32:43.762Z] Camera thread performed 122 scans. [2025-12-04T01:32:43.762Z] ====== philosophers (scala) [default], iteration 28 completed (681.797 ms) ====== [2025-12-04T01:32:43.762Z] ====== philosophers (scala) [default], iteration 29 started ====== [2025-12-04T01:32:43.762Z] GC before operation: completed in 14.992 ms, heap usage 59.746 MB -> 4.623 MB. [2025-12-04T01:32:44.435Z] Camera thread performed 122 scans. [2025-12-04T01:32:44.435Z] ====== philosophers (scala) [default], iteration 29 completed (691.059 ms) ====== [2025-12-04T01:32:44.747Z] ----------------------------------- [2025-12-04T01:32:44.747Z] renaissance-philosophers_0_PASSED [2025-12-04T01:32:44.747Z] ----------------------------------- [2025-12-04T01:32:44.747Z] [2025-12-04T01:32:44.747Z] TEST TEARDOWN: [2025-12-04T01:32:44.747Z] Nothing to be done for teardown. [2025-12-04T01:32:44.747Z] renaissance-philosophers_0 Finish Time: Thu Dec 4 01:32:44 2025 Epoch Time (ms): 1764811964588