[2025-06-19T04:35:20.434Z] Running test renaissance-philosophers_0 ... [2025-06-19T04:35:20.434Z] =============================================== [2025-06-19T04:35:20.434Z] renaissance-philosophers_0 Start Time: Thu Jun 19 04:35:20 2025 Epoch Time (ms): 1750307720148 [2025-06-19T04:35:20.434Z] variation: NoOptions [2025-06-19T04:35:20.434Z] JVM_OPTIONS: [2025-06-19T04:35:20.434Z] { \ [2025-06-19T04:35:20.434Z] echo ""; echo "TEST SETUP:"; \ [2025-06-19T04:35:20.434Z] echo "Nothing to be done for setup."; \ [2025-06-19T04:35:20.434Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17503055404050/renaissance-philosophers_0"; \ [2025-06-19T04:35:20.434Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17503055404050/renaissance-philosophers_0"; \ [2025-06-19T04:35:20.434Z] echo ""; echo "TESTING:"; \ [2025-06-19T04:35:20.434Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_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_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17503055404050/renaissance-philosophers_0"/philosophers.json" philosophers; \ [2025-06-19T04:35:20.434Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-philosophers_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17503055404050/renaissance-philosophers_0"; else echo "-----------------------------------"; echo "renaissance-philosophers_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-19T04:35:20.434Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-19T04:35:20.434Z] echo "Nothing to be done for teardown."; \ [2025-06-19T04:35:20.434Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17503055404050/TestTargetResult"; [2025-06-19T04:35:20.434Z] [2025-06-19T04:35:20.434Z] TEST SETUP: [2025-06-19T04:35:20.434Z] Nothing to be done for setup. [2025-06-19T04:35:20.434Z] [2025-06-19T04:35:20.434Z] TESTING: [2025-06-19T04:35:22.584Z] ====== philosophers (scala) [default], iteration 0 started ====== [2025-06-19T04:35:22.584Z] GC before operation: completed in 48.492 ms, heap usage 10.804 MB -> 4.401 MB. [2025-06-19T04:35:24.724Z] Camera thread performed 122 scans. [2025-06-19T04:35:24.724Z] ====== philosophers (scala) [default], iteration 0 completed (2283.958 ms) ====== [2025-06-19T04:35:24.724Z] ====== philosophers (scala) [default], iteration 1 started ====== [2025-06-19T04:35:24.724Z] GC before operation: completed in 71.797 ms, heap usage 13.758 MB -> 4.813 MB. [2025-06-19T04:35:25.373Z] Camera thread performed 122 scans. [2025-06-19T04:35:25.373Z] ====== philosophers (scala) [default], iteration 1 completed (853.719 ms) ====== [2025-06-19T04:35:25.373Z] ====== philosophers (scala) [default], iteration 2 started ====== [2025-06-19T04:35:25.373Z] GC before operation: completed in 108.934 ms, heap usage 21.913 MB -> 4.813 MB. [2025-06-19T04:35:26.781Z] Camera thread performed 122 scans. [2025-06-19T04:35:26.781Z] ====== philosophers (scala) [default], iteration 2 completed (852.106 ms) ====== [2025-06-19T04:35:26.781Z] ====== philosophers (scala) [default], iteration 3 started ====== [2025-06-19T04:35:26.781Z] GC before operation: completed in 117.770 ms, heap usage 52.819 MB -> 4.814 MB. [2025-06-19T04:35:27.442Z] Camera thread performed 122 scans. [2025-06-19T04:35:27.442Z] ====== philosophers (scala) [default], iteration 3 completed (811.797 ms) ====== [2025-06-19T04:35:27.442Z] ====== philosophers (scala) [default], iteration 4 started ====== [2025-06-19T04:35:27.442Z] GC before operation: completed in 25.320 ms, heap usage 35.551 MB -> 4.817 MB. [2025-06-19T04:35:28.112Z] Camera thread performed 122 scans. [2025-06-19T04:35:28.112Z] ====== philosophers (scala) [default], iteration 4 completed (900.412 ms) ====== [2025-06-19T04:35:28.112Z] ====== philosophers (scala) [default], iteration 5 started ====== [2025-06-19T04:35:28.112Z] GC before operation: completed in 57.893 ms, heap usage 37.480 MB -> 4.818 MB. [2025-06-19T04:35:28.806Z] Camera thread performed 122 scans. [2025-06-19T04:35:28.806Z] ====== philosophers (scala) [default], iteration 5 completed (759.385 ms) ====== [2025-06-19T04:35:28.806Z] ====== philosophers (scala) [default], iteration 6 started ====== [2025-06-19T04:35:29.522Z] GC before operation: completed in 80.896 ms, heap usage 37.454 MB -> 4.818 MB. [2025-06-19T04:35:30.198Z] Camera thread performed 122 scans. [2025-06-19T04:35:30.198Z] ====== philosophers (scala) [default], iteration 6 completed (811.465 ms) ====== [2025-06-19T04:35:30.198Z] ====== philosophers (scala) [default], iteration 7 started ====== [2025-06-19T04:35:30.198Z] GC before operation: completed in 62.354 ms, heap usage 30.434 MB -> 4.819 MB. [2025-06-19T04:35:30.851Z] Camera thread performed 122 scans. [2025-06-19T04:35:30.851Z] ====== philosophers (scala) [default], iteration 7 completed (878.134 ms) ====== [2025-06-19T04:35:30.851Z] ====== philosophers (scala) [default], iteration 8 started ====== [2025-06-19T04:35:30.851Z] GC before operation: completed in 36.386 ms, heap usage 11.380 MB -> 4.818 MB. [2025-06-19T04:35:31.501Z] Camera thread performed 122 scans. [2025-06-19T04:35:31.501Z] ====== philosophers (scala) [default], iteration 8 completed (782.628 ms) ====== [2025-06-19T04:35:31.501Z] ====== philosophers (scala) [default], iteration 9 started ====== [2025-06-19T04:35:32.176Z] GC before operation: completed in 54.070 ms, heap usage 27.421 MB -> 4.819 MB. [2025-06-19T04:35:32.841Z] Camera thread performed 122 scans. [2025-06-19T04:35:32.841Z] ====== philosophers (scala) [default], iteration 9 completed (915.675 ms) ====== [2025-06-19T04:35:32.841Z] ====== philosophers (scala) [default], iteration 10 started ====== [2025-06-19T04:35:32.841Z] GC before operation: completed in 40.667 ms, heap usage 20.955 MB -> 4.820 MB. [2025-06-19T04:35:33.508Z] Camera thread performed 122 scans. [2025-06-19T04:35:33.508Z] ====== philosophers (scala) [default], iteration 10 completed (788.857 ms) ====== [2025-06-19T04:35:33.508Z] ====== philosophers (scala) [default], iteration 11 started ====== [2025-06-19T04:35:33.508Z] GC before operation: completed in 67.606 ms, heap usage 44.869 MB -> 4.820 MB. [2025-06-19T04:35:34.174Z] Camera thread performed 122 scans. [2025-06-19T04:35:34.174Z] ====== philosophers (scala) [default], iteration 11 completed (768.030 ms) ====== [2025-06-19T04:35:34.174Z] ====== philosophers (scala) [default], iteration 12 started ====== [2025-06-19T04:35:34.174Z] GC before operation: completed in 37.363 ms, heap usage 49.817 MB -> 4.823 MB. [2025-06-19T04:35:35.563Z] Camera thread performed 122 scans. [2025-06-19T04:35:35.564Z] ====== philosophers (scala) [default], iteration 12 completed (853.015 ms) ====== [2025-06-19T04:35:35.564Z] ====== philosophers (scala) [default], iteration 13 started ====== [2025-06-19T04:35:35.564Z] GC before operation: completed in 59.523 ms, heap usage 23.350 MB -> 4.822 MB. [2025-06-19T04:35:36.232Z] Camera thread performed 122 scans. [2025-06-19T04:35:36.232Z] ====== philosophers (scala) [default], iteration 13 completed (792.159 ms) ====== [2025-06-19T04:35:36.232Z] ====== philosophers (scala) [default], iteration 14 started ====== [2025-06-19T04:35:36.232Z] GC before operation: completed in 68.112 ms, heap usage 10.938 MB -> 4.822 MB. [2025-06-19T04:35:36.957Z] Camera thread performed 122 scans. [2025-06-19T04:35:36.957Z] ====== philosophers (scala) [default], iteration 14 completed (878.064 ms) ====== [2025-06-19T04:35:36.957Z] ====== philosophers (scala) [default], iteration 15 started ====== [2025-06-19T04:35:36.957Z] GC before operation: completed in 60.371 ms, heap usage 25.426 MB -> 4.822 MB. [2025-06-19T04:35:37.619Z] Camera thread performed 122 scans. [2025-06-19T04:35:37.619Z] ====== philosophers (scala) [default], iteration 15 completed (677.890 ms) ====== [2025-06-19T04:35:37.619Z] ====== philosophers (scala) [default], iteration 16 started ====== [2025-06-19T04:35:37.619Z] GC before operation: completed in 52.363 ms, heap usage 35.974 MB -> 4.822 MB. [2025-06-19T04:35:38.302Z] Camera thread performed 122 scans. [2025-06-19T04:35:38.302Z] ====== philosophers (scala) [default], iteration 16 completed (725.953 ms) ====== [2025-06-19T04:35:38.302Z] ====== philosophers (scala) [default], iteration 17 started ====== [2025-06-19T04:35:38.981Z] GC before operation: completed in 38.732 ms, heap usage 42.395 MB -> 4.823 MB. [2025-06-19T04:35:39.644Z] Camera thread performed 122 scans. [2025-06-19T04:35:39.644Z] ====== philosophers (scala) [default], iteration 17 completed (942.286 ms) ====== [2025-06-19T04:35:39.644Z] ====== philosophers (scala) [default], iteration 18 started ====== [2025-06-19T04:35:39.644Z] GC before operation: completed in 61.295 ms, heap usage 65.965 MB -> 4.824 MB. [2025-06-19T04:35:40.323Z] Camera thread performed 122 scans. [2025-06-19T04:35:40.323Z] ====== philosophers (scala) [default], iteration 18 completed (751.245 ms) ====== [2025-06-19T04:35:40.323Z] ====== philosophers (scala) [default], iteration 19 started ====== [2025-06-19T04:35:40.323Z] GC before operation: completed in 45.031 ms, heap usage 39.964 MB -> 4.823 MB. [2025-06-19T04:35:40.969Z] Camera thread performed 122 scans. [2025-06-19T04:35:40.970Z] ====== philosophers (scala) [default], iteration 19 completed (759.291 ms) ====== [2025-06-19T04:35:40.970Z] ====== philosophers (scala) [default], iteration 20 started ====== [2025-06-19T04:35:40.970Z] GC before operation: completed in 56.470 ms, heap usage 19.919 MB -> 4.823 MB. [2025-06-19T04:35:42.350Z] Camera thread performed 122 scans. [2025-06-19T04:35:42.350Z] ====== philosophers (scala) [default], iteration 20 completed (774.947 ms) ====== [2025-06-19T04:35:42.350Z] ====== philosophers (scala) [default], iteration 21 started ====== [2025-06-19T04:35:42.350Z] GC before operation: completed in 55.013 ms, heap usage 23.429 MB -> 4.823 MB. [2025-06-19T04:35:43.034Z] Camera thread performed 122 scans. [2025-06-19T04:35:43.034Z] ====== philosophers (scala) [default], iteration 21 completed (755.965 ms) ====== [2025-06-19T04:35:43.034Z] ====== philosophers (scala) [default], iteration 22 started ====== [2025-06-19T04:35:43.034Z] GC before operation: completed in 53.411 ms, heap usage 34.397 MB -> 4.823 MB. [2025-06-19T04:35:43.680Z] Camera thread performed 122 scans. [2025-06-19T04:35:43.680Z] ====== philosophers (scala) [default], iteration 22 completed (848.680 ms) ====== [2025-06-19T04:35:43.680Z] ====== philosophers (scala) [default], iteration 23 started ====== [2025-06-19T04:35:43.680Z] GC before operation: completed in 72.140 ms, heap usage 19.949 MB -> 4.824 MB. [2025-06-19T04:35:44.348Z] Camera thread performed 122 scans. [2025-06-19T04:35:44.348Z] ====== philosophers (scala) [default], iteration 23 completed (678.951 ms) ====== [2025-06-19T04:35:44.348Z] ====== philosophers (scala) [default], iteration 24 started ====== [2025-06-19T04:35:44.348Z] GC before operation: completed in 43.971 ms, heap usage 56.949 MB -> 4.824 MB. [2025-06-19T04:35:45.686Z] Camera thread performed 122 scans. [2025-06-19T04:35:45.686Z] ====== philosophers (scala) [default], iteration 24 completed (761.996 ms) ====== [2025-06-19T04:35:45.686Z] ====== philosophers (scala) [default], iteration 25 started ====== [2025-06-19T04:35:45.686Z] GC before operation: completed in 45.670 ms, heap usage 9.462 MB -> 4.825 MB. [2025-06-19T04:35:46.329Z] Camera thread performed 122 scans. [2025-06-19T04:35:46.330Z] ====== philosophers (scala) [default], iteration 25 completed (898.997 ms) ====== [2025-06-19T04:35:46.330Z] ====== philosophers (scala) [default], iteration 26 started ====== [2025-06-19T04:35:46.330Z] GC before operation: completed in 60.979 ms, heap usage 48.946 MB -> 4.825 MB. [2025-06-19T04:35:46.995Z] Camera thread performed 122 scans. [2025-06-19T04:35:46.995Z] ====== philosophers (scala) [default], iteration 26 completed (754.994 ms) ====== [2025-06-19T04:35:46.995Z] ====== philosophers (scala) [default], iteration 27 started ====== [2025-06-19T04:35:46.995Z] GC before operation: completed in 51.095 ms, heap usage 54.951 MB -> 4.825 MB. [2025-06-19T04:35:47.650Z] Camera thread performed 122 scans. [2025-06-19T04:35:47.650Z] ====== philosophers (scala) [default], iteration 27 completed (831.320 ms) ====== [2025-06-19T04:35:47.650Z] ====== philosophers (scala) [default], iteration 28 started ====== [2025-06-19T04:35:48.284Z] GC before operation: completed in 39.663 ms, heap usage 16.923 MB -> 4.848 MB. [2025-06-19T04:35:48.943Z] Camera thread performed 122 scans. [2025-06-19T04:35:48.943Z] ====== philosophers (scala) [default], iteration 28 completed (781.569 ms) ====== [2025-06-19T04:35:48.943Z] ====== philosophers (scala) [default], iteration 29 started ====== [2025-06-19T04:35:48.943Z] GC before operation: completed in 48.303 ms, heap usage 56.443 MB -> 4.826 MB. [2025-06-19T04:35:49.602Z] Camera thread performed 122 scans. [2025-06-19T04:35:49.602Z] ====== philosophers (scala) [default], iteration 29 completed (755.659 ms) ====== [2025-06-19T04:35:49.602Z] ----------------------------------- [2025-06-19T04:35:49.602Z] renaissance-philosophers_0_PASSED [2025-06-19T04:35:49.602Z] ----------------------------------- [2025-06-19T04:35:49.602Z] [2025-06-19T04:35:49.602Z] TEST TEARDOWN: [2025-06-19T04:35:49.602Z] Nothing to be done for teardown. [2025-06-19T04:35:49.602Z] renaissance-philosophers_0 Finish Time: Thu Jun 19 04:35:49 2025 Epoch Time (ms): 1750307749474