[2024-11-08T15:01:27.548Z] Running test renaissance-dec-tree_0 ... [2024-11-08T15:01:27.548Z] =============================================== [2024-11-08T15:01:27.548Z] renaissance-dec-tree_0 Start Time: Fri Nov 8 15:01:27 2024 Epoch Time (ms): 1731078087177 [2024-11-08T15:01:27.548Z] variation: NoOptions [2024-11-08T15:01:27.548Z] JVM_OPTIONS: [2024-11-08T15:01:27.548Z] { \ [2024-11-08T15:01:27.548Z] echo ""; echo "TEST SETUP:"; \ [2024-11-08T15:01:27.548Z] echo "Nothing to be done for setup."; \ [2024-11-08T15:01:27.548Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17310776571078/renaissance-dec-tree_0"; \ [2024-11-08T15:01:27.548Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17310776571078/renaissance-dec-tree_0"; \ [2024-11-08T15:01:27.548Z] echo ""; echo "TESTING:"; \ [2024-11-08T15:01:27.548Z] "/home/jenkins/workspace/Test_openjdk17_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_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17310776571078/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-11-08T15:01:27.548Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17310776571078/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-08T15:01:27.548Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-08T15:01:27.548Z] echo "Nothing to be done for teardown."; \ [2024-11-08T15:01:27.548Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17310776571078/TestTargetResult"; [2024-11-08T15:01:27.548Z] [2024-11-08T15:01:27.548Z] TEST SETUP: [2024-11-08T15:01:27.548Z] Nothing to be done for setup. [2024-11-08T15:01:27.548Z] [2024-11-08T15:01:27.548Z] TESTING: [2024-11-08T15:01:30.516Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-08T15:01:32.440Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-11-08T15:01:35.405Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-11-08T15:01:35.405Z] GC before operation: completed in 52.500 ms, heap usage 48.099 MB -> 35.208 MB. [2024-11-08T15:01:42.010Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (6513.792 ms) ====== [2024-11-08T15:01:42.010Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-11-08T15:01:42.010Z] GC before operation: completed in 77.729 ms, heap usage 293.802 MB -> 65.595 MB. [2024-11-08T15:01:43.940Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2070.183 ms) ====== [2024-11-08T15:01:43.940Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-11-08T15:01:43.940Z] GC before operation: completed in 69.864 ms, heap usage 284.700 MB -> 77.567 MB. [2024-11-08T15:01:45.857Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1637.270 ms) ====== [2024-11-08T15:01:45.857Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-11-08T15:01:45.857Z] GC before operation: completed in 65.469 ms, heap usage 145.661 MB -> 65.180 MB. [2024-11-08T15:01:46.793Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1540.061 ms) ====== [2024-11-08T15:01:46.793Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-11-08T15:01:46.793Z] GC before operation: completed in 66.222 ms, heap usage 330.145 MB -> 65.704 MB. [2024-11-08T15:01:48.717Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1510.291 ms) ====== [2024-11-08T15:01:48.717Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-11-08T15:01:48.717Z] GC before operation: completed in 84.844 ms, heap usage 144.370 MB -> 65.627 MB. [2024-11-08T15:01:50.639Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1511.792 ms) ====== [2024-11-08T15:01:50.639Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-11-08T15:01:50.639Z] GC before operation: completed in 71.015 ms, heap usage 307.202 MB -> 66.153 MB. [2024-11-08T15:01:51.581Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1481.501 ms) ====== [2024-11-08T15:01:51.581Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-11-08T15:01:51.581Z] GC before operation: completed in 87.615 ms, heap usage 339.346 MB -> 66.397 MB. [2024-11-08T15:01:53.503Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1506.167 ms) ====== [2024-11-08T15:01:53.503Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-11-08T15:01:53.503Z] GC before operation: completed in 80.703 ms, heap usage 109.368 MB -> 65.825 MB. [2024-11-08T15:01:55.424Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1468.747 ms) ====== [2024-11-08T15:01:55.424Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-11-08T15:01:55.424Z] GC before operation: completed in 89.399 ms, heap usage 149.670 MB -> 66.280 MB. [2024-11-08T15:01:56.360Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1477.416 ms) ====== [2024-11-08T15:01:56.360Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-11-08T15:01:56.360Z] GC before operation: completed in 100.374 ms, heap usage 283.954 MB -> 72.348 MB. [2024-11-08T15:01:56.360Z] 24/11/08 15:01:56 WARN BlockManager: Asked to remove block broadcast_134, which does not exist [2024-11-08T15:01:56.360Z] 24/11/08 15:01:56 WARN BlockManager: Asked to remove block broadcast_134_piece0, which does not exist [2024-11-08T15:01:58.282Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1435.633 ms) ====== [2024-11-08T15:01:58.282Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-11-08T15:01:58.282Z] GC before operation: completed in 82.375 ms, heap usage 243.210 MB -> 67.044 MB. [2024-11-08T15:01:59.218Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1412.559 ms) ====== [2024-11-08T15:01:59.218Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-11-08T15:02:00.156Z] GC before operation: completed in 79.882 ms, heap usage 329.127 MB -> 66.960 MB. [2024-11-08T15:02:01.276Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1473.111 ms) ====== [2024-11-08T15:02:01.276Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-11-08T15:02:01.276Z] GC before operation: completed in 85.386 ms, heap usage 129.360 MB -> 66.810 MB. [2024-11-08T15:02:02.211Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1388.871 ms) ====== [2024-11-08T15:02:02.211Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-11-08T15:02:03.146Z] GC before operation: completed in 88.803 ms, heap usage 244.258 MB -> 78.354 MB. [2024-11-08T15:02:04.087Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1455.467 ms) ====== [2024-11-08T15:02:04.087Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-11-08T15:02:04.087Z] GC before operation: completed in 96.349 ms, heap usage 169.552 MB -> 72.472 MB. [2024-11-08T15:02:06.007Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1447.993 ms) ====== [2024-11-08T15:02:06.007Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-11-08T15:02:06.007Z] GC before operation: completed in 83.995 ms, heap usage 220.909 MB -> 67.492 MB. [2024-11-08T15:02:06.952Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1446.381 ms) ====== [2024-11-08T15:02:06.952Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-11-08T15:02:06.952Z] GC before operation: completed in 92.973 ms, heap usage 311.345 MB -> 67.620 MB. [2024-11-08T15:02:08.880Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1436.060 ms) ====== [2024-11-08T15:02:08.880Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-11-08T15:02:08.880Z] GC before operation: completed in 96.600 ms, heap usage 302.958 MB -> 73.401 MB. [2024-11-08T15:02:10.806Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1415.775 ms) ====== [2024-11-08T15:02:10.806Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-11-08T15:02:10.806Z] GC before operation: completed in 86.198 ms, heap usage 225.447 MB -> 73.476 MB. [2024-11-08T15:02:11.741Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1408.591 ms) ====== [2024-11-08T15:02:11.741Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-11-08T15:02:11.741Z] GC before operation: completed in 91.026 ms, heap usage 238.511 MB -> 79.057 MB. [2024-11-08T15:02:11.741Z] 24/11/08 15:02:11 WARN BlockManager: Asked to remove block broadcast_274_piece0, which does not exist [2024-11-08T15:02:11.741Z] 24/11/08 15:02:11 WARN BlockManager: Asked to remove block broadcast_274, which does not exist [2024-11-08T15:02:13.666Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1430.504 ms) ====== [2024-11-08T15:02:13.667Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-11-08T15:02:13.667Z] GC before operation: completed in 88.349 ms, heap usage 146.118 MB -> 84.124 MB. [2024-11-08T15:02:14.607Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1437.552 ms) ====== [2024-11-08T15:02:14.607Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-11-08T15:02:14.607Z] GC before operation: completed in 102.229 ms, heap usage 354.906 MB -> 84.741 MB. [2024-11-08T15:02:16.576Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1442.721 ms) ====== [2024-11-08T15:02:16.576Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-11-08T15:02:16.576Z] GC before operation: completed in 106.781 ms, heap usage 409.769 MB -> 68.172 MB. [2024-11-08T15:02:17.519Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1464.371 ms) ====== [2024-11-08T15:02:17.519Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-11-08T15:02:18.458Z] GC before operation: completed in 101.687 ms, heap usage 272.777 MB -> 73.748 MB. [2024-11-08T15:02:19.396Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1418.358 ms) ====== [2024-11-08T15:02:19.396Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-11-08T15:02:19.396Z] GC before operation: completed in 109.522 ms, heap usage 226.143 MB -> 79.346 MB. [2024-11-08T15:02:21.323Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1447.460 ms) ====== [2024-11-08T15:02:21.323Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-11-08T15:02:21.323Z] GC before operation: completed in 113.181 ms, heap usage 123.845 MB -> 84.234 MB. [2024-11-08T15:02:22.267Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1458.926 ms) ====== [2024-11-08T15:02:22.267Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-11-08T15:02:22.267Z] GC before operation: completed in 97.671 ms, heap usage 299.580 MB -> 68.535 MB. [2024-11-08T15:02:24.188Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1439.079 ms) ====== [2024-11-08T15:02:24.188Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-11-08T15:02:24.188Z] GC before operation: completed in 101.312 ms, heap usage 279.127 MB -> 85.040 MB. [2024-11-08T15:02:24.188Z] 24/11/08 15:02:23 WARN BlockManager: Asked to remove block broadcast_386_piece0, which does not exist [2024-11-08T15:02:26.113Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1402.379 ms) ====== [2024-11-08T15:02:26.113Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-11-08T15:02:26.113Z] GC before operation: completed in 108.840 ms, heap usage 398.474 MB -> 79.915 MB. [2024-11-08T15:02:26.113Z] 24/11/08 15:02:25 WARN BlockManager: Asked to remove block broadcast_400, which does not exist [2024-11-08T15:02:27.058Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1441.207 ms) ====== [2024-11-08T15:02:27.058Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-11-08T15:02:27.058Z] GC before operation: completed in 108.123 ms, heap usage 162.678 MB -> 68.486 MB. [2024-11-08T15:02:28.991Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1421.364 ms) ====== [2024-11-08T15:02:28.991Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-11-08T15:02:28.991Z] GC before operation: completed in 105.903 ms, heap usage 243.031 MB -> 79.737 MB. [2024-11-08T15:02:29.958Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1423.575 ms) ====== [2024-11-08T15:02:29.958Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-11-08T15:02:29.958Z] GC before operation: completed in 101.291 ms, heap usage 145.031 MB -> 68.670 MB. [2024-11-08T15:02:31.900Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1419.544 ms) ====== [2024-11-08T15:02:31.900Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-11-08T15:02:31.900Z] GC before operation: completed in 96.344 ms, heap usage 217.108 MB -> 69.186 MB. [2024-11-08T15:02:32.836Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1386.472 ms) ====== [2024-11-08T15:02:32.836Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-11-08T15:02:33.772Z] GC before operation: completed in 102.988 ms, heap usage 287.273 MB -> 85.923 MB. [2024-11-08T15:02:34.708Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1364.693 ms) ====== [2024-11-08T15:02:34.708Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-11-08T15:02:34.708Z] GC before operation: completed in 114.598 ms, heap usage 377.061 MB -> 69.469 MB. [2024-11-08T15:02:36.636Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1422.494 ms) ====== [2024-11-08T15:02:36.636Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-11-08T15:02:36.636Z] GC before operation: completed in 146.984 ms, heap usage 255.498 MB -> 86.230 MB. [2024-11-08T15:02:37.573Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1434.701 ms) ====== [2024-11-08T15:02:37.573Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-11-08T15:02:37.573Z] GC before operation: completed in 127.808 ms, heap usage 372.185 MB -> 69.883 MB. [2024-11-08T15:02:39.515Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1369.966 ms) ====== [2024-11-08T15:02:39.515Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-11-08T15:02:39.515Z] GC before operation: completed in 106.757 ms, heap usage 256.775 MB -> 69.557 MB. [2024-11-08T15:02:40.453Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1393.829 ms) ====== [2024-11-08T15:02:40.453Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-11-08T15:02:41.390Z] GC before operation: completed in 107.210 ms, heap usage 270.378 MB -> 69.805 MB. [2024-11-08T15:02:42.327Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1380.058 ms) ====== [2024-11-08T15:02:42.327Z] ----------------------------------- [2024-11-08T15:02:42.327Z] renaissance-dec-tree_0_PASSED [2024-11-08T15:02:42.327Z] ----------------------------------- [2024-11-08T15:02:42.327Z] [2024-11-08T15:02:42.327Z] TEST TEARDOWN: [2024-11-08T15:02:42.327Z] Nothing to be done for teardown. [2024-11-08T15:02:42.327Z] renaissance-dec-tree_0 Finish Time: Fri Nov 8 15:02:42 2024 Epoch Time (ms): 1731078162064