[2024-11-23T10:34:14.919Z] Running test renaissance-dec-tree_0 ... [2024-11-23T10:34:14.919Z] =============================================== [2024-11-23T10:34:14.919Z] renaissance-dec-tree_0 Start Time: Sat Nov 23 10:34:14 2024 Epoch Time (ms): 1732358054317 [2024-11-23T10:34:14.919Z] variation: NoOptions [2024-11-23T10:34:14.919Z] JVM_OPTIONS: [2024-11-23T10:34:14.919Z] { \ [2024-11-23T10:34:14.919Z] echo ""; echo "TEST SETUP:"; \ [2024-11-23T10:34:14.919Z] echo "Nothing to be done for setup."; \ [2024-11-23T10:34:14.919Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17323572807194/renaissance-dec-tree_0"; \ [2024-11-23T10:34:14.919Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17323572807194/renaissance-dec-tree_0"; \ [2024-11-23T10:34:14.919Z] echo ""; echo "TESTING:"; \ [2024-11-23T10:34:14.919Z] "/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_17323572807194/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-11-23T10:34:14.919Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_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_17323572807194/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-23T10:34:14.919Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-23T10:34:14.919Z] echo "Nothing to be done for teardown."; \ [2024-11-23T10:34:14.919Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17323572807194/TestTargetResult"; [2024-11-23T10:34:14.919Z] [2024-11-23T10:34:14.919Z] TEST SETUP: [2024-11-23T10:34:14.919Z] Nothing to be done for setup. [2024-11-23T10:34:14.919Z] [2024-11-23T10:34:14.919Z] TESTING: [2024-11-23T10:34:19.873Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-23T10:34:21.231Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2024-11-23T10:34:22.647Z] WARNING: An illegal reflective access operation has occurred [2024-11-23T10:34:22.647Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/output_17323572807194/renaissance-dec-tree_0/harness-103415-9042941731231889559/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-11-23T10:34:22.647Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-11-23T10:34:22.647Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-11-23T10:34:22.647Z] WARNING: All illegal access operations will be denied in a future release [2024-11-23T10:34:24.819Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-11-23T10:34:25.465Z] GC before operation: completed in 152.906 ms, heap usage 69.003 MB -> 33.722 MB. [2024-11-23T10:34:40.777Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (14295.472 ms) ====== [2024-11-23T10:34:40.777Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-11-23T10:34:40.777Z] GC before operation: completed in 356.110 ms, heap usage 173.187 MB -> 62.840 MB. [2024-11-23T10:34:45.882Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (5366.049 ms) ====== [2024-11-23T10:34:45.882Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-11-23T10:34:45.882Z] GC before operation: completed in 173.925 ms, heap usage 214.363 MB -> 62.950 MB. [2024-11-23T10:34:49.844Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (4072.732 ms) ====== [2024-11-23T10:34:49.844Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-11-23T10:34:49.844Z] GC before operation: completed in 458.911 ms, heap usage 181.317 MB -> 90.768 MB. [2024-11-23T10:34:53.838Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (3717.623 ms) ====== [2024-11-23T10:34:53.838Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-11-23T10:34:53.838Z] GC before operation: completed in 291.186 ms, heap usage 164.541 MB -> 63.757 MB. [2024-11-23T10:34:57.732Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (3490.150 ms) ====== [2024-11-23T10:34:57.732Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-11-23T10:34:57.733Z] GC before operation: completed in 262.512 ms, heap usage 267.432 MB -> 63.953 MB. [2024-11-23T10:35:01.680Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (3458.990 ms) ====== [2024-11-23T10:35:01.680Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-11-23T10:35:01.680Z] GC before operation: completed in 250.660 ms, heap usage 259.457 MB -> 91.377 MB. [2024-11-23T10:35:04.683Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (3552.672 ms) ====== [2024-11-23T10:35:04.683Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-11-23T10:35:05.379Z] GC before operation: completed in 282.700 ms, heap usage 206.898 MB -> 64.109 MB. [2024-11-23T10:35:08.375Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (3054.909 ms) ====== [2024-11-23T10:35:08.375Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-11-23T10:35:08.375Z] GC before operation: completed in 197.083 ms, heap usage 139.964 MB -> 64.141 MB. [2024-11-23T10:35:11.425Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (3224.679 ms) ====== [2024-11-23T10:35:11.425Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-11-23T10:35:12.114Z] GC before operation: completed in 276.599 ms, heap usage 178.129 MB -> 64.610 MB. [2024-11-23T10:35:15.136Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2941.237 ms) ====== [2024-11-23T10:35:15.136Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-11-23T10:35:15.136Z] GC before operation: completed in 178.306 ms, heap usage 196.402 MB -> 64.347 MB. [2024-11-23T10:35:18.145Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2855.315 ms) ====== [2024-11-23T10:35:18.145Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-11-23T10:35:18.145Z] GC before operation: completed in 273.888 ms, heap usage 209.992 MB -> 64.854 MB. [2024-11-23T10:35:21.179Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (3052.782 ms) ====== [2024-11-23T10:35:21.179Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-11-23T10:35:21.830Z] GC before operation: completed in 216.230 ms, heap usage 221.777 MB -> 64.570 MB. [2024-11-23T10:35:25.035Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (3024.221 ms) ====== [2024-11-23T10:35:25.035Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-11-23T10:35:25.035Z] GC before operation: completed in 432.956 ms, heap usage 155.949 MB -> 64.676 MB. [2024-11-23T10:35:28.025Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2544.955 ms) ====== [2024-11-23T10:35:28.025Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-11-23T10:35:28.025Z] GC before operation: completed in 234.803 ms, heap usage 201.336 MB -> 64.913 MB. [2024-11-23T10:35:31.029Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (3100.360 ms) ====== [2024-11-23T10:35:31.029Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-11-23T10:35:31.029Z] GC before operation: completed in 310.020 ms, heap usage 184.835 MB -> 64.873 MB. [2024-11-23T10:35:33.997Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (3016.817 ms) ====== [2024-11-23T10:35:33.997Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-11-23T10:35:34.694Z] GC before operation: completed in 341.942 ms, heap usage 265.725 MB -> 92.637 MB. [2024-11-23T10:35:37.117Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2693.814 ms) ====== [2024-11-23T10:35:37.117Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-11-23T10:35:37.804Z] GC before operation: completed in 295.956 ms, heap usage 338.848 MB -> 92.737 MB. [2024-11-23T10:35:40.151Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2816.251 ms) ====== [2024-11-23T10:35:40.151Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-11-23T10:35:40.814Z] GC before operation: completed in 271.737 ms, heap usage 163.254 MB -> 65.098 MB. [2024-11-23T10:35:43.797Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2745.398 ms) ====== [2024-11-23T10:35:43.797Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-11-23T10:35:43.797Z] GC before operation: completed in 305.711 ms, heap usage 214.576 MB -> 65.487 MB. [2024-11-23T10:35:46.794Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2758.376 ms) ====== [2024-11-23T10:35:46.794Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-11-23T10:35:46.794Z] GC before operation: completed in 1.173 ms, heap usage 106.794 MB -> 106.794 MB. [2024-11-23T10:35:48.981Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2452.993 ms) ====== [2024-11-23T10:35:48.981Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-11-23T10:35:48.981Z] GC before operation: completed in 307.814 ms, heap usage 198.928 MB -> 66.229 MB. [2024-11-23T10:35:51.996Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2397.220 ms) ====== [2024-11-23T10:35:51.996Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-11-23T10:35:51.996Z] GC before operation: completed in 225.867 ms, heap usage 302.573 MB -> 65.774 MB. [2024-11-23T10:35:55.019Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2969.130 ms) ====== [2024-11-23T10:35:55.019Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-11-23T10:35:55.019Z] GC before operation: completed in 253.918 ms, heap usage 263.375 MB -> 65.717 MB. [2024-11-23T10:35:57.993Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (3099.569 ms) ====== [2024-11-23T10:35:57.993Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-11-23T10:35:58.636Z] GC before operation: completed in 254.001 ms, heap usage 218.916 MB -> 65.953 MB. [2024-11-23T10:36:00.832Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2485.576 ms) ====== [2024-11-23T10:36:00.832Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-11-23T10:36:01.504Z] GC before operation: completed in 272.271 ms, heap usage 230.756 MB -> 93.507 MB. [2024-11-23T10:36:04.649Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (3461.933 ms) ====== [2024-11-23T10:36:04.649Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-11-23T10:36:05.398Z] GC before operation: completed in 757.628 ms, heap usage 217.978 MB -> 66.146 MB. [2024-11-23T10:36:08.477Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (3079.828 ms) ====== [2024-11-23T10:36:08.477Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-11-23T10:36:09.169Z] GC before operation: completed in 366.211 ms, heap usage 275.163 MB -> 66.244 MB. [2024-11-23T10:36:12.227Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (3077.261 ms) ====== [2024-11-23T10:36:12.227Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-11-23T10:36:12.227Z] GC before operation: completed in 305.330 ms, heap usage 196.420 MB -> 66.333 MB. [2024-11-23T10:36:15.312Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (3271.976 ms) ====== [2024-11-23T10:36:15.312Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-11-23T10:36:16.026Z] GC before operation: completed in 497.022 ms, heap usage 232.998 MB -> 66.689 MB. [2024-11-23T10:36:19.117Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (3001.717 ms) ====== [2024-11-23T10:36:19.117Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-11-23T10:36:19.117Z] GC before operation: completed in 308.807 ms, heap usage 103.514 MB -> 66.235 MB. [2024-11-23T10:36:22.206Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (2713.296 ms) ====== [2024-11-23T10:36:22.206Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-11-23T10:36:22.206Z] GC before operation: completed in 187.625 ms, heap usage 172.208 MB -> 66.343 MB. [2024-11-23T10:36:24.357Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (2468.601 ms) ====== [2024-11-23T10:36:24.357Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-11-23T10:36:25.177Z] GC before operation: completed in 607.076 ms, heap usage 203.110 MB -> 94.203 MB. [2024-11-23T10:36:28.267Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (2788.783 ms) ====== [2024-11-23T10:36:28.267Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-11-23T10:36:28.267Z] GC before operation: completed in 330.008 ms, heap usage 269.554 MB -> 66.688 MB. [2024-11-23T10:36:31.283Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2792.707 ms) ====== [2024-11-23T10:36:31.283Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-11-23T10:36:31.954Z] GC before operation: completed in 426.327 ms, heap usage 126.564 MB -> 66.911 MB. [2024-11-23T10:36:34.144Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (2366.298 ms) ====== [2024-11-23T10:36:34.144Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-11-23T10:36:34.144Z] GC before operation: completed in 288.600 ms, heap usage 101.554 MB -> 66.742 MB. [2024-11-23T10:36:37.110Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2454.904 ms) ====== [2024-11-23T10:36:37.110Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-11-23T10:36:37.110Z] GC before operation: completed in 374.351 ms, heap usage 239.490 MB -> 67.111 MB. [2024-11-23T10:36:40.145Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2977.314 ms) ====== [2024-11-23T10:36:40.145Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-11-23T10:36:40.145Z] GC before operation: completed in 266.031 ms, heap usage 143.680 MB -> 94.666 MB. [2024-11-23T10:36:43.060Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2382.606 ms) ====== [2024-11-23T10:36:43.060Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-11-23T10:36:43.060Z] GC before operation: completed in 269.965 ms, heap usage 257.766 MB -> 67.168 MB. [2024-11-23T10:36:46.064Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2569.873 ms) ====== [2024-11-23T10:36:46.064Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-11-23T10:36:46.064Z] GC before operation: completed in 245.746 ms, heap usage 268.162 MB -> 67.392 MB. [2024-11-23T10:36:48.280Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (2403.888 ms) ====== [2024-11-23T10:36:48.934Z] ----------------------------------- [2024-11-23T10:36:48.934Z] renaissance-dec-tree_0_PASSED [2024-11-23T10:36:48.934Z] ----------------------------------- [2024-11-23T10:36:48.934Z] [2024-11-23T10:36:48.934Z] TEST TEARDOWN: [2024-11-23T10:36:48.934Z] Nothing to be done for teardown. [2024-11-23T10:36:48.934Z] renaissance-dec-tree_0 Finish Time: Sat Nov 23 10:36:48 2024 Epoch Time (ms): 1732358208308