[2024-11-14T00:28:10.329Z] Running test renaissance-dec-tree_0 ... [2024-11-14T00:28:10.329Z] =============================================== [2024-11-14T00:28:10.329Z] renaissance-dec-tree_0 Start Time: Thu Nov 14 00:28:10 2024 Epoch Time (ms): 1731544090067 [2024-11-14T00:28:10.329Z] variation: NoOptions [2024-11-14T00:28:10.329Z] JVM_OPTIONS: [2024-11-14T00:28:10.329Z] { \ [2024-11-14T00:28:10.329Z] echo ""; echo "TEST SETUP:"; \ [2024-11-14T00:28:10.329Z] echo "Nothing to be done for setup."; \ [2024-11-14T00:28:10.329Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17315435913636/renaissance-dec-tree_0"; \ [2024-11-14T00:28:10.329Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17315435913636/renaissance-dec-tree_0"; \ [2024-11-14T00:28:10.329Z] echo ""; echo "TESTING:"; \ [2024-11-14T00:28:10.329Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_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_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17315435913636/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-11-14T00:28:10.329Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17315435913636/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-14T00:28:10.329Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-14T00:28:10.329Z] echo "Nothing to be done for teardown."; \ [2024-11-14T00:28:10.329Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17315435913636/TestTargetResult"; [2024-11-14T00:28:10.329Z] [2024-11-14T00:28:10.329Z] TEST SETUP: [2024-11-14T00:28:10.329Z] Nothing to be done for setup. [2024-11-14T00:28:10.329Z] [2024-11-14T00:28:10.329Z] TESTING: [2024-11-14T00:28:14.417Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-14T00:28:16.342Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-11-14T00:28:17.278Z] WARNING: An illegal reflective access operation has occurred [2024-11-14T00:28:17.278Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/output_17315435913636/renaissance-dec-tree_0/harness-002810-9689925245250845580/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-11-14T00:28:17.278Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-11-14T00:28:17.278Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-11-14T00:28:17.278Z] WARNING: All illegal access operations will be denied in a future release [2024-11-14T00:28:19.212Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-11-14T00:28:19.212Z] GC before operation: completed in 59.195 ms, heap usage 61.607 MB -> 33.772 MB. [2024-11-14T00:28:27.264Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (8074.853 ms) ====== [2024-11-14T00:28:27.264Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-11-14T00:28:28.199Z] GC before operation: completed in 120.104 ms, heap usage 310.394 MB -> 63.647 MB. [2024-11-14T00:28:30.121Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2283.634 ms) ====== [2024-11-14T00:28:30.121Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-11-14T00:28:30.121Z] GC before operation: completed in 102.013 ms, heap usage 262.875 MB -> 63.955 MB. [2024-11-14T00:28:32.044Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1947.524 ms) ====== [2024-11-14T00:28:32.044Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-11-14T00:28:32.044Z] GC before operation: completed in 93.289 ms, heap usage 191.716 MB -> 64.616 MB. [2024-11-14T00:28:34.652Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1891.173 ms) ====== [2024-11-14T00:28:34.652Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-11-14T00:28:34.652Z] GC before operation: completed in 89.926 ms, heap usage 110.408 MB -> 63.922 MB. [2024-11-14T00:28:35.606Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1836.727 ms) ====== [2024-11-14T00:28:35.606Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-11-14T00:28:36.541Z] GC before operation: completed in 101.273 ms, heap usage 255.168 MB -> 65.110 MB. [2024-11-14T00:28:37.481Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1741.876 ms) ====== [2024-11-14T00:28:37.481Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-11-14T00:28:38.417Z] GC before operation: completed in 96.630 ms, heap usage 143.003 MB -> 64.630 MB. [2024-11-14T00:28:39.354Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1678.753 ms) ====== [2024-11-14T00:28:39.354Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-11-14T00:28:39.354Z] GC before operation: completed in 96.767 ms, heap usage 247.481 MB -> 76.014 MB. [2024-11-14T00:28:41.278Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1656.767 ms) ====== [2024-11-14T00:28:41.278Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-11-14T00:28:41.278Z] GC before operation: completed in 106.711 ms, heap usage 157.162 MB -> 64.953 MB. [2024-11-14T00:28:43.205Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1663.567 ms) ====== [2024-11-14T00:28:43.205Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-11-14T00:28:43.205Z] GC before operation: completed in 101.154 ms, heap usage 215.680 MB -> 76.646 MB. [2024-11-14T00:28:45.133Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1655.849 ms) ====== [2024-11-14T00:28:45.133Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-11-14T00:28:45.133Z] GC before operation: completed in 105.674 ms, heap usage 216.919 MB -> 65.442 MB. [2024-11-14T00:28:47.062Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1625.657 ms) ====== [2024-11-14T00:28:47.062Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-11-14T00:28:47.062Z] GC before operation: completed in 107.384 ms, heap usage 159.189 MB -> 65.291 MB. [2024-11-14T00:28:48.004Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1623.115 ms) ====== [2024-11-14T00:28:48.004Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-11-14T00:28:48.947Z] GC before operation: completed in 123.500 ms, heap usage 246.975 MB -> 65.812 MB. [2024-11-14T00:28:49.886Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1654.464 ms) ====== [2024-11-14T00:28:49.886Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-11-14T00:28:49.886Z] GC before operation: completed in 110.080 ms, heap usage 232.241 MB -> 65.774 MB. [2024-11-14T00:28:51.807Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1584.109 ms) ====== [2024-11-14T00:28:51.807Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-11-14T00:28:51.807Z] GC before operation: completed in 110.731 ms, heap usage 103.485 MB -> 65.603 MB. [2024-11-14T00:28:53.734Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1647.333 ms) ====== [2024-11-14T00:28:53.734Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-11-14T00:28:53.734Z] GC before operation: completed in 112.394 ms, heap usage 256.227 MB -> 65.999 MB. [2024-11-14T00:28:55.664Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1586.136 ms) ====== [2024-11-14T00:28:55.664Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-11-14T00:28:55.664Z] GC before operation: completed in 109.167 ms, heap usage 232.834 MB -> 66.166 MB. [2024-11-14T00:28:56.600Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1550.580 ms) ====== [2024-11-14T00:28:56.600Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-11-14T00:28:57.535Z] GC before operation: completed in 109.016 ms, heap usage 249.441 MB -> 66.267 MB. [2024-11-14T00:28:58.473Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1593.030 ms) ====== [2024-11-14T00:28:58.473Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-11-14T00:28:58.473Z] GC before operation: completed in 108.921 ms, heap usage 228.600 MB -> 66.512 MB. [2024-11-14T00:29:00.444Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1559.702 ms) ====== [2024-11-14T00:29:00.444Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-11-14T00:29:00.444Z] GC before operation: completed in 113.524 ms, heap usage 185.730 MB -> 82.780 MB. [2024-11-14T00:29:02.367Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1600.516 ms) ====== [2024-11-14T00:29:02.367Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-11-14T00:29:02.367Z] GC before operation: completed in 114.367 ms, heap usage 249.742 MB -> 77.679 MB. [2024-11-14T00:29:03.303Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1543.087 ms) ====== [2024-11-14T00:29:03.303Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-11-14T00:29:04.238Z] GC before operation: completed in 123.108 ms, heap usage 230.788 MB -> 67.097 MB. [2024-11-14T00:29:05.174Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1539.940 ms) ====== [2024-11-14T00:29:05.174Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-11-14T00:29:05.174Z] GC before operation: completed in 115.780 ms, heap usage 235.705 MB -> 66.781 MB. [2024-11-14T00:29:07.098Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1560.754 ms) ====== [2024-11-14T00:29:07.098Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-11-14T00:29:07.098Z] GC before operation: completed in 114.650 ms, heap usage 216.760 MB -> 66.881 MB. [2024-11-14T00:29:09.021Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1547.590 ms) ====== [2024-11-14T00:29:09.021Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-11-14T00:29:09.021Z] GC before operation: completed in 116.329 ms, heap usage 163.665 MB -> 66.860 MB. [2024-11-14T00:29:10.949Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1560.841 ms) ====== [2024-11-14T00:29:10.949Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-11-14T00:29:10.949Z] GC before operation: completed in 116.744 ms, heap usage 164.806 MB -> 78.118 MB. [2024-11-14T00:29:11.887Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1518.262 ms) ====== [2024-11-14T00:29:11.887Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-11-14T00:29:11.887Z] GC before operation: completed in 116.613 ms, heap usage 249.271 MB -> 67.330 MB. [2024-11-14T00:29:13.810Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1594.591 ms) ====== [2024-11-14T00:29:13.810Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-11-14T00:29:13.810Z] GC before operation: completed in 115.623 ms, heap usage 226.873 MB -> 78.192 MB. [2024-11-14T00:29:15.735Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1639.727 ms) ====== [2024-11-14T00:29:15.735Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-11-14T00:29:15.735Z] GC before operation: completed in 123.284 ms, heap usage 238.030 MB -> 73.190 MB. [2024-11-14T00:29:17.659Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1544.339 ms) ====== [2024-11-14T00:29:17.659Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-11-14T00:29:17.659Z] GC before operation: completed in 115.710 ms, heap usage 256.718 MB -> 67.629 MB. [2024-11-14T00:29:18.596Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1539.222 ms) ====== [2024-11-14T00:29:18.596Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-11-14T00:29:18.596Z] GC before operation: completed in 113.142 ms, heap usage 240.094 MB -> 67.723 MB. [2024-11-14T00:29:20.521Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1548.541 ms) ====== [2024-11-14T00:29:20.521Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-11-14T00:29:20.521Z] GC before operation: completed in 126.703 ms, heap usage 250.105 MB -> 78.967 MB. [2024-11-14T00:29:22.451Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1583.995 ms) ====== [2024-11-14T00:29:22.451Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-11-14T00:29:22.451Z] GC before operation: completed in 114.433 ms, heap usage 202.091 MB -> 67.918 MB. [2024-11-14T00:29:24.377Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1532.412 ms) ====== [2024-11-14T00:29:24.377Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-11-14T00:29:24.377Z] GC before operation: completed in 116.287 ms, heap usage 164.516 MB -> 78.762 MB. [2024-11-14T00:29:25.316Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1519.992 ms) ====== [2024-11-14T00:29:25.316Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-11-14T00:29:25.316Z] GC before operation: completed in 116.737 ms, heap usage 261.057 MB -> 73.548 MB. [2024-11-14T00:29:27.903Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1572.347 ms) ====== [2024-11-14T00:29:27.903Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-11-14T00:29:27.903Z] GC before operation: completed in 119.847 ms, heap usage 122.902 MB -> 67.493 MB. [2024-11-14T00:29:28.847Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1531.858 ms) ====== [2024-11-14T00:29:28.847Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-11-14T00:29:28.847Z] GC before operation: completed in 115.232 ms, heap usage 135.706 MB -> 67.860 MB. [2024-11-14T00:29:30.777Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1502.663 ms) ====== [2024-11-14T00:29:30.777Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-11-14T00:29:30.777Z] GC before operation: completed in 119.783 ms, heap usage 249.768 MB -> 68.396 MB. [2024-11-14T00:29:31.714Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1519.769 ms) ====== [2024-11-14T00:29:31.714Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-11-14T00:29:32.651Z] GC before operation: completed in 121.391 ms, heap usage 111.608 MB -> 73.659 MB. [2024-11-14T00:29:33.588Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1515.223 ms) ====== [2024-11-14T00:29:33.588Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-11-14T00:29:33.588Z] GC before operation: completed in 123.630 ms, heap usage 174.002 MB -> 90.364 MB. [2024-11-14T00:29:35.526Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1490.001 ms) ====== [2024-11-14T00:29:35.526Z] ----------------------------------- [2024-11-14T00:29:35.526Z] renaissance-dec-tree_0_PASSED [2024-11-14T00:29:35.526Z] ----------------------------------- [2024-11-14T00:29:35.526Z] [2024-11-14T00:29:35.526Z] TEST TEARDOWN: [2024-11-14T00:29:35.526Z] Nothing to be done for teardown. [2024-11-14T00:29:35.526Z] renaissance-dec-tree_0 Finish Time: Thu Nov 14 00:29:35 2024 Epoch Time (ms): 1731544175090