[2025-01-10T13:21:26.985Z] Running test renaissance-dec-tree_0 ... [2025-01-10T13:21:26.985Z] =============================================== [2025-01-10T13:21:26.985Z] renaissance-dec-tree_0 Start Time: Fri Jan 10 13:21:26 2025 Epoch Time (ms): 1736515286242 [2025-01-10T13:21:26.985Z] variation: NoOptions [2025-01-10T13:21:26.985Z] JVM_OPTIONS: [2025-01-10T13:21:26.985Z] { \ [2025-01-10T13:21:26.985Z] echo ""; echo "TEST SETUP:"; \ [2025-01-10T13:21:26.985Z] echo "Nothing to be done for setup."; \ [2025-01-10T13:21:26.985Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17365142991953/renaissance-dec-tree_0"; \ [2025-01-10T13:21:26.985Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17365142991953/renaissance-dec-tree_0"; \ [2025-01-10T13:21:26.985Z] echo ""; echo "TESTING:"; \ [2025-01-10T13:21:26.985Z] "/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_17365142991953/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-01-10T13:21:26.985Z] 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_17365142991953/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-01-10T13:21:26.985Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-01-10T13:21:26.985Z] echo "Nothing to be done for teardown."; \ [2025-01-10T13:21:26.985Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17365142991953/TestTargetResult"; [2025-01-10T13:21:26.985Z] [2025-01-10T13:21:26.985Z] TEST SETUP: [2025-01-10T13:21:26.985Z] Nothing to be done for setup. [2025-01-10T13:21:26.985Z] [2025-01-10T13:21:26.985Z] TESTING: [2025-01-10T13:21:33.422Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-01-10T13:21:36.606Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-01-10T13:21:38.071Z] WARNING: An illegal reflective access operation has occurred [2025-01-10T13:21:38.071Z] 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_17365142991953/renaissance-dec-tree_0/harness-132128-4399965881331325525/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-01-10T13:21:38.071Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-01-10T13:21:38.071Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-01-10T13:21:38.071Z] WARNING: All illegal access operations will be denied in a future release [2025-01-10T13:21:42.386Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-01-10T13:21:42.386Z] GC before operation: completed in 144.601 ms, heap usage 38.251 MB -> 33.719 MB. [2025-01-10T13:22:00.701Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (18067.636 ms) ====== [2025-01-10T13:22:00.701Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-01-10T13:22:00.701Z] GC before operation: completed in 330.724 ms, heap usage 182.819 MB -> 62.595 MB. [2025-01-10T13:22:07.048Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (6226.785 ms) ====== [2025-01-10T13:22:07.048Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-01-10T13:22:07.048Z] GC before operation: completed in 284.433 ms, heap usage 112.434 MB -> 62.635 MB. [2025-01-10T13:22:11.049Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (4349.337 ms) ====== [2025-01-10T13:22:11.049Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-01-10T13:22:11.751Z] GC before operation: completed in 166.561 ms, heap usage 178.189 MB -> 63.165 MB. [2025-01-10T13:22:15.791Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (4020.171 ms) ====== [2025-01-10T13:22:15.791Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-01-10T13:22:15.791Z] GC before operation: completed in 359.905 ms, heap usage 109.889 MB -> 63.263 MB. [2025-01-10T13:22:19.932Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (4046.594 ms) ====== [2025-01-10T13:22:19.932Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-01-10T13:22:19.932Z] GC before operation: completed in 222.113 ms, heap usage 163.779 MB -> 63.318 MB. [2025-01-10T13:22:25.082Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (4303.573 ms) ====== [2025-01-10T13:22:25.082Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-01-10T13:22:25.082Z] GC before operation: completed in 331.689 ms, heap usage 103.963 MB -> 63.490 MB. [2025-01-10T13:22:29.176Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (3971.177 ms) ====== [2025-01-10T13:22:29.176Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-01-10T13:22:29.176Z] GC before operation: completed in 363.883 ms, heap usage 259.202 MB -> 64.108 MB. [2025-01-10T13:22:33.244Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (4190.451 ms) ====== [2025-01-10T13:22:33.244Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-01-10T13:22:33.244Z] GC before operation: completed in 217.310 ms, heap usage 245.119 MB -> 64.289 MB. [2025-01-10T13:22:38.461Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (4960.088 ms) ====== [2025-01-10T13:22:38.461Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-01-10T13:22:39.151Z] GC before operation: completed in 312.912 ms, heap usage 201.590 MB -> 64.246 MB. [2025-01-10T13:22:44.553Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (5045.198 ms) ====== [2025-01-10T13:22:44.553Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-01-10T13:22:44.553Z] GC before operation: completed in 316.908 ms, heap usage 104.094 MB -> 64.063 MB. [2025-01-10T13:22:48.771Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (4462.528 ms) ====== [2025-01-10T13:22:48.771Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-01-10T13:22:48.771Z] GC before operation: completed in 240.828 ms, heap usage 265.746 MB -> 64.446 MB. [2025-01-10T13:22:54.029Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (4820.961 ms) ====== [2025-01-10T13:22:54.029Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-01-10T13:22:54.029Z] GC before operation: completed in 450.141 ms, heap usage 126.582 MB -> 64.680 MB. [2025-01-10T13:22:58.124Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (3720.241 ms) ====== [2025-01-10T13:22:58.124Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-01-10T13:22:58.124Z] GC before operation: completed in 422.953 ms, heap usage 272.968 MB -> 64.796 MB. [2025-01-10T13:23:02.523Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (3870.478 ms) ====== [2025-01-10T13:23:02.523Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-01-10T13:23:03.227Z] GC before operation: completed in 1019.897 ms, heap usage 219.964 MB -> 64.750 MB. [2025-01-10T13:23:07.527Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (4384.427 ms) ====== [2025-01-10T13:23:07.527Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-01-10T13:23:07.527Z] GC before operation: completed in 270.153 ms, heap usage 215.329 MB -> 64.996 MB. [2025-01-10T13:23:12.109Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (4030.316 ms) ====== [2025-01-10T13:23:12.109Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-01-10T13:23:12.109Z] GC before operation: completed in 319.046 ms, heap usage 98.519 MB -> 64.739 MB. [2025-01-10T13:23:16.252Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (3497.176 ms) ====== [2025-01-10T13:23:16.252Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-01-10T13:23:16.252Z] GC before operation: completed in 260.525 ms, heap usage 118.335 MB -> 64.978 MB. [2025-01-10T13:23:19.276Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (3252.120 ms) ====== [2025-01-10T13:23:19.276Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-01-10T13:23:19.276Z] GC before operation: completed in 262.396 ms, heap usage 209.087 MB -> 65.371 MB. [2025-01-10T13:23:23.462Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (4008.395 ms) ====== [2025-01-10T13:23:23.462Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-01-10T13:23:24.193Z] GC before operation: completed in 642.405 ms, heap usage 209.316 MB -> 92.928 MB. [2025-01-10T13:23:28.310Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (3580.392 ms) ====== [2025-01-10T13:23:28.310Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-01-10T13:23:28.310Z] GC before operation: completed in 244.834 ms, heap usage 195.996 MB -> 65.820 MB. [2025-01-10T13:23:31.497Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (3403.445 ms) ====== [2025-01-10T13:23:31.497Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-01-10T13:23:31.497Z] GC before operation: completed in 326.390 ms, heap usage 243.506 MB -> 93.130 MB. [2025-01-10T13:23:35.598Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (3831.284 ms) ====== [2025-01-10T13:23:35.598Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-01-10T13:23:36.313Z] GC before operation: completed in 467.543 ms, heap usage 259.637 MB -> 93.222 MB. [2025-01-10T13:23:40.369Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (4026.155 ms) ====== [2025-01-10T13:23:40.369Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-01-10T13:23:40.369Z] GC before operation: completed in 393.428 ms, heap usage 188.146 MB -> 65.449 MB. [2025-01-10T13:23:44.633Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (3875.352 ms) ====== [2025-01-10T13:23:44.633Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-01-10T13:23:44.633Z] GC before operation: completed in 213.400 ms, heap usage 137.157 MB -> 65.795 MB. [2025-01-10T13:23:47.833Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2920.538 ms) ====== [2025-01-10T13:23:47.833Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-01-10T13:23:47.833Z] GC before operation: completed in 282.968 ms, heap usage 237.841 MB -> 85.357 MB. [2025-01-10T13:23:51.045Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (3502.712 ms) ====== [2025-01-10T13:23:51.045Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-01-10T13:23:51.722Z] GC before operation: completed in 276.266 ms, heap usage 282.414 MB -> 66.007 MB. [2025-01-10T13:23:54.937Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (3406.939 ms) ====== [2025-01-10T13:23:54.937Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-01-10T13:23:55.695Z] GC before operation: completed in 474.004 ms, heap usage 129.574 MB -> 65.806 MB. [2025-01-10T13:23:58.824Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (3440.028 ms) ====== [2025-01-10T13:23:58.824Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-01-10T13:23:59.508Z] GC before operation: completed in 378.119 ms, heap usage 172.200 MB -> 66.583 MB. [2025-01-10T13:24:02.663Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (3081.495 ms) ====== [2025-01-10T13:24:02.663Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-01-10T13:24:02.663Z] GC before operation: completed in 284.411 ms, heap usage 212.755 MB -> 66.430 MB. [2025-01-10T13:24:05.719Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (3273.758 ms) ====== [2025-01-10T13:24:05.719Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-01-10T13:24:06.421Z] GC before operation: completed in 306.780 ms, heap usage 224.749 MB -> 66.374 MB. [2025-01-10T13:24:09.544Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (3410.887 ms) ====== [2025-01-10T13:24:09.544Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-01-10T13:24:10.249Z] GC before operation: completed in 376.421 ms, heap usage 170.382 MB -> 74.768 MB. [2025-01-10T13:24:13.390Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (3529.003 ms) ====== [2025-01-10T13:24:13.390Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-01-10T13:24:14.089Z] GC before operation: completed in 332.345 ms, heap usage 121.078 MB -> 66.304 MB. [2025-01-10T13:24:17.300Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (3782.305 ms) ====== [2025-01-10T13:24:17.301Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-01-10T13:24:17.996Z] GC before operation: completed in 343.572 ms, heap usage 109.301 MB -> 66.818 MB. [2025-01-10T13:24:21.180Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (3406.831 ms) ====== [2025-01-10T13:24:21.180Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-01-10T13:24:21.925Z] GC before operation: completed in 284.404 ms, heap usage 191.145 MB -> 66.765 MB. [2025-01-10T13:24:26.102Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (3985.821 ms) ====== [2025-01-10T13:24:26.102Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-01-10T13:24:26.102Z] GC before operation: completed in 261.028 ms, heap usage 137.636 MB -> 66.989 MB. [2025-01-10T13:24:29.240Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (3544.727 ms) ====== [2025-01-10T13:24:29.240Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-01-10T13:24:29.996Z] GC before operation: completed in 411.134 ms, heap usage 160.687 MB -> 66.822 MB. [2025-01-10T13:24:34.184Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (3761.090 ms) ====== [2025-01-10T13:24:34.184Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-01-10T13:24:34.184Z] GC before operation: completed in 409.626 ms, heap usage 100.114 MB -> 66.757 MB. [2025-01-10T13:24:38.493Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (4345.731 ms) ====== [2025-01-10T13:24:38.493Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-01-10T13:24:39.287Z] GC before operation: completed in 726.076 ms, heap usage 165.395 MB -> 66.858 MB. [2025-01-10T13:24:43.420Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (3980.969 ms) ====== [2025-01-10T13:24:43.420Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-01-10T13:24:43.420Z] GC before operation: completed in 341.892 ms, heap usage 141.383 MB -> 67.357 MB. [2025-01-10T13:24:47.554Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (4138.755 ms) ====== [2025-01-10T13:24:48.243Z] ----------------------------------- [2025-01-10T13:24:48.243Z] renaissance-dec-tree_0_PASSED [2025-01-10T13:24:48.243Z] ----------------------------------- [2025-01-10T13:24:48.243Z] [2025-01-10T13:24:48.243Z] TEST TEARDOWN: [2025-01-10T13:24:48.243Z] Nothing to be done for teardown. [2025-01-10T13:24:48.243Z] renaissance-dec-tree_0 Finish Time: Fri Jan 10 13:24:47 2025 Epoch Time (ms): 1736515487759