[2025-12-03T23:33:38.044Z] Running test renaissance-log-regression_0 ... [2025-12-03T23:33:38.044Z] =============================================== [2025-12-03T23:33:38.044Z] renaissance-log-regression_0 Start Time: Wed Dec 3 18:33:37 2025 Epoch Time (ms): 1764804817820 [2025-12-03T23:33:38.044Z] variation: NoOptions [2025-12-03T23:33:38.044Z] JVM_OPTIONS: [2025-12-03T23:33:38.044Z] { \ [2025-12-03T23:33:38.044Z] echo ""; echo "TEST SETUP:"; \ [2025-12-03T23:33:38.044Z] echo "Nothing to be done for setup."; \ [2025-12-03T23:33:38.044Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17648041138274/renaissance-log-regression_0"; \ [2025-12-03T23:33:38.044Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17648041138274/renaissance-log-regression_0"; \ [2025-12-03T23:33:38.044Z] echo ""; echo "TESTING:"; \ [2025-12-03T23:33:38.044Z] "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/jdkbinary/j2sdk-image/Contents/Home/bin/..//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 "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17648041138274/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-12-03T23:33:38.044Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17648041138274/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-03T23:33:38.044Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-03T23:33:38.044Z] echo "Nothing to be done for teardown."; \ [2025-12-03T23:33:38.044Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17648041138274/TestTargetResult"; [2025-12-03T23:33:38.044Z] [2025-12-03T23:33:38.044Z] TEST SETUP: [2025-12-03T23:33:38.044Z] Nothing to be done for setup. [2025-12-03T23:33:38.044Z] [2025-12-03T23:33:38.044Z] TESTING: [2025-12-03T23:33:41.133Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-12-03T23:33:41.887Z] WARNING: An illegal reflective access operation has occurred [2025-12-03T23:33:41.887Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/output_17648041138274/renaissance-log-regression_0/harness-183338-426864862235844049/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2025-12-03T23:33:41.887Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-12-03T23:33:41.887Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-12-03T23:33:41.887Z] WARNING: All illegal access operations will be denied in a future release [2025-12-03T23:33:42.237Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-12-03T23:33:42.237Z] GC before operation: completed in 19.469 ms, heap usage 90.346 MB -> 34.619 MB. [2025-12-03T23:33:47.266Z] ====== log-regression (apache-spark) [default], iteration 0 completed (5035.074 ms) ====== [2025-12-03T23:33:47.266Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-12-03T23:33:47.266Z] GC before operation: completed in 48.380 ms, heap usage 257.959 MB -> 118.509 MB. [2025-12-03T23:33:48.492Z] ====== log-regression (apache-spark) [default], iteration 1 completed (1112.612 ms) ====== [2025-12-03T23:33:48.492Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-12-03T23:33:48.492Z] GC before operation: completed in 52.139 ms, heap usage 273.144 MB -> 119.054 MB. [2025-12-03T23:33:49.752Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1102.420 ms) ====== [2025-12-03T23:33:49.752Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-12-03T23:33:49.752Z] GC before operation: completed in 39.038 ms, heap usage 265.010 MB -> 119.466 MB. [2025-12-03T23:33:50.985Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1041.588 ms) ====== [2025-12-03T23:33:50.985Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-12-03T23:33:50.985Z] GC before operation: completed in 37.875 ms, heap usage 274.774 MB -> 119.706 MB. [2025-12-03T23:33:51.734Z] ====== log-regression (apache-spark) [default], iteration 4 completed (800.694 ms) ====== [2025-12-03T23:33:51.734Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-12-03T23:33:51.734Z] GC before operation: completed in 43.852 ms, heap usage 389.951 MB -> 120.271 MB. [2025-12-03T23:33:52.507Z] ====== log-regression (apache-spark) [default], iteration 5 completed (734.646 ms) ====== [2025-12-03T23:33:52.507Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-12-03T23:33:52.507Z] GC before operation: completed in 54.250 ms, heap usage 237.715 MB -> 120.061 MB. [2025-12-03T23:33:53.815Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1101.507 ms) ====== [2025-12-03T23:33:53.815Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-12-03T23:33:53.815Z] GC before operation: completed in 62.987 ms, heap usage 299.395 MB -> 120.423 MB. [2025-12-03T23:33:54.611Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1009.139 ms) ====== [2025-12-03T23:33:54.611Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-12-03T23:33:54.611Z] GC before operation: completed in 44.840 ms, heap usage 256.250 MB -> 120.472 MB. [2025-12-03T23:33:55.844Z] ====== log-regression (apache-spark) [default], iteration 8 completed (967.207 ms) ====== [2025-12-03T23:33:55.844Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-12-03T23:33:55.844Z] GC before operation: completed in 42.391 ms, heap usage 256.599 MB -> 120.759 MB. [2025-12-03T23:33:56.204Z] ====== log-regression (apache-spark) [default], iteration 9 completed (689.060 ms) ====== [2025-12-03T23:33:56.204Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-12-03T23:33:56.572Z] GC before operation: completed in 43.497 ms, heap usage 314.999 MB -> 121.127 MB. [2025-12-03T23:33:56.938Z] ====== log-regression (apache-spark) [default], iteration 10 completed (694.419 ms) ====== [2025-12-03T23:33:56.938Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-12-03T23:33:57.289Z] GC before operation: completed in 46.973 ms, heap usage 253.330 MB -> 121.104 MB. [2025-12-03T23:33:58.052Z] ====== log-regression (apache-spark) [default], iteration 11 completed (715.960 ms) ====== [2025-12-03T23:33:58.052Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-12-03T23:33:58.052Z] GC before operation: completed in 48.790 ms, heap usage 355.034 MB -> 121.631 MB. [2025-12-03T23:33:58.818Z] ====== log-regression (apache-spark) [default], iteration 12 completed (781.093 ms) ====== [2025-12-03T23:33:58.818Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-12-03T23:33:58.818Z] GC before operation: completed in 47.275 ms, heap usage 287.295 MB -> 121.687 MB. [2025-12-03T23:33:59.575Z] ====== log-regression (apache-spark) [default], iteration 13 completed (697.304 ms) ====== [2025-12-03T23:33:59.575Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-12-03T23:33:59.575Z] GC before operation: completed in 46.699 ms, heap usage 319.815 MB -> 121.966 MB. [2025-12-03T23:34:00.356Z] ====== log-regression (apache-spark) [default], iteration 14 completed (724.126 ms) ====== [2025-12-03T23:34:00.356Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-12-03T23:34:00.356Z] GC before operation: completed in 49.445 ms, heap usage 318.920 MB -> 122.164 MB. [2025-12-03T23:34:01.202Z] ====== log-regression (apache-spark) [default], iteration 15 completed (743.575 ms) ====== [2025-12-03T23:34:01.202Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-12-03T23:34:01.202Z] GC before operation: completed in 49.439 ms, heap usage 273.722 MB -> 122.157 MB. [2025-12-03T23:34:01.570Z] ====== log-regression (apache-spark) [default], iteration 16 completed (673.113 ms) ====== [2025-12-03T23:34:01.570Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-12-03T23:34:01.932Z] GC before operation: completed in 48.229 ms, heap usage 365.368 MB -> 122.617 MB. [2025-12-03T23:34:02.715Z] ====== log-regression (apache-spark) [default], iteration 17 completed (750.178 ms) ====== [2025-12-03T23:34:02.715Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-12-03T23:34:02.715Z] GC before operation: completed in 48.928 ms, heap usage 233.166 MB -> 122.489 MB. [2025-12-03T23:34:03.518Z] ====== log-regression (apache-spark) [default], iteration 18 completed (790.990 ms) ====== [2025-12-03T23:34:03.518Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-12-03T23:34:03.518Z] GC before operation: completed in 48.443 ms, heap usage 337.911 MB -> 122.933 MB. [2025-12-03T23:34:04.276Z] ====== log-regression (apache-spark) [default], iteration 19 completed (662.709 ms) ====== [2025-12-03T23:34:04.276Z] ----------------------------------- [2025-12-03T23:34:04.276Z] renaissance-log-regression_0_PASSED [2025-12-03T23:34:04.276Z] ----------------------------------- [2025-12-03T23:34:04.276Z] [2025-12-03T23:34:04.276Z] TEST TEARDOWN: [2025-12-03T23:34:04.276Z] Nothing to be done for teardown. [2025-12-03T23:34:04.276Z] renaissance-log-regression_0 Finish Time: Wed Dec 3 18:34:04 2025 Epoch Time (ms): 1764804844009