[2024-08-10T05:13:32.036Z] Running test renaissance-dec-tree_0 ... [2024-08-10T05:13:32.036Z] =============================================== [2024-08-10T05:13:32.036Z] renaissance-dec-tree_0 Start Time: Sat Aug 10 00:13:31 2024 Epoch Time (ms): 1723266811073 [2024-08-10T05:13:32.036Z] variation: NoOptions [2024-08-10T05:13:32.036Z] JVM_OPTIONS: [2024-08-10T05:13:32.036Z] { \ [2024-08-10T05:13:32.036Z] echo ""; echo "TEST SETUP:"; \ [2024-08-10T05:13:32.036Z] echo "Nothing to be done for setup."; \ [2024-08-10T05:13:32.036Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17232663323668/renaissance-dec-tree_0"; \ [2024-08-10T05:13:32.036Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17232663323668/renaissance-dec-tree_0"; \ [2024-08-10T05:13:32.036Z] echo ""; echo "TESTING:"; \ [2024-08-10T05:13:32.036Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_0/jdkbinary/j2sdk-image/jdk-11.0.25+2/bin/..//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_x86-64_linux_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17232663323668/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-10T05:13:32.036Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17232663323668/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-10T05:13:32.036Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-10T05:13:32.036Z] echo "Nothing to be done for teardown."; \ [2024-08-10T05:13:32.036Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17232663323668/TestTargetResult"; [2024-08-10T05:13:32.036Z] [2024-08-10T05:13:32.036Z] TEST SETUP: [2024-08-10T05:13:32.036Z] Nothing to be done for setup. [2024-08-10T05:13:32.036Z] [2024-08-10T05:13:32.036Z] TESTING: [2024-08-10T05:13:34.253Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-10T05:13:36.479Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2024-08-10T05:13:37.902Z] WARNING: An illegal reflective access operation has occurred [2024-08-10T05:13:37.902Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/output_17232663323668/renaissance-dec-tree_0/harness-001331-4154101416189974039/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-08-10T05:13:37.902Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-08-10T05:13:37.902Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-08-10T05:13:37.902Z] WARNING: All illegal access operations will be denied in a future release [2024-08-10T05:13:40.124Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-10T05:13:40.124Z] GC before operation: completed in 52.297 ms, heap usage 49.883 MB -> 34.345 MB. [2024-08-10T05:13:49.516Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (8475.841 ms) ====== [2024-08-10T05:13:49.516Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-10T05:13:49.516Z] GC before operation: completed in 125.383 ms, heap usage 280.455 MB -> 64.430 MB. [2024-08-10T05:13:50.946Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2408.922 ms) ====== [2024-08-10T05:13:50.946Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-10T05:13:50.946Z] GC before operation: completed in 112.882 ms, heap usage 276.650 MB -> 75.669 MB. [2024-08-10T05:13:53.167Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1802.461 ms) ====== [2024-08-10T05:13:53.167Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-10T05:13:53.167Z] GC before operation: completed in 79.267 ms, heap usage 141.344 MB -> 75.898 MB. [2024-08-10T05:13:54.620Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1763.560 ms) ====== [2024-08-10T05:13:54.620Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-10T05:13:54.620Z] GC before operation: completed in 123.583 ms, heap usage 289.440 MB -> 81.801 MB. [2024-08-10T05:13:56.051Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1524.523 ms) ====== [2024-08-10T05:13:56.051Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-10T05:13:56.736Z] GC before operation: completed in 99.925 ms, heap usage 178.024 MB -> 65.309 MB. [2024-08-10T05:13:58.164Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1538.044 ms) ====== [2024-08-10T05:13:58.164Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-10T05:13:58.164Z] GC before operation: completed in 104.113 ms, heap usage 197.138 MB -> 76.788 MB. [2024-08-10T05:13:59.587Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1374.326 ms) ====== [2024-08-10T05:13:59.587Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-10T05:13:59.587Z] GC before operation: completed in 102.892 ms, heap usage 273.773 MB -> 82.191 MB. [2024-08-10T05:14:01.011Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1489.221 ms) ====== [2024-08-10T05:14:01.011Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-10T05:14:01.011Z] GC before operation: completed in 111.974 ms, heap usage 180.765 MB -> 76.582 MB. [2024-08-10T05:14:02.434Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1382.013 ms) ====== [2024-08-10T05:14:02.434Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-10T05:14:02.434Z] GC before operation: completed in 108.224 ms, heap usage 141.595 MB -> 87.644 MB. [2024-08-10T05:14:03.875Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1428.504 ms) ====== [2024-08-10T05:14:03.875Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-10T05:14:03.875Z] GC before operation: completed in 117.125 ms, heap usage 189.041 MB -> 65.770 MB. [2024-08-10T05:14:06.090Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1484.773 ms) ====== [2024-08-10T05:14:06.090Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-10T05:14:06.090Z] GC before operation: completed in 167.427 ms, heap usage 288.847 MB -> 93.758 MB. [2024-08-10T05:14:06.090Z] 24/08/10 00:14:05 WARN BlockManager: Asked to remove block broadcast_148, which does not exist [2024-08-10T05:14:07.517Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1502.959 ms) ====== [2024-08-10T05:14:07.517Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-10T05:14:07.517Z] GC before operation: completed in 123.410 ms, heap usage 312.123 MB -> 66.278 MB. [2024-08-10T05:14:08.941Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1523.534 ms) ====== [2024-08-10T05:14:08.941Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-10T05:14:08.941Z] GC before operation: completed in 124.839 ms, heap usage 222.258 MB -> 66.366 MB. [2024-08-10T05:14:10.365Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1475.059 ms) ====== [2024-08-10T05:14:10.365Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-10T05:14:11.053Z] GC before operation: completed in 110.948 ms, heap usage 215.814 MB -> 88.456 MB. [2024-08-10T05:14:12.489Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1446.278 ms) ====== [2024-08-10T05:14:12.489Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-10T05:14:12.489Z] GC before operation: completed in 119.650 ms, heap usage 180.300 MB -> 66.320 MB. [2024-08-10T05:14:13.913Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1416.965 ms) ====== [2024-08-10T05:14:13.913Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-10T05:14:13.913Z] GC before operation: completed in 116.431 ms, heap usage 160.469 MB -> 66.644 MB. [2024-08-10T05:14:15.333Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1276.535 ms) ====== [2024-08-10T05:14:15.333Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-10T05:14:15.333Z] GC before operation: completed in 125.461 ms, heap usage 179.579 MB -> 66.871 MB. [2024-08-10T05:14:16.755Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1349.882 ms) ====== [2024-08-10T05:14:16.755Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-10T05:14:16.755Z] GC before operation: completed in 122.728 ms, heap usage 194.900 MB -> 66.969 MB. [2024-08-10T05:14:18.176Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1378.669 ms) ====== [2024-08-10T05:14:18.176Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-10T05:14:18.176Z] GC before operation: completed in 132.055 ms, heap usage 199.893 MB -> 83.540 MB. [2024-08-10T05:14:19.597Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1324.901 ms) ====== [2024-08-10T05:14:19.597Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-10T05:14:19.597Z] GC before operation: completed in 122.109 ms, heap usage 276.941 MB -> 78.258 MB. [2024-08-10T05:14:21.019Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1309.663 ms) ====== [2024-08-10T05:14:21.019Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-10T05:14:21.019Z] GC before operation: completed in 110.377 ms, heap usage 211.461 MB -> 94.878 MB. [2024-08-10T05:14:22.438Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1240.346 ms) ====== [2024-08-10T05:14:22.438Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-10T05:14:22.438Z] GC before operation: completed in 217.173 ms, heap usage 285.357 MB -> 94.976 MB. [2024-08-10T05:14:23.868Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1511.993 ms) ====== [2024-08-10T05:14:23.868Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-10T05:14:23.868Z] GC before operation: completed in 113.909 ms, heap usage 143.405 MB -> 78.304 MB. [2024-08-10T05:14:25.292Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1248.736 ms) ====== [2024-08-10T05:14:25.292Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-10T05:14:25.292Z] GC before operation: completed in 119.994 ms, heap usage 273.363 MB -> 95.206 MB. [2024-08-10T05:14:26.713Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1178.233 ms) ====== [2024-08-10T05:14:26.713Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-10T05:14:26.713Z] GC before operation: completed in 151.353 ms, heap usage 326.374 MB -> 84.379 MB. [2024-08-10T05:14:28.142Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1335.722 ms) ====== [2024-08-10T05:14:28.142Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-10T05:14:28.142Z] GC before operation: completed in 130.592 ms, heap usage 231.436 MB -> 89.750 MB. [2024-08-10T05:14:29.592Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1527.561 ms) ====== [2024-08-10T05:14:29.592Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-10T05:14:30.280Z] GC before operation: completed in 131.402 ms, heap usage 326.204 MB -> 78.993 MB. [2024-08-10T05:14:31.706Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1466.080 ms) ====== [2024-08-10T05:14:31.706Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-10T05:14:31.706Z] GC before operation: completed in 131.699 ms, heap usage 264.215 MB -> 84.483 MB. [2024-08-10T05:14:33.129Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1489.230 ms) ====== [2024-08-10T05:14:33.129Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-10T05:14:33.129Z] GC before operation: completed in 121.279 ms, heap usage 122.226 MB -> 89.717 MB. [2024-08-10T05:14:34.548Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1259.769 ms) ====== [2024-08-10T05:14:34.548Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-10T05:14:34.548Z] GC before operation: completed in 112.220 ms, heap usage 223.097 MB -> 90.157 MB. [2024-08-10T05:14:35.980Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1276.432 ms) ====== [2024-08-10T05:14:35.980Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-10T05:14:35.980Z] GC before operation: completed in 151.945 ms, heap usage 187.151 MB -> 79.102 MB. [2024-08-10T05:14:37.412Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1379.779 ms) ====== [2024-08-10T05:14:37.412Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-10T05:14:37.412Z] GC before operation: completed in 115.893 ms, heap usage 199.696 MB -> 84.884 MB. [2024-08-10T05:14:38.851Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1399.834 ms) ====== [2024-08-10T05:14:38.851Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-10T05:14:38.851Z] GC before operation: completed in 122.467 ms, heap usage 127.748 MB -> 84.396 MB. [2024-08-10T05:14:38.851Z] 24/08/10 00:14:38 WARN BlockManager: Asked to remove block broadcast_456_piece0, which does not exist [2024-08-10T05:14:38.851Z] 24/08/10 00:14:38 WARN BlockManager: Asked to remove block rdd_1614_1, which does not exist [2024-08-10T05:14:40.289Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1326.472 ms) ====== [2024-08-10T05:14:40.289Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-10T05:14:40.289Z] GC before operation: completed in 129.079 ms, heap usage 219.177 MB -> 85.064 MB. [2024-08-10T05:14:41.710Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1459.164 ms) ====== [2024-08-10T05:14:41.710Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-10T05:14:42.397Z] GC before operation: completed in 116.038 ms, heap usage 185.429 MB -> 96.004 MB. [2024-08-10T05:14:43.095Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1323.439 ms) ====== [2024-08-10T05:14:43.095Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-10T05:14:43.781Z] GC before operation: completed in 121.011 ms, heap usage 138.329 MB -> 79.399 MB. [2024-08-10T05:14:44.466Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1198.832 ms) ====== [2024-08-10T05:14:44.466Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-10T05:14:45.153Z] GC before operation: completed in 115.751 ms, heap usage 233.388 MB -> 96.489 MB. [2024-08-10T05:14:45.153Z] 24/08/10 00:14:44 WARN BlockManager: Asked to remove block broadcast_512, which does not exist [2024-08-10T05:14:45.153Z] 24/08/10 00:14:44 WARN BlockManager: Asked to remove block broadcast_512_piece0, which does not exist [2024-08-10T05:14:45.846Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1238.546 ms) ====== [2024-08-10T05:14:45.846Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-10T05:14:46.531Z] GC before operation: completed in 140.398 ms, heap usage 286.298 MB -> 69.132 MB. [2024-08-10T05:14:47.953Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1552.230 ms) ====== [2024-08-10T05:14:47.953Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-10T05:14:47.953Z] GC before operation: completed in 119.280 ms, heap usage 255.970 MB -> 91.072 MB. [2024-08-10T05:14:49.375Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1504.862 ms) ====== [2024-08-10T05:14:50.061Z] ----------------------------------- [2024-08-10T05:14:50.061Z] renaissance-dec-tree_0_PASSED [2024-08-10T05:14:50.061Z] ----------------------------------- [2024-08-10T05:14:50.061Z] [2024-08-10T05:14:50.061Z] TEST TEARDOWN: [2024-08-10T05:14:50.061Z] Nothing to be done for teardown. [2024-08-10T05:14:50.061Z] renaissance-dec-tree_0 Finish Time: Sat Aug 10 00:14:49 2024 Epoch Time (ms): 1723266889501