[2025-09-25T02:43:07.284Z] Running test dacapo-h2_0 ... [2025-09-25T02:43:07.284Z] =============================================== [2025-09-25T02:43:07.284Z] dacapo-h2_0 Start Time: Thu Sep 25 02:43:01 2025 Epoch Time (ms): 1758768181568 [2025-09-25T02:43:07.284Z] variation: NoOptions [2025-09-25T02:43:07.284Z] JVM_OPTIONS: [2025-09-25T02:43:07.284Z] { \ [2025-09-25T02:43:07.284Z] echo ""; echo "TEST SETUP:"; \ [2025-09-25T02:43:07.284Z] echo "Nothing to be done for setup."; \ [2025-09-25T02:43:07.284Z] mkdir -p "/ssd/jenkins/workspace/Test_openjdk17_hs_sanity.perf_arm_linux_rerun/aqa-tests/TKG/../TKG/output_17587680814550/dacapo-h2_0"; \ [2025-09-25T02:43:07.284Z] cd "/ssd/jenkins/workspace/Test_openjdk17_hs_sanity.perf_arm_linux_rerun/aqa-tests/TKG/../TKG/output_17587680814550/dacapo-h2_0"; \ [2025-09-25T02:43:07.284Z] echo ""; echo "TESTING:"; \ [2025-09-25T02:43:07.284Z] "/ssd/jenkins/workspace/Test_openjdk17_hs_sanity.perf_arm_linux_rerun/jdkbinary/j2sdk-image/bin/java" -jar "/ssd/jenkins/workspace/Test_openjdk17_hs_sanity.perf_arm_linux_rerun/aqa-tests/TKG/../../jvmtest/perf/dacapo/dacapo.jar" h2; \ [2025-09-25T02:43:07.284Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "dacapo-h2_0""_PASSED"; echo "-----------------------------------"; cd /ssd/jenkins/workspace/Test_openjdk17_hs_sanity.perf_arm_linux_rerun/aqa-tests/TKG/..; rm -f -r "/ssd/jenkins/workspace/Test_openjdk17_hs_sanity.perf_arm_linux_rerun/aqa-tests/TKG/../TKG/output_17587680814550/dacapo-h2_0"; else echo "-----------------------------------"; echo "dacapo-h2_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-09-25T02:43:07.284Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-09-25T02:43:07.285Z] echo "Nothing to be done for teardown."; \ [2025-09-25T02:43:07.285Z] } 2>&1 | tee -a "/ssd/jenkins/workspace/Test_openjdk17_hs_sanity.perf_arm_linux_rerun/aqa-tests/TKG/../TKG/output_17587680814550/TestTargetResult"; [2025-09-25T02:43:07.285Z] [2025-09-25T02:43:07.285Z] TEST SETUP: [2025-09-25T02:43:07.285Z] Nothing to be done for setup. [2025-09-25T02:43:07.285Z] [2025-09-25T02:43:07.285Z] TESTING: [2025-09-25T02:43:07.285Z] Using scaled threading model. 8 processors detected, 8 threads used to drive the workload, in a possible range of [1,1024] [2025-09-25T02:43:07.285Z] Version: h2 2.2.220 derby 10.15.2.0 (use -p to print nominal benchmark stats) [2025-09-25T02:43:07.285Z] Preparing the H2 database... [2025-09-25T02:43:07.285Z] TPCC configuration: scale: 16, terminals: 8, transactions: 100000 [2025-09-25T02:45:48.455Z] ===== DaCapo 23.11-MR2-chopin-minimal h2 starting ===== [2025-09-25T02:45:48.455Z] Starting 100000 requests... [2025-09-25T02:46:00.440Z] [2025-09-25T02:46:06.031Z] 5% [2025-09-25T02:46:12.982Z] 10% [2025-09-25T02:46:23.017Z] 15% [2025-09-25T02:46:27.509Z] 20% [2025-09-25T02:46:33.043Z] 25% [2025-09-25T02:46:42.979Z] 30% [2025-09-25T02:46:48.488Z] 35% [2025-09-25T02:46:58.576Z] 40% [2025-09-25T02:47:04.122Z] 45% [2025-09-25T02:47:14.105Z] 50% [2025-09-25T02:47:24.079Z] 55% [2025-09-25T02:47:33.998Z] 60% [2025-09-25T02:47:45.969Z] 65% [2025-09-25T02:48:00.282Z] 70% [2025-09-25T02:48:20.865Z] 75% [2025-09-25T02:49:10.831Z] 80% [2025-09-25T02:51:36.933Z] 85% [2025-09-25T02:58:35.792Z] 90% [2025-09-25T03:18:44.178Z] 95% [2025-09-25T03:18:44.178Z] 100% [2025-09-25T03:18:44.178Z] Completed requests [2025-09-25T03:18:44.178Z] Stock level ............. 3973 ( 4.0%) [2025-09-25T03:18:44.178Z] Order status by name .... 2361 ( 2.4%) [2025-09-25T03:18:44.178Z] Order status by ID ...... 1609 ( 1.6%) [2025-09-25T03:18:44.178Z] Payment by name ......... 25847 (25.8%) [2025-09-25T03:18:44.178Z] Payment by ID ........... 17220 (17.2%) [2025-09-25T03:18:44.178Z] Delivery schedule ....... 4029 ( 4.0%) [2025-09-25T03:18:44.178Z] New order ............... 44509 (44.5%) [2025-09-25T03:18:44.178Z] New order rollback ...... 452 ( 0.5%) [2025-09-25T03:18:44.178Z] ===== DaCapo 23.11-MR2-chopin-minimal h2 PASSED in 1965601 msec ===== [2025-09-25T03:18:44.178Z] ===== DaCapo processed 100000 requests in 1965512 msec, 50 requests per second ===== [2025-09-25T03:18:44.178Z] ===== DaCapo tail latency, simple: 50% 4308 usec, 90% 34013 usec, 99% 3745906 usec, 99.9% 14354809 usec, 99.99% 24673386 usec, max 41770156 usec, measured over 100000 events ===== [2025-09-25T03:18:44.178Z] ===== DaCapo tail latency, metered 100ms smoothing: 50% 8044 usec, 90% 36782 usec, 99% 3745906 usec, 99.9% 14354809 usec, 99.99% 24673386 usec, max 41770156 usec, measured over 100000 events ===== [2025-09-25T03:18:44.178Z] ===== DaCapo tail latency, metered full smoothing: 50% 4784 usec, 90% 41680 usec, 99% 297755744 usec, 99.9% 401345600 usec, 99.99% 410395200 usec, max 416036960 usec, measured over 100000 events ===== [2025-09-25T03:24:15.773Z] Resetting database to initial state.....java.lang.reflect.InvocationTargetException [2025-09-25T03:24:15.773Z] java.lang.reflect.InvocationTargetException [2025-09-25T03:24:15.773Z] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [2025-09-25T03:24:15.773Z] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) [2025-09-25T03:24:15.773Z] at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [2025-09-25T03:24:15.773Z] at java.base/java.lang.reflect.Method.invoke(Method.java:569) [2025-09-25T03:24:15.773Z] at org.dacapo.harness.H2.postIteration(H2.java:115) [2025-09-25T03:24:15.773Z] at org.dacapo.harness.Benchmark.run(Benchmark.java:274) [2025-09-25T03:24:15.773Z] at org.dacapo.harness.TestHarness.runBenchmark(TestHarness.java:225) [2025-09-25T03:24:15.773Z] at org.dacapo.harness.TestHarness.main(TestHarness.java:170) [2025-09-25T03:24:15.773Z] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [2025-09-25T03:24:15.773Z] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) [2025-09-25T03:24:15.773Z] at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [2025-09-25T03:24:15.773Z] at java.base/java.lang.reflect.Method.invoke(Method.java:569) [2025-09-25T03:24:15.773Z] at Harness.main(Harness.java:39) [2025-09-25T03:24:15.773Z] Caused by: org.h2.jdbc.JdbcSQLNonTransientConnectionException: Out of memory.; SQL statement: [2025-09-25T03:24:15.773Z] DELETE FROM ORDERLINE WHERE OL_INITIAL = FALSE [90108-220] [2025-09-25T03:24:15.773Z] at org.h2.message.DbException.getJdbcSQLException(DbException.java:690) [2025-09-25T03:24:15.773Z] at org.h2.message.DbException.getJdbcSQLException(DbException.java:489) [2025-09-25T03:24:15.773Z] at org.h2.message.DbException.get(DbException.java:212) [2025-09-25T03:24:15.773Z] at org.h2.message.DbException.convert(DbException.java:401) [2025-09-25T03:24:15.773Z] at org.h2.command.Command.executeUpdate(Command.java:262) [2025-09-25T03:24:15.773Z] at org.h2.jdbc.JdbcPreparedStatement.execute(JdbcPreparedStatement.java:254) [2025-09-25T03:24:15.773Z] at org.dacapo.h2.TPCC.resetToInitialData(Unknown Source) [2025-09-25T03:24:15.773Z] at org.dacapo.h2.TPCC.postIteration(Unknown Source) [2025-09-25T03:24:15.773Z] ... 13 more [2025-09-25T03:24:15.773Z] Caused by: java.lang.OutOfMemoryError: Java heap space: failed reallocation of scalar replaced objects [2025-09-25T03:24:15.773Z] ----------------------------------- [2025-09-25T03:24:15.773Z] dacapo-h2_0_FAILED [2025-09-25T03:24:15.773Z] ----------------------------------- [2025-09-25T03:24:15.773Z] [2025-09-25T03:24:15.773Z] TEST TEARDOWN: [2025-09-25T03:24:15.773Z] Nothing to be done for teardown. [2025-09-25T03:24:15.773Z] dacapo-h2_0 Finish Time: Thu Sep 25 03:24:13 2025 Epoch Time (ms): 1758770653060