[2024-06-27T04:30:28.397Z] Running test renaissance-dec-tree_0 ... [2024-06-27T04:30:28.397Z] =============================================== [2024-06-27T04:30:28.397Z] renaissance-dec-tree_0 Start Time: Thu Jun 27 04:30:27 2024 Epoch Time (ms): 1719462627686 [2024-06-27T04:30:28.397Z] variation: NoOptions [2024-06-27T04:30:28.397Z] JVM_OPTIONS: [2024-06-27T04:30:28.397Z] { \ [2024-06-27T04:30:28.397Z] echo ""; echo "TEST SETUP:"; \ [2024-06-27T04:30:28.397Z] echo "Nothing to be done for setup."; \ [2024-06-27T04:30:28.397Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17194621789584/renaissance-dec-tree_0"; \ [2024-06-27T04:30:28.397Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17194621789584/renaissance-dec-tree_0"; \ [2024-06-27T04:30:28.397Z] echo ""; echo "TESTING:"; \ [2024-06-27T04:30:28.397Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/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_ppc64_aix_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17194621789584/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-06-27T04:30:28.397Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17194621789584/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-06-27T04:30:28.397Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-06-27T04:30:28.397Z] echo "Nothing to be done for teardown."; \ [2024-06-27T04:30:28.397Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17194621789584/TestTargetResult"; [2024-06-27T04:30:28.397Z] [2024-06-27T04:30:28.397Z] TEST SETUP: [2024-06-27T04:30:28.397Z] Nothing to be done for setup. [2024-06-27T04:30:28.397Z] [2024-06-27T04:30:28.397Z] TESTING: [2024-06-27T04:30:32.814Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-06-27T04:30:35.263Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 24) threads. [2024-06-27T04:30:36.833Z] WARNING: An illegal reflective access operation has occurred [2024-06-27T04:30:36.833Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/output_17194621789584/renaissance-dec-tree_0/harness-043028-5076649016514756331/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-06-27T04:30:36.833Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-06-27T04:30:36.833Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-06-27T04:30:36.833Z] WARNING: All illegal access operations will be denied in a future release [2024-06-27T04:30:40.226Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-06-27T04:30:40.226Z] GC before operation: completed in 96.988 ms, heap usage 199.838 MB -> 35.199 MB. [2024-06-27T04:30:50.030Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (9403.520 ms) ====== [2024-06-27T04:30:50.030Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-06-27T04:30:50.030Z] GC before operation: completed in 86.597 ms, heap usage 147.594 MB -> 66.930 MB. [2024-06-27T04:30:52.469Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2481.683 ms) ====== [2024-06-27T04:30:52.469Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-06-27T04:30:52.469Z] GC before operation: completed in 83.363 ms, heap usage 170.909 MB -> 67.110 MB. [2024-06-27T04:30:54.039Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2140.170 ms) ====== [2024-06-27T04:30:54.039Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-06-27T04:30:54.039Z] GC before operation: completed in 104.483 ms, heap usage 102.963 MB -> 67.457 MB. [2024-06-27T04:30:56.552Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2081.045 ms) ====== [2024-06-27T04:30:56.552Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-06-27T04:30:56.552Z] GC before operation: completed in 100.807 ms, heap usage 266.967 MB -> 95.498 MB. [2024-06-27T04:30:59.012Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2042.567 ms) ====== [2024-06-27T04:30:59.012Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-06-27T04:30:59.012Z] GC before operation: completed in 120.544 ms, heap usage 143.223 MB -> 67.928 MB. [2024-06-27T04:31:00.592Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1971.548 ms) ====== [2024-06-27T04:31:00.592Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-06-27T04:31:00.592Z] GC before operation: completed in 111.438 ms, heap usage 135.828 MB -> 68.191 MB. [2024-06-27T04:31:03.042Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1922.692 ms) ====== [2024-06-27T04:31:03.042Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-06-27T04:31:03.042Z] GC before operation: completed in 112.680 ms, heap usage 133.898 MB -> 68.399 MB. [2024-06-27T04:31:04.611Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1882.364 ms) ====== [2024-06-27T04:31:04.611Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-06-27T04:31:04.611Z] GC before operation: completed in 125.665 ms, heap usage 107.664 MB -> 68.224 MB. [2024-06-27T04:31:07.056Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1892.850 ms) ====== [2024-06-27T04:31:07.056Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-06-27T04:31:07.056Z] GC before operation: completed in 122.082 ms, heap usage 189.283 MB -> 68.897 MB. [2024-06-27T04:31:08.630Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1885.446 ms) ====== [2024-06-27T04:31:08.630Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-06-27T04:31:08.630Z] GC before operation: completed in 120.957 ms, heap usage 249.912 MB -> 69.261 MB. [2024-06-27T04:31:11.092Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1826.032 ms) ====== [2024-06-27T04:31:11.092Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-06-27T04:31:11.092Z] GC before operation: completed in 123.476 ms, heap usage 368.492 MB -> 80.086 MB. [2024-06-27T04:31:12.663Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1808.694 ms) ====== [2024-06-27T04:31:12.663Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-06-27T04:31:12.663Z] GC before operation: completed in 112.904 ms, heap usage 312.052 MB -> 69.250 MB. [2024-06-27T04:31:14.245Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1835.896 ms) ====== [2024-06-27T04:31:14.245Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-06-27T04:31:15.007Z] GC before operation: completed in 111.393 ms, heap usage 105.559 MB -> 69.067 MB. [2024-06-27T04:31:16.639Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1833.541 ms) ====== [2024-06-27T04:31:16.639Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-06-27T04:31:16.639Z] GC before operation: completed in 125.094 ms, heap usage 132.974 MB -> 69.192 MB. [2024-06-27T04:31:18.211Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1815.642 ms) ====== [2024-06-27T04:31:18.211Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-06-27T04:31:18.970Z] GC before operation: completed in 139.475 ms, heap usage 187.147 MB -> 69.573 MB. [2024-06-27T04:31:20.542Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1795.460 ms) ====== [2024-06-27T04:31:20.543Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-06-27T04:31:20.543Z] GC before operation: completed in 138.489 ms, heap usage 167.121 MB -> 69.473 MB. [2024-06-27T04:31:22.122Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1752.779 ms) ====== [2024-06-27T04:31:22.122Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-06-27T04:31:22.122Z] GC before operation: completed in 127.411 ms, heap usage 261.664 MB -> 69.698 MB. [2024-06-27T04:31:24.571Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1801.782 ms) ====== [2024-06-27T04:31:24.571Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-06-27T04:31:24.571Z] GC before operation: completed in 127.704 ms, heap usage 133.507 MB -> 69.516 MB. [2024-06-27T04:31:26.142Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1789.721 ms) ====== [2024-06-27T04:31:26.142Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-06-27T04:31:26.142Z] GC before operation: completed in 128.800 ms, heap usage 228.487 MB -> 70.077 MB. [2024-06-27T04:31:27.715Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1754.408 ms) ====== [2024-06-27T04:31:27.715Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-06-27T04:31:28.476Z] GC before operation: completed in 162.243 ms, heap usage 174.127 MB -> 69.718 MB. [2024-06-27T04:31:30.052Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1741.425 ms) ====== [2024-06-27T04:31:30.052Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-06-27T04:31:30.052Z] GC before operation: completed in 158.536 ms, heap usage 136.643 MB -> 69.800 MB. [2024-06-27T04:31:31.631Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1741.367 ms) ====== [2024-06-27T04:31:31.631Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-06-27T04:31:31.631Z] GC before operation: completed in 139.467 ms, heap usage 149.615 MB -> 70.187 MB. [2024-06-27T04:31:34.097Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1815.783 ms) ====== [2024-06-27T04:31:34.097Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-06-27T04:31:34.097Z] GC before operation: completed in 148.083 ms, heap usage 262.784 MB -> 70.317 MB. [2024-06-27T04:31:35.681Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1751.193 ms) ====== [2024-06-27T04:31:35.681Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-06-27T04:31:35.681Z] GC before operation: completed in 141.576 ms, heap usage 102.329 MB -> 69.847 MB. [2024-06-27T04:31:37.251Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1717.038 ms) ====== [2024-06-27T04:31:37.251Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-06-27T04:31:38.011Z] GC before operation: completed in 137.880 ms, heap usage 275.720 MB -> 70.863 MB. [2024-06-27T04:31:39.581Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1766.123 ms) ====== [2024-06-27T04:31:39.581Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-06-27T04:31:39.581Z] GC before operation: completed in 139.646 ms, heap usage 261.234 MB -> 70.744 MB. [2024-06-27T04:31:41.158Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1824.348 ms) ====== [2024-06-27T04:31:41.159Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-06-27T04:31:41.921Z] GC before operation: completed in 138.983 ms, heap usage 280.449 MB -> 71.097 MB. [2024-06-27T04:31:43.505Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1765.601 ms) ====== [2024-06-27T04:31:43.505Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-06-27T04:31:43.505Z] GC before operation: completed in 164.261 ms, heap usage 272.425 MB -> 76.357 MB. [2024-06-27T04:31:45.086Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1697.468 ms) ====== [2024-06-27T04:31:45.086Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-06-27T04:31:45.086Z] GC before operation: completed in 160.364 ms, heap usage 267.528 MB -> 71.246 MB. [2024-06-27T04:31:47.527Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1732.848 ms) ====== [2024-06-27T04:31:47.527Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-06-27T04:31:47.527Z] GC before operation: completed in 142.899 ms, heap usage 130.813 MB -> 81.767 MB. [2024-06-27T04:31:49.109Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1707.619 ms) ====== [2024-06-27T04:31:49.109Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-06-27T04:31:49.109Z] GC before operation: completed in 138.714 ms, heap usage 121.566 MB -> 70.698 MB. [2024-06-27T04:31:50.680Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1698.134 ms) ====== [2024-06-27T04:31:50.680Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-06-27T04:31:50.680Z] GC before operation: completed in 169.641 ms, heap usage 145.584 MB -> 71.031 MB. [2024-06-27T04:31:53.131Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1704.187 ms) ====== [2024-06-27T04:31:53.132Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-06-27T04:31:53.132Z] GC before operation: completed in 148.064 ms, heap usage 192.529 MB -> 71.437 MB. [2024-06-27T04:31:54.703Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1699.348 ms) ====== [2024-06-27T04:31:54.703Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-06-27T04:31:54.703Z] GC before operation: completed in 153.116 ms, heap usage 149.742 MB -> 71.286 MB. [2024-06-27T04:31:56.275Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1724.300 ms) ====== [2024-06-27T04:31:56.275Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-06-27T04:31:56.275Z] GC before operation: completed in 138.579 ms, heap usage 115.497 MB -> 71.064 MB. [2024-06-27T04:31:57.849Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1695.217 ms) ====== [2024-06-27T04:31:57.849Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-06-27T04:31:58.610Z] GC before operation: completed in 150.342 ms, heap usage 234.953 MB -> 82.629 MB. [2024-06-27T04:32:00.181Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1728.085 ms) ====== [2024-06-27T04:32:00.181Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-06-27T04:32:00.181Z] GC before operation: completed in 152.183 ms, heap usage 291.103 MB -> 71.866 MB. [2024-06-27T04:32:01.754Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1723.407 ms) ====== [2024-06-27T04:32:01.754Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-06-27T04:32:02.521Z] GC before operation: completed in 173.320 ms, heap usage 256.649 MB -> 77.592 MB. [2024-06-27T04:32:04.101Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1698.334 ms) ====== [2024-06-27T04:32:04.101Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-06-27T04:32:04.101Z] GC before operation: completed in 152.038 ms, heap usage 137.028 MB -> 71.875 MB. [2024-06-27T04:32:05.671Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1699.600 ms) ====== [2024-06-27T04:32:05.671Z] ----------------------------------- [2024-06-27T04:32:05.671Z] renaissance-dec-tree_0_PASSED [2024-06-27T04:32:05.671Z] ----------------------------------- [2024-06-27T04:32:05.671Z] [2024-06-27T04:32:05.671Z] TEST TEARDOWN: [2024-06-27T04:32:05.671Z] Nothing to be done for teardown. [2024-06-27T04:32:05.671Z] renaissance-dec-tree_0 Finish Time: Thu Jun 27 04:32:05 2024 Epoch Time (ms): 1719462725572