[2025-08-25T22:52:46.927Z] Running test renaissance-philosophers_0 ... [2025-08-25T22:52:46.927Z] =============================================== [2025-08-25T22:52:46.927Z] renaissance-philosophers_0 Start Time: Mon Aug 25 22:52:46 2025 Epoch Time (ms): 1756162366337 [2025-08-25T22:52:46.927Z] variation: NoOptions [2025-08-25T22:52:46.927Z] JVM_OPTIONS: [2025-08-25T22:52:46.927Z] { \ [2025-08-25T22:52:46.927Z] echo ""; echo "TEST SETUP:"; \ [2025-08-25T22:52:46.927Z] echo "Nothing to be done for setup."; \ [2025-08-25T22:52:46.927Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17561604265130/renaissance-philosophers_0"; \ [2025-08-25T22:52:46.927Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17561604265130/renaissance-philosophers_0"; \ [2025-08-25T22:52:46.927Z] echo ""; echo "TESTING:"; \ [2025-08-25T22:52:46.927Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-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_alpine-linux_testList_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17561604265130/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2025-08-25T22:52:46.927Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17561604265130/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-08-25T22:52:46.927Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-08-25T22:52:46.927Z] echo "Nothing to be done for teardown."; \ [2025-08-25T22:52:46.927Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_1/aqa-tests/TKG/../TKG/output_17561604265130/TestTargetResult"; [2025-08-25T22:52:46.927Z] [2025-08-25T22:52:46.927Z] TEST SETUP: [2025-08-25T22:52:46.927Z] Nothing to be done for setup. [2025-08-25T22:52:46.927Z] [2025-08-25T22:52:46.927Z] TESTING: [2025-08-25T22:52:47.704Z] ====== philosophers (scala) [default], iteration 0 started ====== [2025-08-25T22:52:48.497Z] GC before operation: completed in 31.355 ms, heap usage 15.069 MB -> 4.205 MB. [2025-08-25T22:52:51.966Z] Camera thread performed 122 scans. [2025-08-25T22:52:51.966Z] ====== philosophers (scala) [default], iteration 0 completed (3385.062 ms) ====== [2025-08-25T22:52:51.966Z] ====== philosophers (scala) [default], iteration 1 started ====== [2025-08-25T22:52:51.966Z] GC before operation: completed in 33.101 ms, heap usage 18.627 MB -> 4.613 MB. [2025-08-25T22:52:52.744Z] Camera thread performed 122 scans. [2025-08-25T22:52:52.744Z] ====== philosophers (scala) [default], iteration 1 completed (1328.323 ms) ====== [2025-08-25T22:52:52.744Z] ====== philosophers (scala) [default], iteration 2 started ====== [2025-08-25T22:52:52.744Z] GC before operation: completed in 23.054 ms, heap usage 14.803 MB -> 4.613 MB. [2025-08-25T22:52:54.912Z] Camera thread performed 122 scans. [2025-08-25T22:52:54.912Z] ====== philosophers (scala) [default], iteration 2 completed (1368.676 ms) ====== [2025-08-25T22:52:54.912Z] ====== philosophers (scala) [default], iteration 3 started ====== [2025-08-25T22:52:54.912Z] GC before operation: completed in 34.448 ms, heap usage 40.809 MB -> 4.619 MB. [2025-08-25T22:52:55.686Z] Camera thread performed 122 scans. [2025-08-25T22:52:55.686Z] ====== philosophers (scala) [default], iteration 3 completed (1362.886 ms) ====== [2025-08-25T22:52:55.686Z] ====== philosophers (scala) [default], iteration 4 started ====== [2025-08-25T22:52:55.686Z] GC before operation: completed in 31.910 ms, heap usage 26.833 MB -> 4.619 MB. [2025-08-25T22:52:57.295Z] Camera thread performed 122 scans. [2025-08-25T22:52:57.295Z] ====== philosophers (scala) [default], iteration 4 completed (1362.689 ms) ====== [2025-08-25T22:52:57.295Z] ====== philosophers (scala) [default], iteration 5 started ====== [2025-08-25T22:52:57.295Z] GC before operation: completed in 55.513 ms, heap usage 41.404 MB -> 4.621 MB. [2025-08-25T22:52:58.933Z] Camera thread performed 122 scans. [2025-08-25T22:52:58.933Z] ====== philosophers (scala) [default], iteration 5 completed (1426.574 ms) ====== [2025-08-25T22:52:58.933Z] ====== philosophers (scala) [default], iteration 6 started ====== [2025-08-25T22:52:58.933Z] GC before operation: completed in 28.791 ms, heap usage 40.302 MB -> 4.622 MB. [2025-08-25T22:52:59.719Z] Camera thread performed 122 scans. [2025-08-25T22:52:59.719Z] ====== philosophers (scala) [default], iteration 6 completed (1325.097 ms) ====== [2025-08-25T22:52:59.719Z] ====== philosophers (scala) [default], iteration 7 started ====== [2025-08-25T22:52:59.719Z] GC before operation: completed in 40.765 ms, heap usage 36.180 MB -> 4.622 MB. [2025-08-25T22:53:01.324Z] Camera thread performed 122 scans. [2025-08-25T22:53:01.324Z] ====== philosophers (scala) [default], iteration 7 completed (1370.918 ms) ====== [2025-08-25T22:53:01.324Z] ====== philosophers (scala) [default], iteration 8 started ====== [2025-08-25T22:53:01.324Z] GC before operation: completed in 26.662 ms, heap usage 33.645 MB -> 4.622 MB. [2025-08-25T22:53:02.920Z] Camera thread performed 122 scans. [2025-08-25T22:53:02.920Z] ====== philosophers (scala) [default], iteration 8 completed (1372.894 ms) ====== [2025-08-25T22:53:02.920Z] ====== philosophers (scala) [default], iteration 9 started ====== [2025-08-25T22:53:02.920Z] GC before operation: completed in 23.274 ms, heap usage 24.867 MB -> 4.622 MB. [2025-08-25T22:53:04.531Z] Camera thread performed 122 scans. [2025-08-25T22:53:04.531Z] ====== philosophers (scala) [default], iteration 9 completed (1394.541 ms) ====== [2025-08-25T22:53:04.531Z] ====== philosophers (scala) [default], iteration 10 started ====== [2025-08-25T22:53:04.531Z] GC before operation: completed in 25.826 ms, heap usage 35.215 MB -> 4.622 MB. [2025-08-25T22:53:05.308Z] Camera thread performed 122 scans. [2025-08-25T22:53:05.308Z] ====== philosophers (scala) [default], iteration 10 completed (1356.562 ms) ====== [2025-08-25T22:53:05.308Z] ====== philosophers (scala) [default], iteration 11 started ====== [2025-08-25T22:53:05.308Z] GC before operation: completed in 39.624 ms, heap usage 5.818 MB -> 4.622 MB. [2025-08-25T22:53:06.904Z] Camera thread performed 122 scans. [2025-08-25T22:53:06.904Z] ====== philosophers (scala) [default], iteration 11 completed (1371.080 ms) ====== [2025-08-25T22:53:06.904Z] ====== philosophers (scala) [default], iteration 12 started ====== [2025-08-25T22:53:06.904Z] GC before operation: completed in 27.507 ms, heap usage 36.182 MB -> 4.623 MB. [2025-08-25T22:53:08.506Z] Camera thread performed 122 scans. [2025-08-25T22:53:08.506Z] ====== philosophers (scala) [default], iteration 12 completed (1327.430 ms) ====== [2025-08-25T22:53:08.506Z] ====== philosophers (scala) [default], iteration 13 started ====== [2025-08-25T22:53:08.506Z] GC before operation: completed in 40.748 ms, heap usage 29.274 MB -> 4.623 MB. [2025-08-25T22:53:09.287Z] Camera thread performed 122 scans. [2025-08-25T22:53:09.287Z] ====== philosophers (scala) [default], iteration 13 completed (1281.523 ms) ====== [2025-08-25T22:53:09.287Z] ====== philosophers (scala) [default], iteration 14 started ====== [2025-08-25T22:53:09.287Z] GC before operation: completed in 37.200 ms, heap usage 62.424 MB -> 4.623 MB. [2025-08-25T22:53:10.894Z] Camera thread performed 122 scans. [2025-08-25T22:53:10.894Z] ====== philosophers (scala) [default], iteration 14 completed (1301.506 ms) ====== [2025-08-25T22:53:10.894Z] ====== philosophers (scala) [default], iteration 15 started ====== [2025-08-25T22:53:10.894Z] GC before operation: completed in 37.913 ms, heap usage 57.139 MB -> 4.624 MB. [2025-08-25T22:53:12.495Z] Camera thread performed 122 scans. [2025-08-25T22:53:12.495Z] ====== philosophers (scala) [default], iteration 15 completed (1354.771 ms) ====== [2025-08-25T22:53:12.495Z] ====== philosophers (scala) [default], iteration 16 started ====== [2025-08-25T22:53:12.495Z] GC before operation: completed in 24.987 ms, heap usage 63.829 MB -> 4.624 MB. [2025-08-25T22:53:14.105Z] Camera thread performed 122 scans. [2025-08-25T22:53:14.105Z] ====== philosophers (scala) [default], iteration 16 completed (1318.355 ms) ====== [2025-08-25T22:53:14.105Z] ====== philosophers (scala) [default], iteration 17 started ====== [2025-08-25T22:53:14.105Z] GC before operation: completed in 28.034 ms, heap usage 24.495 MB -> 4.624 MB. [2025-08-25T22:53:14.880Z] Camera thread performed 122 scans. [2025-08-25T22:53:14.880Z] ====== philosophers (scala) [default], iteration 17 completed (1347.063 ms) ====== [2025-08-25T22:53:14.880Z] ====== philosophers (scala) [default], iteration 18 started ====== [2025-08-25T22:53:14.880Z] GC before operation: completed in 27.598 ms, heap usage 62.421 MB -> 4.624 MB. [2025-08-25T22:53:16.549Z] Camera thread performed 122 scans. [2025-08-25T22:53:16.549Z] ====== philosophers (scala) [default], iteration 18 completed (1414.268 ms) ====== [2025-08-25T22:53:16.549Z] ====== philosophers (scala) [default], iteration 19 started ====== [2025-08-25T22:53:16.549Z] GC before operation: completed in 30.666 ms, heap usage 50.789 MB -> 4.624 MB. [2025-08-25T22:53:18.153Z] Camera thread performed 122 scans. [2025-08-25T22:53:18.153Z] ====== philosophers (scala) [default], iteration 19 completed (1431.322 ms) ====== [2025-08-25T22:53:18.153Z] ====== philosophers (scala) [default], iteration 20 started ====== [2025-08-25T22:53:18.153Z] GC before operation: completed in 24.288 ms, heap usage 33.135 MB -> 4.624 MB. [2025-08-25T22:53:18.947Z] Camera thread performed 122 scans. [2025-08-25T22:53:18.948Z] ====== philosophers (scala) [default], iteration 20 completed (1327.786 ms) ====== [2025-08-25T22:53:18.948Z] ====== philosophers (scala) [default], iteration 21 started ====== [2025-08-25T22:53:19.730Z] GC before operation: completed in 45.558 ms, heap usage 52.204 MB -> 4.624 MB. [2025-08-25T22:53:20.505Z] Camera thread performed 122 scans. [2025-08-25T22:53:20.505Z] ====== philosophers (scala) [default], iteration 21 completed (1346.357 ms) ====== [2025-08-25T22:53:20.505Z] ====== philosophers (scala) [default], iteration 22 started ====== [2025-08-25T22:53:20.505Z] GC before operation: completed in 26.373 ms, heap usage 73.168 MB -> 4.624 MB. [2025-08-25T22:53:22.102Z] Camera thread performed 122 scans. [2025-08-25T22:53:22.102Z] ====== philosophers (scala) [default], iteration 22 completed (1361.536 ms) ====== [2025-08-25T22:53:22.102Z] ====== philosophers (scala) [default], iteration 23 started ====== [2025-08-25T22:53:22.102Z] GC before operation: completed in 34.799 ms, heap usage 27.574 MB -> 4.625 MB. [2025-08-25T22:53:23.710Z] Camera thread performed 122 scans. [2025-08-25T22:53:23.710Z] ====== philosophers (scala) [default], iteration 23 completed (1330.598 ms) ====== [2025-08-25T22:53:23.710Z] ====== philosophers (scala) [default], iteration 24 started ====== [2025-08-25T22:53:23.710Z] GC before operation: completed in 29.454 ms, heap usage 22.172 MB -> 4.624 MB. [2025-08-25T22:53:25.312Z] Camera thread performed 122 scans. [2025-08-25T22:53:25.312Z] ====== philosophers (scala) [default], iteration 24 completed (1431.033 ms) ====== [2025-08-25T22:53:25.312Z] ====== philosophers (scala) [default], iteration 25 started ====== [2025-08-25T22:53:25.312Z] GC before operation: completed in 28.594 ms, heap usage 30.435 MB -> 4.625 MB. [2025-08-25T22:53:26.090Z] Camera thread performed 122 scans. [2025-08-25T22:53:26.090Z] ====== philosophers (scala) [default], iteration 25 completed (1308.440 ms) ====== [2025-08-25T22:53:26.090Z] ====== philosophers (scala) [default], iteration 26 started ====== [2025-08-25T22:53:26.090Z] GC before operation: completed in 36.698 ms, heap usage 18.197 MB -> 4.625 MB. [2025-08-25T22:53:27.692Z] Camera thread performed 122 scans. [2025-08-25T22:53:27.692Z] ====== philosophers (scala) [default], iteration 26 completed (1332.851 ms) ====== [2025-08-25T22:53:27.692Z] ====== philosophers (scala) [default], iteration 27 started ====== [2025-08-25T22:53:27.692Z] GC before operation: completed in 24.725 ms, heap usage 51.418 MB -> 4.625 MB. [2025-08-25T22:53:29.298Z] Camera thread performed 122 scans. [2025-08-25T22:53:29.298Z] ====== philosophers (scala) [default], iteration 27 completed (1309.540 ms) ====== [2025-08-25T22:53:29.298Z] ====== philosophers (scala) [default], iteration 28 started ====== [2025-08-25T22:53:29.298Z] GC before operation: completed in 33.241 ms, heap usage 41.116 MB -> 4.661 MB. [2025-08-25T22:53:30.140Z] Camera thread performed 122 scans. [2025-08-25T22:53:30.140Z] ====== philosophers (scala) [default], iteration 28 completed (1253.426 ms) ====== [2025-08-25T22:53:30.140Z] ====== philosophers (scala) [default], iteration 29 started ====== [2025-08-25T22:53:30.140Z] GC before operation: completed in 26.928 ms, heap usage 29.872 MB -> 4.625 MB. [2025-08-25T22:53:31.750Z] Camera thread performed 122 scans. [2025-08-25T22:53:31.750Z] ====== philosophers (scala) [default], iteration 29 completed (1388.104 ms) ====== [2025-08-25T22:53:31.750Z] ----------------------------------- [2025-08-25T22:53:31.750Z] renaissance-philosophers_0_PASSED [2025-08-25T22:53:31.750Z] ----------------------------------- [2025-08-25T22:53:31.750Z] [2025-08-25T22:53:31.750Z] TEST TEARDOWN: [2025-08-25T22:53:31.750Z] Nothing to be done for teardown. [2025-08-25T22:53:31.750Z] renaissance-philosophers_0 Finish Time: Mon Aug 25 22:53:31 2025 Epoch Time (ms): 1756162411512