[2026-04-25T15:41:33.507Z] Running test dacapo-h2_0 ... [2026-04-25T15:41:33.507Z] =============================================== [2026-04-25T15:41:33.507Z] dacapo-h2_0 Start Time: Sat Apr 25 15:41:31 2026 Epoch Time (ms): 1777131691325 [2026-04-25T15:41:33.507Z] variation: NoOptions [2026-04-25T15:41:33.507Z] JVM_OPTIONS: [2026-04-25T15:41:33.507Z] { \ [2026-04-25T15:41:33.507Z] echo ""; echo "TEST SETUP:"; \ [2026-04-25T15:41:33.507Z] echo "Nothing to be done for setup."; \ [2026-04-25T15:41:33.507Z] mkdir -p "/ssd/jenkins/workspace/Test_openjdk11_hs_sanity.perf_arm_linux_rerun/aqa-tests/TKG/../TKG/output_17771315868092/dacapo-h2_0"; \ [2026-04-25T15:41:33.507Z] cd "/ssd/jenkins/workspace/Test_openjdk11_hs_sanity.perf_arm_linux_rerun/aqa-tests/TKG/../TKG/output_17771315868092/dacapo-h2_0"; \ [2026-04-25T15:41:33.507Z] echo ""; echo "TESTING:"; \ [2026-04-25T15:41:33.507Z] "/ssd/jenkins/workspace/Test_openjdk11_hs_sanity.perf_arm_linux_rerun/jdkbinary/j2sdk-image/bin/java" -jar "/ssd/jenkins/workspace/Test_openjdk11_hs_sanity.perf_arm_linux_rerun/aqa-tests/TKG/../../jvmtest/perf/dacapo/dacapo.jar" h2; \ [2026-04-25T15:41:33.507Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "dacapo-h2_0""_PASSED"; echo "-----------------------------------"; cd /ssd/jenkins/workspace/Test_openjdk11_hs_sanity.perf_arm_linux_rerun/aqa-tests/TKG/..; rm -f -r "/ssd/jenkins/workspace/Test_openjdk11_hs_sanity.perf_arm_linux_rerun/aqa-tests/TKG/../TKG/output_17771315868092/dacapo-h2_0"; else echo "-----------------------------------"; echo "dacapo-h2_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-25T15:41:33.507Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-25T15:41:33.507Z] echo "Nothing to be done for teardown."; \ [2026-04-25T15:41:33.507Z] } 2>&1 | tee -a "/ssd/jenkins/workspace/Test_openjdk11_hs_sanity.perf_arm_linux_rerun/aqa-tests/TKG/../TKG/output_17771315868092/TestTargetResult"; [2026-04-25T15:41:33.507Z] [2026-04-25T15:41:33.507Z] TEST SETUP: [2026-04-25T15:41:33.507Z] Nothing to be done for setup. [2026-04-25T15:41:33.507Z] [2026-04-25T15:41:33.507Z] TESTING: [2026-04-25T15:41:33.507Z] Using scaled threading model. 8 processors detected, 8 threads used to drive the workload, in a possible range of [1,1024] [2026-04-25T15:41:33.507Z] Version: h2 2.2.220 derby 10.15.2.0 (use -p to print nominal benchmark stats) [2026-04-25T15:41:33.507Z] Preparing the H2 database... [2026-04-25T15:41:33.507Z] TPCC configuration: scale: 16, terminals: 8, transactions: 100000 [2026-04-25T15:44:30.014Z] ===== DaCapo 23.11-MR2-chopin-minimal h2 starting ===== [2026-04-25T15:44:30.014Z] Starting 100000 requests... [2026-04-25T15:44:31.443Z] [2026-04-25T15:44:38.236Z] 5% [2026-04-25T15:44:44.992Z] 10% [2026-04-25T15:44:53.204Z] 15% [2026-04-25T15:44:58.747Z] 20% [2026-04-25T15:45:07.106Z] 25% [2026-04-25T15:45:12.712Z] 30% [2026-04-25T15:45:20.941Z] 35% [2026-04-25T15:45:26.473Z] 40% [2026-04-25T15:45:34.712Z] 45% [2026-04-25T15:45:42.921Z] 50% [2026-04-25T15:45:51.086Z] 55% [2026-04-25T15:45:59.252Z] 60% [2026-04-25T15:46:11.585Z] 65% [2026-04-25T15:46:28.821Z] 70% [2026-04-25T15:47:18.930Z] 75% [2026-04-25T15:49:14.682Z] 80% [2026-04-25T15:51:25.572Z] 85% [2026-04-25T15:54:37.192Z] 90% [2026-04-25T15:59:19.908Z] 95% [2026-04-25T15:59:19.908Z] 100% [2026-04-25T15:59:19.908Z] Completed requests [2026-04-25T15:59:19.908Z] Stock level ............. 3973 ( 4.0%) [2026-04-25T15:59:19.908Z] Order status by name .... 2361 ( 2.4%) [2026-04-25T15:59:19.908Z] Order status by ID ...... 1609 ( 1.6%) [2026-04-25T15:59:19.908Z] Payment by name ......... 25847 (25.8%) [2026-04-25T15:59:19.908Z] Payment by ID ........... 17220 (17.2%) [2026-04-25T15:59:19.908Z] Delivery schedule ....... 4029 ( 4.0%) [2026-04-25T15:59:19.908Z] New order ............... 44509 (44.5%) [2026-04-25T15:59:19.908Z] New order rollback ...... 452 ( 0.5%) [2026-04-25T15:59:19.908Z] ===== DaCapo 23.11-MR2-chopin-minimal h2 PASSED in 893930 msec ===== [2026-04-25T15:59:19.909Z] ===== DaCapo processed 100000 requests in 893854 msec, 111 requests per second ===== [2026-04-25T15:59:19.909Z] ===== DaCapo tail latency, simple: 50% 3735 usec, 90% 26542 usec, 99% 2949578 usec, 99.9% 3269132 usec, 99.99% 3301769 usec, max 5995036 usec, measured over 100000 events ===== [2026-04-25T15:59:19.909Z] ===== DaCapo tail latency, metered 100ms smoothing: 50% 6717 usec, 90% 31817 usec, 99% 2949578 usec, 99.9% 3269132 usec, 99.99% 3301769 usec, max 5995036 usec, measured over 100000 events ===== [2026-04-25T15:59:19.909Z] ===== DaCapo tail latency, metered full smoothing: 50% 4325 usec, 90% 51085 usec, 99% 3598237 usec, 99.9% 3777790 usec, 99.99% 3820404 usec, max 5995036 usec, measured over 100000 events ===== [2026-04-25T16:02:26.358Z] Resetting database to initial state.....java.lang.reflect.InvocationTargetException [2026-04-25T16:02:26.358Z] java.lang.reflect.InvocationTargetException [2026-04-25T16:02:26.358Z] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [2026-04-25T16:02:26.358Z] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [2026-04-25T16:02:26.358Z] at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [2026-04-25T16:02:26.358Z] at java.base/java.lang.reflect.Method.invoke(Method.java:566) [2026-04-25T16:02:26.358Z] at org.dacapo.harness.H2.postIteration(H2.java:115) [2026-04-25T16:02:26.358Z] at org.dacapo.harness.Benchmark.run(Benchmark.java:274) [2026-04-25T16:02:26.358Z] at org.dacapo.harness.TestHarness.runBenchmark(TestHarness.java:225) [2026-04-25T16:02:26.358Z] at org.dacapo.harness.TestHarness.main(TestHarness.java:170) [2026-04-25T16:02:26.358Z] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [2026-04-25T16:02:26.358Z] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [2026-04-25T16:02:26.358Z] at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [2026-04-25T16:02:26.358Z] at java.base/java.lang.reflect.Method.invoke(Method.java:566) [2026-04-25T16:02:26.358Z] at Harness.main(Harness.java:39) [2026-04-25T16:02:26.358Z] Caused by: org.h2.jdbc.JdbcSQLNonTransientConnectionException: Out of memory.; SQL statement: [2026-04-25T16:02:26.358Z] DELETE FROM ORDERLINE WHERE OL_INITIAL = FALSE [90108-220] [2026-04-25T16:02:26.358Z] at org.h2.message.DbException.getJdbcSQLException(DbException.java:690) [2026-04-25T16:02:26.358Z] at org.h2.message.DbException.getJdbcSQLException(DbException.java:489) [2026-04-25T16:02:26.358Z] at org.h2.message.DbException.get(DbException.java:212) [2026-04-25T16:02:26.358Z] at org.h2.message.DbException.convert(DbException.java:401) [2026-04-25T16:02:26.358Z] at org.h2.command.Command.executeUpdate(Command.java:262) [2026-04-25T16:02:26.358Z] at org.h2.jdbc.JdbcPreparedStatement.execute(JdbcPreparedStatement.java:254) [2026-04-25T16:02:26.358Z] at org.dacapo.h2.TPCC.resetToInitialData(Unknown Source) [2026-04-25T16:02:26.358Z] at org.dacapo.h2.TPCC.postIteration(Unknown Source) [2026-04-25T16:02:26.358Z] ... 13 more [2026-04-25T16:02:26.358Z] Caused by: java.lang.OutOfMemoryError: Java heap space [2026-04-25T16:02:26.358Z] at org.h2.mvstore.tx.TxDecisionMaker.logAndDecideToPut(TxDecisionMaker.java:158) [2026-04-25T16:02:26.358Z] at org.h2.mvstore.tx.TxDecisionMaker$RepeatableReadLockDecisionMaker.logAndDecideToPut(TxDecisionMaker.java:380) [2026-04-25T16:02:26.358Z] at org.h2.mvstore.tx.TxDecisionMaker.decide(TxDecisionMaker.java:80) [2026-04-25T16:02:26.358Z] at org.h2.mvstore.tx.TxDecisionMaker$LockDecisionMaker.decide(TxDecisionMaker.java:346) [2026-04-25T16:02:26.358Z] at org.h2.mvstore.tx.TxDecisionMaker$LockDecisionMaker.decide(TxDecisionMaker.java:338) [2026-04-25T16:02:26.358Z] at org.h2.mvstore.MVMap$DecisionMaker.decide(MVMap.java:1701) [2026-04-25T16:02:26.358Z] at org.h2.mvstore.MVMap.operate(MVMap.java:1775) [2026-04-25T16:02:26.358Z] at org.h2.mvstore.tx.TransactionMap.set(TransactionMap.java:363) [2026-04-25T16:02:26.358Z] at org.h2.mvstore.tx.TransactionMap.lock(TransactionMap.java:329) [2026-04-25T16:02:26.358Z] at org.h2.mvstore.db.MVPrimaryIndex.lockRow(MVPrimaryIndex.java:225) [2026-04-25T16:02:26.358Z] at org.h2.mvstore.db.MVPrimaryIndex.lockRow(MVPrimaryIndex.java:220) [2026-04-25T16:02:26.358Z] at org.h2.mvstore.db.MVTable.lockRow(MVTable.java:555) [2026-04-25T16:02:26.358Z] at org.h2.command.dml.Delete.update(Delete.java:61) [2026-04-25T16:02:26.358Z] at org.h2.command.dml.DataChangeStatement.update(DataChangeStatement.java:74) [2026-04-25T16:02:26.358Z] at org.h2.command.CommandContainer.update(CommandContainer.java:169) [2026-04-25T16:02:26.358Z] at org.h2.command.Command.executeUpdate(Command.java:252) [2026-04-25T16:02:26.358Z] ... 16 more [2026-04-25T16:02:26.358Z] ----------------------------------- [2026-04-25T16:02:26.358Z] dacapo-h2_0_FAILED [2026-04-25T16:02:26.358Z] ----------------------------------- [2026-04-25T16:02:26.358Z] [2026-04-25T16:02:26.358Z] TEST TEARDOWN: [2026-04-25T16:02:26.358Z] Nothing to be done for teardown. [2026-04-25T16:02:26.358Z] dacapo-h2_0 Finish Time: Sat Apr 25 16:02:14 2026 Epoch Time (ms): 1777132934411