[2024-10-03T01:03:11.074Z] Running test renaissance-dec-tree_0 ... [2024-10-03T01:03:11.074Z] =============================================== [2024-10-03T01:03:11.074Z] renaissance-dec-tree_0 Start Time: Wed Oct 2 21:03:10 2024 Epoch Time (ms): 1727917390839 [2024-10-03T01:03:11.074Z] variation: NoOptions [2024-10-03T01:03:11.074Z] JVM_OPTIONS: [2024-10-03T01:03:11.074Z] { \ [2024-10-03T01:03:11.074Z] echo ""; echo "TEST SETUP:"; \ [2024-10-03T01:03:11.074Z] echo "Nothing to be done for setup."; \ [2024-10-03T01:03:11.074Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1727915543675/renaissance-dec-tree_0"; \ [2024-10-03T01:03:11.074Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1727915543675/renaissance-dec-tree_0"; \ [2024-10-03T01:03:11.074Z] echo ""; echo "TESTING:"; \ [2024-10-03T01:03:11.074Z] "/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_1727915543675/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-10-03T01:03:11.074Z] 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_1727915543675/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-03T01:03:11.074Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-03T01:03:11.074Z] echo "Nothing to be done for teardown."; \ [2024-10-03T01:03:11.074Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1727915543675/TestTargetResult"; [2024-10-03T01:03:11.074Z] [2024-10-03T01:03:11.074Z] TEST SETUP: [2024-10-03T01:03:11.074Z] Nothing to be done for setup. [2024-10-03T01:03:11.074Z] [2024-10-03T01:03:11.074Z] TESTING: [2024-10-03T01:03:22.496Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-10-03T01:03:26.922Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2024-10-03T01:03:29.378Z] WARNING: An illegal reflective access operation has occurred [2024-10-03T01:03:29.378Z] 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_1727915543675/renaissance-dec-tree_0/harness-210315-7807389109383732464/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-10-03T01:03:29.378Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-10-03T01:03:29.378Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-10-03T01:03:29.378Z] WARNING: All illegal access operations will be denied in a future release [2024-10-03T01:03:38.629Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-10-03T01:03:38.629Z] GC before operation: completed in 755.145 ms, heap usage 52.534 MB -> 33.748 MB. [2024-10-03T01:04:08.952Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (27715.932 ms) ====== [2024-10-03T01:04:08.952Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-10-03T01:04:08.952Z] GC before operation: completed in 638.402 ms, heap usage 107.643 MB -> 89.543 MB. [2024-10-03T01:04:14.513Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (7606.303 ms) ====== [2024-10-03T01:04:14.513Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-10-03T01:04:15.368Z] GC before operation: completed in 652.212 ms, heap usage 133.438 MB -> 63.135 MB. [2024-10-03T01:04:21.372Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (5847.337 ms) ====== [2024-10-03T01:04:21.372Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-10-03T01:04:21.372Z] GC before operation: completed in 305.030 ms, heap usage 141.545 MB -> 63.286 MB. [2024-10-03T01:04:28.287Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (6797.943 ms) ====== [2024-10-03T01:04:28.287Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-10-03T01:04:28.287Z] GC before operation: completed in 667.594 ms, heap usage 165.838 MB -> 63.525 MB. [2024-10-03T01:04:35.341Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (6370.275 ms) ====== [2024-10-03T01:04:35.341Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-10-03T01:04:35.341Z] GC before operation: completed in 280.910 ms, heap usage 269.070 MB -> 63.628 MB. [2024-10-03T01:04:42.315Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (6013.292 ms) ====== [2024-10-03T01:04:42.315Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-10-03T01:04:42.315Z] GC before operation: completed in 214.951 ms, heap usage 122.376 MB -> 63.749 MB. [2024-10-03T01:04:48.724Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (6187.146 ms) ====== [2024-10-03T01:04:48.724Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-10-03T01:04:48.724Z] GC before operation: completed in 843.951 ms, heap usage 245.858 MB -> 63.994 MB. [2024-10-03T01:04:54.320Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (5534.459 ms) ====== [2024-10-03T01:04:54.320Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-10-03T01:04:54.320Z] GC before operation: completed in 561.348 ms, heap usage 189.002 MB -> 64.538 MB. [2024-10-03T01:05:01.714Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (7291.272 ms) ====== [2024-10-03T01:05:01.715Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-10-03T01:05:02.499Z] GC before operation: completed in 614.791 ms, heap usage 287.555 MB -> 64.280 MB. [2024-10-03T01:05:08.121Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (5652.435 ms) ====== [2024-10-03T01:05:08.121Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-10-03T01:05:08.926Z] GC before operation: completed in 382.706 ms, heap usage 207.750 MB -> 64.383 MB. [2024-10-03T01:05:13.922Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (4819.918 ms) ====== [2024-10-03T01:05:13.922Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-10-03T01:05:13.922Z] GC before operation: completed in 517.795 ms, heap usage 166.884 MB -> 64.362 MB. [2024-10-03T01:05:20.789Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (6689.980 ms) ====== [2024-10-03T01:05:20.789Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-10-03T01:05:21.590Z] GC before operation: completed in 686.445 ms, heap usage 193.499 MB -> 64.742 MB. [2024-10-03T01:05:26.212Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (5165.617 ms) ====== [2024-10-03T01:05:26.212Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-10-03T01:05:26.914Z] GC before operation: completed in 373.839 ms, heap usage 189.891 MB -> 64.841 MB. [2024-10-03T01:05:34.557Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (7655.731 ms) ====== [2024-10-03T01:05:34.557Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-10-03T01:05:35.491Z] GC before operation: completed in 550.410 ms, heap usage 167.771 MB -> 64.520 MB. [2024-10-03T01:05:40.109Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (5171.550 ms) ====== [2024-10-03T01:05:40.109Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-10-03T01:05:40.109Z] GC before operation: completed in 319.157 ms, heap usage 218.002 MB -> 65.300 MB. [2024-10-03T01:05:44.345Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (3662.730 ms) ====== [2024-10-03T01:05:44.345Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-10-03T01:05:44.345Z] GC before operation: completed in 449.503 ms, heap usage 198.760 MB -> 65.062 MB. [2024-10-03T01:05:48.871Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (4131.097 ms) ====== [2024-10-03T01:05:48.871Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-10-03T01:05:49.642Z] GC before operation: completed in 1013.688 ms, heap usage 252.921 MB -> 65.166 MB. [2024-10-03T01:05:58.129Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (8269.876 ms) ====== [2024-10-03T01:05:58.129Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-10-03T01:05:58.962Z] GC before operation: completed in 572.900 ms, heap usage 250.572 MB -> 65.261 MB. [2024-10-03T01:06:02.474Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (3935.963 ms) ====== [2024-10-03T01:06:02.474Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-10-03T01:06:03.487Z] GC before operation: completed in 774.105 ms, heap usage 179.565 MB -> 92.970 MB. [2024-10-03T01:06:09.557Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (5622.570 ms) ====== [2024-10-03T01:06:09.558Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-10-03T01:06:09.558Z] GC before operation: completed in 781.732 ms, heap usage 241.631 MB -> 93.057 MB. [2024-10-03T01:06:13.489Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (4012.501 ms) ====== [2024-10-03T01:06:13.489Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-10-03T01:06:14.223Z] GC before operation: completed in 562.986 ms, heap usage 127.514 MB -> 92.874 MB. [2024-10-03T01:06:18.734Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (4661.772 ms) ====== [2024-10-03T01:06:18.734Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-10-03T01:06:19.532Z] GC before operation: completed in 512.403 ms, heap usage 154.711 MB -> 65.787 MB. [2024-10-03T01:06:25.282Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (5638.027 ms) ====== [2024-10-03T01:06:25.283Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-10-03T01:06:26.136Z] GC before operation: completed in 907.771 ms, heap usage 284.731 MB -> 65.892 MB. [2024-10-03T01:06:32.067Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (5830.116 ms) ====== [2024-10-03T01:06:32.067Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-10-03T01:06:32.067Z] GC before operation: completed in 462.486 ms, heap usage 187.234 MB -> 65.850 MB. [2024-10-03T01:06:37.979Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (5481.645 ms) ====== [2024-10-03T01:06:37.979Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-10-03T01:06:38.836Z] GC before operation: completed in 766.865 ms, heap usage 269.803 MB -> 66.093 MB. [2024-10-03T01:06:46.049Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (6865.040 ms) ====== [2024-10-03T01:06:46.049Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-10-03T01:06:46.049Z] GC before operation: completed in 405.302 ms, heap usage 137.637 MB -> 66.028 MB. [2024-10-03T01:06:50.636Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (4232.061 ms) ====== [2024-10-03T01:06:50.636Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-10-03T01:06:50.636Z] GC before operation: completed in 558.619 ms, heap usage 100.330 MB -> 65.864 MB. [2024-10-03T01:06:54.926Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (3741.765 ms) ====== [2024-10-03T01:06:54.926Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-10-03T01:06:54.926Z] GC before operation: completed in 419.584 ms, heap usage 245.110 MB -> 93.841 MB. [2024-10-03T01:06:58.426Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (3767.179 ms) ====== [2024-10-03T01:06:58.426Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-10-03T01:07:00.342Z] GC before operation: completed in 732.476 ms, heap usage 269.201 MB -> 66.329 MB. [2024-10-03T01:07:08.134Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (7965.645 ms) ====== [2024-10-03T01:07:08.134Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-10-03T01:07:08.795Z] GC before operation: completed in 1241.900 ms, heap usage 105.547 MB -> 65.891 MB. [2024-10-03T01:07:13.233Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (4104.611 ms) ====== [2024-10-03T01:07:13.233Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-10-03T01:07:13.233Z] GC before operation: completed in 361.699 ms, heap usage 257.810 MB -> 66.673 MB. [2024-10-03T01:07:17.540Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (4520.037 ms) ====== [2024-10-03T01:07:17.540Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-10-03T01:07:18.386Z] GC before operation: completed in 545.942 ms, heap usage 111.121 MB -> 94.230 MB. [2024-10-03T01:07:23.725Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (5075.352 ms) ====== [2024-10-03T01:07:23.725Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-10-03T01:07:24.483Z] GC before operation: completed in 1408.375 ms, heap usage 263.584 MB -> 66.718 MB. [2024-10-03T01:07:31.990Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (6725.768 ms) ====== [2024-10-03T01:07:31.991Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-10-03T01:07:31.991Z] GC before operation: completed in 474.981 ms, heap usage 259.517 MB -> 66.813 MB. [2024-10-03T01:07:38.110Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (6158.398 ms) ====== [2024-10-03T01:07:38.110Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-10-03T01:07:39.995Z] GC before operation: completed in 1661.020 ms, heap usage 249.369 MB -> 66.913 MB. [2024-10-03T01:07:45.535Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (5893.042 ms) ====== [2024-10-03T01:07:45.535Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-10-03T01:07:45.535Z] GC before operation: completed in 310.573 ms, heap usage 203.756 MB -> 67.142 MB. [2024-10-03T01:07:51.115Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (4927.341 ms) ====== [2024-10-03T01:07:51.115Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-10-03T01:07:51.857Z] GC before operation: completed in 948.610 ms, heap usage 193.745 MB -> 67.095 MB. [2024-10-03T01:07:56.072Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (3697.877 ms) ====== [2024-10-03T01:07:56.072Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-10-03T01:07:56.072Z] GC before operation: completed in 380.103 ms, heap usage 247.804 MB -> 67.331 MB. [2024-10-03T01:08:01.953Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (5540.996 ms) ====== [2024-10-03T01:08:01.953Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-10-03T01:08:01.953Z] GC before operation: completed in 488.368 ms, heap usage 186.988 MB -> 67.645 MB. [2024-10-03T01:08:06.545Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (4153.704 ms) ====== [2024-10-03T01:08:07.373Z] ----------------------------------- [2024-10-03T01:08:07.373Z] renaissance-dec-tree_0_PASSED [2024-10-03T01:08:07.373Z] ----------------------------------- [2024-10-03T01:08:07.373Z] [2024-10-03T01:08:07.373Z] TEST TEARDOWN: [2024-10-03T01:08:07.373Z] Nothing to be done for teardown. [2024-10-03T01:08:07.373Z] renaissance-dec-tree_0 Finish Time: Wed Oct 2 21:08:06 2024 Epoch Time (ms): 1727917686922