signum-node icon indicating copy to clipboard operation
signum-node copied to clipboard
verified publisher icon signum-network

error in blockchain download thread

Open josergc opened this issue 1 year ago • 5 comments

I've just found this message looping all the time in a node v3.8.0 running H2

[INFO] 2024-01-29 13:49:41 brs.BlockchainProcessorImpl - Error in blockchain download thread
org.jooq.exception.DataAccessException: SQL [select (exists (select 1 "one" from "block" where "block"."id" = 7955664919908856464))]; The database has been closed [90098-224]
	at org.jooq_3.16.23.H2.debug(Unknown Source)
	at org.jooq.impl.Tools.translate(Tools.java:3130)
	at org.jooq.impl.DefaultExecuteContext.sqlException(DefaultExecuteContext.java:727)
	at org.jooq.impl.AbstractQuery.execute(AbstractQuery.java:343)
	at org.jooq.impl.AbstractResultQuery.fetchLazy(AbstractResultQuery.java:295)
	at org.jooq.impl.AbstractResultQuery.fetchLazyNonAutoClosing(AbstractResultQuery.java:316)
	at org.jooq.impl.SelectImpl.fetchLazyNonAutoClosing(SelectImpl.java:2867)
	at org.jooq.impl.ResultQueryTrait.fetchOne(ResultQueryTrait.java:506)
	at org.jooq.impl.Tools.attach(Tools.java:1376)
	at org.jooq.impl.DefaultDSLContext.fetchOne(DefaultDSLContext.java:4629)
	at org.jooq.impl.DefaultDSLContext.lambda$fetchValue$48(DefaultDSLContext.java:4649)
	at org.jooq.impl.Tools.attach(Tools.java:1376)
	at org.jooq.impl.DefaultDSLContext.fetchValue(DefaultDSLContext.java:4649)
	at org.jooq.impl.DefaultDSLContext.fetchValue(DefaultDSLContext.java:4659)
	at org.jooq.impl.DefaultDSLContext.fetchExists(DefaultDSLContext.java:4741)
	at brs.db.sql.SqlBlockDb.lambda$hasBlock$1(SqlBlockDb.java:36)
	at brs.db.sql.Db.useDSLContext(Db.java:215)
	at brs.db.sql.SqlBlockDb.hasBlock(SqlBlockDb.java:35)
	at brs.BlockchainImpl.hasBlock(BlockchainImpl.java:92)
	at brs.util.DownloadCacheImpl.hasBlock(DownloadCacheImpl.java:319)
	at brs.BlockchainProcessorImpl$1.getCommonMilestoneBlockId(BlockchainProcessorImpl.java:456)
	at brs.BlockchainProcessorImpl$1.run(BlockchainProcessorImpl.java:271)
	at brs.util.ThreadPool.lambda$start$0(ThreadPool.java:104)
	at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
	at java.base/java.util.concurrent.FutureTask.runAndReset(Unknown Source)
	at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(Unknown Source)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
	at java.base/java.lang.Thread.run(Unknown Source)
Caused by: org.h2.jdbc.JdbcSQLNonTransientConnectionException: The database has been closed [90098-224]
	at org.h2.message.DbException.getJdbcSQLException(DbException.java:690)
	at org.h2.message.DbException.getJdbcSQLException(DbException.java:489)
	at org.h2.message.DbException.get(DbException.java:212)
	at org.h2.engine.SessionLocal.getTransaction(SessionLocal.java:1610)
	at org.h2.engine.SessionLocal.startStatementWithinTransaction(SessionLocal.java:1631)
	at org.h2.command.Command.executeQuery(Command.java:186)
	at org.h2.jdbc.JdbcStatement.executeInternal(JdbcStatement.java:257)
	at org.h2.jdbc.JdbcStatement.execute(JdbcStatement.java:231)
	at com.zaxxer.hikari.pool.ProxyStatement.execute(ProxyStatement.java:94)
	at com.zaxxer.hikari.pool.HikariProxyStatement.execute(HikariProxyStatement.java)
	at org.jooq.tools.jdbc.DefaultStatement.execute(DefaultStatement.java:102)
	at org.jooq.impl.SettingsEnabledPreparedStatement.execute(SettingsEnabledPreparedStatement.java:227)
	at org.jooq.impl.Tools.executeStatementAndGetFirstResultSet(Tools.java:4408)
	at org.jooq.impl.AbstractResultQuery.execute(AbstractResultQuery.java:230)
	at org.jooq.impl.AbstractQuery.execute(AbstractQuery.java:329)
	... 25 more
Caused by: org.h2.mvstore.MVStoreException: Reading from file sun.nio.ch.FileChannelImpl@5ec4c79d failed at 6164313006 (length -1), read 0, remaining 512 [2.2.224/1]
	at org.h2.mvstore.DataUtils.newMVStoreException(DataUtils.java:996)
	at org.h2.mvstore.DataUtils.readFully(DataUtils.java:455)
	at org.h2.mvstore.FileStore.readFully(FileStore.java:719)
	at org.h2.mvstore.SingleFileStore.readFully(SingleFileStore.java:60)
	at org.h2.mvstore.SingleFileStore.readFully(SingleFileStore.java:28)
	at org.h2.mvstore.SFChunk.readFully(SFChunk.java:35)
	at org.h2.mvstore.Chunk.readBufferForPage(Chunk.java:465)
	at org.h2.mvstore.FileStore.readPage(FileStore.java:1960)
	at org.h2.mvstore.MVStore.readPage(MVStore.java:1021)
	at org.h2.mvstore.MVMap.readPage(MVMap.java:632)
	at org.h2.mvstore.MVMap.rewritePage(MVMap.java:682)
	at org.h2.mvstore.FileStore.rewriteChunks(FileStore.java:1920)
	at org.h2.mvstore.FileStore.compactRewrite(FileStore.java:1896)
	at org.h2.mvstore.FileStore.rewriteChunks(FileStore.java:1857)
	at org.h2.mvstore.RandomAccessStore.lambda$doHousekeeping$4(RandomAccessStore.java:728)
	at org.h2.mvstore.MVStore.tryExecuteUnderStoreLock(MVStore.java:937)
	at org.h2.mvstore.RandomAccessStore.doHousekeeping(RandomAccessStore.java:723)
	at org.h2.mvstore.FileStore.writeInBackground(FileStore.java:1837)
	at org.h2.mvstore.FileStore$BackgroundWriterThread.run(FileStore.java:2248)
Caused by: java.nio.channels.AsynchronousCloseException
	at java.base/java.nio.channels.spi.AbstractInterruptibleChannel.end(Unknown Source)
	at java.base/sun.nio.ch.FileChannelImpl.endBlocking(Unknown Source)
	at java.base/sun.nio.ch.FileChannelImpl.readInternal(Unknown Source)
	at java.base/sun.nio.ch.FileChannelImpl.read(Unknown Source)
	at org.h2.mvstore.DataUtils.readFully(DataUtils.java:441)
	... 17 more
[INFO] 2024-01-29 13:49:43 brs.BlockchainProcessorImpl - Error in blockchain download thread
org.jooq.exception.DataAccessException: SQL [select (exists (select 1 "one" from "block" where "block"."id" = 4435643953206244011))]; The database has been closed [90098-224]
	at org.jooq_3.16.23.H2.debug(Unknown Source)
	at org.jooq.impl.Tools.translate(Tools.java:3130)
	at org.jooq.impl.DefaultExecuteContext.sqlException(DefaultExecuteContext.java:727)
	at org.jooq.impl.AbstractQuery.execute(AbstractQuery.java:343)
	at org.jooq.impl.AbstractResultQuery.fetchLazy(AbstractResultQuery.java:295)
	at org.jooq.impl.AbstractResultQuery.fetchLazyNonAutoClosing(AbstractResultQuery.java:316)
	at org.jooq.impl.SelectImpl.fetchLazyNonAutoClosing(SelectImpl.java:2867)
	at org.jooq.impl.ResultQueryTrait.fetchOne(ResultQueryTrait.java:506)
	at org.jooq.impl.Tools.attach(Tools.java:1376)
	at org.jooq.impl.DefaultDSLContext.fetchOne(DefaultDSLContext.java:4629)
	at org.jooq.impl.DefaultDSLContext.lambda$fetchValue$48(DefaultDSLContext.java:4649)
	at org.jooq.impl.Tools.attach(Tools.java:1376)
	at org.jooq.impl.DefaultDSLContext.fetchValue(DefaultDSLContext.java:4649)
	at org.jooq.impl.DefaultDSLContext.fetchValue(DefaultDSLContext.java:4659)
	at org.jooq.impl.DefaultDSLContext.fetchExists(DefaultDSLContext.java:4741)
	at brs.db.sql.SqlBlockDb.lambda$hasBlock$1(SqlBlockDb.java:36)
	at brs.db.sql.Db.useDSLContext(Db.java:215)
	at brs.db.sql.SqlBlockDb.hasBlock(SqlBlockDb.java:35)
	at brs.BlockchainImpl.hasBlock(BlockchainImpl.java:92)
	at brs.util.DownloadCacheImpl.hasBlock(DownloadCacheImpl.java:319)
	at brs.BlockchainProcessorImpl$1.getCommonMilestoneBlockId(BlockchainProcessorImpl.java:456)
	at brs.BlockchainProcessorImpl$1.run(BlockchainProcessorImpl.java:271)
	at brs.util.ThreadPool.lambda$start$0(ThreadPool.java:104)
	at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
	at java.base/java.util.concurrent.FutureTask.runAndReset(Unknown Source)
	at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(Unknown Source)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
	at java.base/java.lang.Thread.run(Unknown Source)
Caused by: org.h2.jdbc.JdbcSQLNonTransientConnectionException: The database has been closed [90098-224]
	at org.h2.message.DbException.getJdbcSQLException(DbException.java:690)
	at org.h2.message.DbException.getJdbcSQLException(DbException.java:489)
	at org.h2.message.DbException.get(DbException.java:212)
	at org.h2.engine.SessionLocal.getTransaction(SessionLocal.java:1610)
	at org.h2.engine.SessionLocal.startStatementWithinTransaction(SessionLocal.java:1631)
	at org.h2.command.Command.executeQuery(Command.java:186)
	at org.h2.jdbc.JdbcStatement.executeInternal(JdbcStatement.java:257)
	at org.h2.jdbc.JdbcStatement.execute(JdbcStatement.java:231)
	at com.zaxxer.hikari.pool.ProxyStatement.execute(ProxyStatement.java:94)
	at com.zaxxer.hikari.pool.HikariProxyStatement.execute(HikariProxyStatement.java)
	at org.jooq.tools.jdbc.DefaultStatement.execute(DefaultStatement.java:102)
	at org.jooq.impl.SettingsEnabledPreparedStatement.execute(SettingsEnabledPreparedStatement.java:227)
	at org.jooq.impl.Tools.executeStatementAndGetFirstResultSet(Tools.java:4408)
	at org.jooq.impl.AbstractResultQuery.execute(AbstractResultQuery.java:230)
	at org.jooq.impl.AbstractQuery.execute(AbstractQuery.java:329)
	... 25 more
Caused by: org.h2.mvstore.MVStoreException: Reading from file sun.nio.ch.FileChannelImpl@5ec4c79d failed at 6164313006 (length -1), read 0, remaining 512 [2.2.224/1]
	at org.h2.mvstore.DataUtils.newMVStoreException(DataUtils.java:996)
	at org.h2.mvstore.DataUtils.readFully(DataUtils.java:455)
	at org.h2.mvstore.FileStore.readFully(FileStore.java:719)
	at org.h2.mvstore.SingleFileStore.readFully(SingleFileStore.java:60)
	at org.h2.mvstore.SingleFileStore.readFully(SingleFileStore.java:28)
	at org.h2.mvstore.SFChunk.readFully(SFChunk.java:35)
	at org.h2.mvstore.Chunk.readBufferForPage(Chunk.java:465)
	at org.h2.mvstore.FileStore.readPage(FileStore.java:1960)
	at org.h2.mvstore.MVStore.readPage(MVStore.java:1021)
	at org.h2.mvstore.MVMap.readPage(MVMap.java:632)
	at org.h2.mvstore.MVMap.rewritePage(MVMap.java:682)
	at org.h2.mvstore.FileStore.rewriteChunks(FileStore.java:1920)
	at org.h2.mvstore.FileStore.compactRewrite(FileStore.java:1896)
	at org.h2.mvstore.FileStore.rewriteChunks(FileStore.java:1857)
	at org.h2.mvstore.RandomAccessStore.lambda$doHousekeeping$4(RandomAccessStore.java:728)
	at org.h2.mvstore.MVStore.tryExecuteUnderStoreLock(MVStore.java:937)
	at org.h2.mvstore.RandomAccessStore.doHousekeeping(RandomAccessStore.java:723)
	at org.h2.mvstore.FileStore.writeInBackground(FileStore.java:1837)
	at org.h2.mvstore.FileStore$BackgroundWriterThread.run(FileStore.java:2248)
Caused by: java.nio.channels.AsynchronousCloseException
	at java.base/java.nio.channels.spi.AbstractInterruptibleChannel.end(Unknown Source)
	at java.base/sun.nio.ch.FileChannelImpl.endBlocking(Unknown Source)
	at java.base/sun.nio.ch.FileChannelImpl.readInternal(Unknown Source)
	at java.base/sun.nio.ch.FileChannelImpl.read(Unknown Source)
	at org.h2.mvstore.DataUtils.readFully(DataUtils.java:441)
	... 17 more
[INFO] 2024-01-29 13:49:44 brs.BlockchainProcessorImpl - Error in blockchain download thread
org.jooq.exception.DataAccessException: SQL [select (exists (select 1 "one" from "block" where "block"."id" = 4435643953206244011))]; The database has been closed [90098-224]
	at org.jooq_3.16.23.H2.debug(Unknown Source)
	at org.jooq.impl.Tools.translate(Tools.java:3130)
	at org.jooq.impl.DefaultExecuteContext.sqlException(DefaultExecuteContext.java:727)
	at org.jooq.impl.AbstractQuery.execute(AbstractQuery.java:343)
	at org.jooq.impl.AbstractResultQuery.fetchLazy(AbstractResultQuery.java:295)
	at org.jooq.impl.AbstractResultQuery.fetchLazyNonAutoClosing(AbstractResultQuery.java:316)
	at org.jooq.impl.SelectImpl.fetchLazyNonAutoClosing(SelectImpl.java:2867)
	at org.jooq.impl.ResultQueryTrait.fetchOne(ResultQueryTrait.java:506)
	at org.jooq.impl.Tools.attach(Tools.java:1376)
	at org.jooq.impl.DefaultDSLContext.fetchOne(DefaultDSLContext.java:4629)
	at org.jooq.impl.DefaultDSLContext.lambda$fetchValue$48(DefaultDSLContext.java:4649)
	at org.jooq.impl.Tools.attach(Tools.java:1376)
	at org.jooq.impl.DefaultDSLContext.fetchValue(DefaultDSLContext.java:4649)
	at org.jooq.impl.DefaultDSLContext.fetchValue(DefaultDSLContext.java:4659)
	at org.jooq.impl.DefaultDSLContext.fetchExists(DefaultDSLContext.java:4741)
	at brs.db.sql.SqlBlockDb.lambda$hasBlock$1(SqlBlockDb.java:36)
	at brs.db.sql.Db.useDSLContext(Db.java:215)
	at brs.db.sql.SqlBlockDb.hasBlock(SqlBlockDb.java:35)
	at brs.BlockchainImpl.hasBlock(BlockchainImpl.java:92)
	at brs.util.DownloadCacheImpl.hasBlock(DownloadCacheImpl.java:319)
	at brs.BlockchainProcessorImpl$1.getCommonMilestoneBlockId(BlockchainProcessorImpl.java:456)
	at brs.BlockchainProcessorImpl$1.run(BlockchainProcessorImpl.java:271)
	at brs.util.ThreadPool.lambda$start$0(ThreadPool.java:104)
	at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
	at java.base/java.util.concurrent.FutureTask.runAndReset(Unknown Source)
	at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(Unknown Source)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
	at java.base/java.lang.Thread.run(Unknown Source)
Caused by: org.h2.jdbc.JdbcSQLNonTransientConnectionException: The database has been closed [90098-224]
	at org.h2.message.DbException.getJdbcSQLException(DbException.java:690)
	at org.h2.message.DbException.getJdbcSQLException(DbException.java:489)
	at org.h2.message.DbException.get(DbException.java:212)
	at org.h2.engine.SessionLocal.getTransaction(SessionLocal.java:1610)
	at org.h2.engine.SessionLocal.startStatementWithinTransaction(SessionLocal.java:1631)
	at org.h2.command.Command.executeQuery(Command.java:186)
	at org.h2.jdbc.JdbcStatement.executeInternal(JdbcStatement.java:257)
	at org.h2.jdbc.JdbcStatement.execute(JdbcStatement.java:231)
	at com.zaxxer.hikari.pool.ProxyStatement.execute(ProxyStatement.java:94)
	at com.zaxxer.hikari.pool.HikariProxyStatement.execute(HikariProxyStatement.java)
	at org.jooq.tools.jdbc.DefaultStatement.execute(DefaultStatement.java:102)
	at org.jooq.impl.SettingsEnabledPreparedStatement.execute(SettingsEnabledPreparedStatement.java:227)
	at org.jooq.impl.Tools.executeStatementAndGetFirstResultSet(Tools.java:4408)
	at org.jooq.impl.AbstractResultQuery.execute(AbstractResultQuery.java:230)
	at org.jooq.impl.AbstractQuery.execute(AbstractQuery.java:329)
	... 25 more
Caused by: org.h2.mvstore.MVStoreException: Reading from file sun.nio.ch.FileChannelImpl@5ec4c79d failed at 6164313006 (length -1), read 0, remaining 512 [2.2.224/1]
	at org.h2.mvstore.DataUtils.newMVStoreException(DataUtils.java:996)
	at org.h2.mvstore.DataUtils.readFully(DataUtils.java:455)
	at org.h2.mvstore.FileStore.readFully(FileStore.java:719)
	at org.h2.mvstore.SingleFileStore.readFully(SingleFileStore.java:60)
	at org.h2.mvstore.SingleFileStore.readFully(SingleFileStore.java:28)
	at org.h2.mvstore.SFChunk.readFully(SFChunk.java:35)
	at org.h2.mvstore.Chunk.readBufferForPage(Chunk.java:465)
	at org.h2.mvstore.FileStore.readPage(FileStore.java:1960)
	at org.h2.mvstore.MVStore.readPage(MVStore.java:1021)
	at org.h2.mvstore.MVMap.readPage(MVMap.java:632)
	at org.h2.mvstore.MVMap.rewritePage(MVMap.java:682)
	at org.h2.mvstore.FileStore.rewriteChunks(FileStore.java:1920)
	at org.h2.mvstore.FileStore.compactRewrite(FileStore.java:1896)
	at org.h2.mvstore.FileStore.rewriteChunks(FileStore.java:1857)
	at org.h2.mvstore.RandomAccessStore.lambda$doHousekeeping$4(RandomAccessStore.java:728)
	at org.h2.mvstore.MVStore.tryExecuteUnderStoreLock(MVStore.java:937)
	at org.h2.mvstore.RandomAccessStore.doHousekeeping(RandomAccessStore.java:723)
	at org.h2.mvstore.FileStore.writeInBackground(FileStore.java:1837)
	at org.h2.mvstore.FileStore$BackgroundWriterThread.run(FileStore.java:2248)
Caused by: java.nio.channels.AsynchronousCloseException
	at java.base/java.nio.channels.spi.AbstractInterruptibleChannel.end(Unknown Source)
	at java.base/sun.nio.ch.FileChannelImpl.endBlocking(Unknown Source)
	at java.base/sun.nio.ch.FileChannelImpl.readInternal(Unknown Source)
	at java.base/sun.nio.ch.FileChannelImpl.read(Unknown Source)
	at org.h2.mvstore.DataUtils.readFully(DataUtils.java:441)
	... 17 more
[INFO] 2024-01-29 13:49:45 brs.BlockchainProcessorImpl - Error in blockchain download thread
org.jooq.exception.DataAccessException: SQL [select (exists (select 1 "one" from "block" where "block"."id" = 4435643953206244011))]; The database has been closed [90098-224]
	at org.jooq_3.16.23.H2.debug(Unknown Source)
	at org.jooq.impl.Tools.translate(Tools.java:3130)
	at org.jooq.impl.DefaultExecuteContext.sqlException(DefaultExecuteContext.java:727)
	at org.jooq.impl.AbstractQuery.execute(AbstractQuery.java:343)
	at org.jooq.impl.AbstractResultQuery.fetchLazy(AbstractResultQuery.java:295)
	at org.jooq.impl.AbstractResultQuery.fetchLazyNonAutoClosing(AbstractResultQuery.java:316)
	at org.jooq.impl.SelectImpl.fetchLazyNonAutoClosing(SelectImpl.java:2867)
	at org.jooq.impl.ResultQueryTrait.fetchOne(ResultQueryTrait.java:506)
	at org.jooq.impl.Tools.attach(Tools.java:1376)
	at org.jooq.impl.DefaultDSLContext.fetchOne(DefaultDSLContext.java:4629)
	at org.jooq.impl.DefaultDSLContext.lambda$fetchValue$48(DefaultDSLContext.java:4649)
	at org.jooq.impl.Tools.attach(Tools.java:1376)
	at org.jooq.impl.DefaultDSLContext.fetchValue(DefaultDSLContext.java:4649)
	at org.jooq.impl.DefaultDSLContext.fetchValue(DefaultDSLContext.java:4659)
	at org.jooq.impl.DefaultDSLContext.fetchExists(DefaultDSLContext.java:4741)
	at brs.db.sql.SqlBlockDb.lambda$hasBlock$1(SqlBlockDb.java:36)
	at brs.db.sql.Db.useDSLContext(Db.java:215)
	at brs.db.sql.SqlBlockDb.hasBlock(SqlBlockDb.java:35)
	at brs.BlockchainImpl.hasBlock(BlockchainImpl.java:92)
	at brs.util.DownloadCacheImpl.hasBlock(DownloadCacheImpl.java:319)
	at brs.BlockchainProcessorImpl$1.getCommonMilestoneBlockId(BlockchainProcessorImpl.java:456)
	at brs.BlockchainProcessorImpl$1.run(BlockchainProcessorImpl.java:271)
	at brs.util.ThreadPool.lambda$start$0(ThreadPool.java:104)
	at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
	at java.base/java.util.concurrent.FutureTask.runAndReset(Unknown Source)
	at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(Unknown Source)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
	at java.base/java.lang.Thread.run(Unknown Source)
Caused by: org.h2.jdbc.JdbcSQLNonTransientConnectionException: The database has been closed [90098-224]
	at org.h2.message.DbException.getJdbcSQLException(DbException.java:690)
	at org.h2.message.DbException.getJdbcSQLException(DbException.java:489)
	at org.h2.message.DbException.get(DbException.java:212)
	at org.h2.engine.SessionLocal.getTransaction(SessionLocal.java:1610)
	at org.h2.engine.SessionLocal.startStatementWithinTransaction(SessionLocal.java:1631)
	at org.h2.command.Command.executeQuery(Command.java:186)
	at org.h2.jdbc.JdbcStatement.executeInternal(JdbcStatement.java:257)
	at org.h2.jdbc.JdbcStatement.execute(JdbcStatement.java:231)
	at com.zaxxer.hikari.pool.ProxyStatement.execute(ProxyStatement.java:94)
	at com.zaxxer.hikari.pool.HikariProxyStatement.execute(HikariProxyStatement.java)
	at org.jooq.tools.jdbc.DefaultStatement.execute(DefaultStatement.java:102)
	at org.jooq.impl.SettingsEnabledPreparedStatement.execute(SettingsEnabledPreparedStatement.java:227)
	at org.jooq.impl.Tools.executeStatementAndGetFirstResultSet(Tools.java:4408)
	at org.jooq.impl.AbstractResultQuery.execute(AbstractResultQuery.java:230)
	at org.jooq.impl.AbstractQuery.execute(AbstractQuery.java:329)
	... 25 more
Caused by: org.h2.mvstore.MVStoreException: Reading from file sun.nio.ch.FileChannelImpl@5ec4c79d failed at 6164313006 (length -1), read 0, remaining 512 [2.2.224/1]
	at org.h2.mvstore.DataUtils.newMVStoreException(DataUtils.java:996)
	at org.h2.mvstore.DataUtils.readFully(DataUtils.java:455)
	at org.h2.mvstore.FileStore.readFully(FileStore.java:719)
	at org.h2.mvstore.SingleFileStore.readFully(SingleFileStore.java:60)
	at org.h2.mvstore.SingleFileStore.readFully(SingleFileStore.java:28)
	at org.h2.mvstore.SFChunk.readFully(SFChunk.java:35)
	at org.h2.mvstore.Chunk.readBufferForPage(Chunk.java:465)
	at org.h2.mvstore.FileStore.readPage(FileStore.java:1960)
	at org.h2.mvstore.MVStore.readPage(MVStore.java:1021)
	at org.h2.mvstore.MVMap.readPage(MVMap.java:632)
	at org.h2.mvstore.MVMap.rewritePage(MVMap.java:682)
	at org.h2.mvstore.FileStore.rewriteChunks(FileStore.java:1920)
	at org.h2.mvstore.FileStore.compactRewrite(FileStore.java:1896)
	at org.h2.mvstore.FileStore.rewriteChunks(FileStore.java:1857)
	at org.h2.mvstore.RandomAccessStore.lambda$doHousekeeping$4(RandomAccessStore.java:728)
	at org.h2.mvstore.MVStore.tryExecuteUnderStoreLock(MVStore.java:937)
	at org.h2.mvstore.RandomAccessStore.doHousekeeping(RandomAccessStore.java:723)
	at org.h2.mvstore.FileStore.writeInBackground(FileStore.java:1837)
	at org.h2.mvstore.FileStore$BackgroundWriterThread.run(FileStore.java:2248)
Caused by: java.nio.channels.AsynchronousCloseException
	at java.base/java.nio.channels.spi.AbstractInterruptibleChannel.end(Unknown Source)
	at java.base/sun.nio.ch.FileChannelImpl.endBlocking(Unknown Source)
	at java.base/sun.nio.ch.FileChannelImpl.readInternal(Unknown Source)
	at java.base/sun.nio.ch.FileChannelImpl.read(Unknown Source)
	at org.h2.mvstore.DataUtils.readFully(DataUtils.java:441)
	... 17 more
[INFO] 2024-01-29 13:49:46 brs.BlockchainProcessorImpl - Error in blockchain download thread
org.jooq.exception.DataAccessException: SQL [select (exists (select 1 "one" from "block" where "block"."id" = 4435643953206244011))]; The database has been closed [90098-224]
	at org.jooq_3.16.23.H2.debug(Unknown Source)
	at org.jooq.impl.Tools.translate(Tools.java:3130)
	at org.jooq.impl.DefaultExecuteContext.sqlException(DefaultExecuteContext.java:727)
	at org.jooq.impl.AbstractQuery.execute(AbstractQuery.java:343)
	at org.jooq.impl.AbstractResultQuery.fetchLazy(AbstractResultQuery.java:295)
	at org.jooq.impl.AbstractResultQuery.fetchLazyNonAutoClosing(AbstractResultQuery.java:316)
	at org.jooq.impl.SelectImpl.fetchLazyNonAutoClosing(SelectImpl.java:2867)
	at org.jooq.impl.ResultQueryTrait.fetchOne(ResultQueryTrait.java:506)
	at org.jooq.impl.Tools.attach(Tools.java:1376)
	at org.jooq.impl.DefaultDSLContext.fetchOne(DefaultDSLContext.java:4629)
	at org.jooq.impl.DefaultDSLContext.lambda$fetchValue$48(DefaultDSLContext.java:4649)
	at org.jooq.impl.Tools.attach(Tools.java:1376)
	at org.jooq.impl.DefaultDSLContext.fetchValue(DefaultDSLContext.java:4649)
	at org.jooq.impl.DefaultDSLContext.fetchValue(DefaultDSLContext.java:4659)
	at org.jooq.impl.DefaultDSLContext.fetchExists(DefaultDSLContext.java:4741)
	at brs.db.sql.SqlBlockDb.lambda$hasBlock$1(SqlBlockDb.java:36)
	at brs.db.sql.Db.useDSLContext(Db.java:215)
	at brs.db.sql.SqlBlockDb.hasBlock(SqlBlockDb.java:35)
	at brs.BlockchainImpl.hasBlock(BlockchainImpl.java:92)
	at brs.util.DownloadCacheImpl.hasBlock(DownloadCacheImpl.java:319)
	at brs.BlockchainProcessorImpl$1.getCommonMilestoneBlockId(BlockchainProcessorImpl.java:456)
	at brs.BlockchainProcessorImpl$1.run(BlockchainProcessorImpl.java:271)
	at brs.util.ThreadPool.lambda$start$0(ThreadPool.java:104)
	at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
	at java.base/java.util.concurrent.FutureTask.runAndReset(Unknown Source)
	at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(Unknown Source)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
	at java.base/java.lang.Thread.run(Unknown Source)
Caused by: org.h2.jdbc.JdbcSQLNonTransientConnectionException: The database has been closed [90098-224]
	at org.h2.message.DbException.getJdbcSQLException(DbException.java:690)
	at org.h2.message.DbException.getJdbcSQLException(DbException.java:489)
	at org.h2.message.DbException.get(DbException.java:212)
	at org.h2.engine.SessionLocal.getTransaction(SessionLocal.java:1610)
	at org.h2.engine.SessionLocal.startStatementWithinTransaction(SessionLocal.java:1631)
	at org.h2.command.Command.executeQuery(Command.java:186)
	at org.h2.jdbc.JdbcStatement.executeInternal(JdbcStatement.java:257)
	at org.h2.jdbc.JdbcStatement.execute(JdbcStatement.java:231)
	at com.zaxxer.hikari.pool.ProxyStatement.execute(ProxyStatement.java:94)
	at com.zaxxer.hikari.pool.HikariProxyStatement.execute(HikariProxyStatement.java)
	at org.jooq.tools.jdbc.DefaultStatement.execute(DefaultStatement.java:102)
	at org.jooq.impl.SettingsEnabledPreparedStatement.execute(SettingsEnabledPreparedStatement.java:227)
	at org.jooq.impl.Tools.executeStatementAndGetFirstResultSet(Tools.java:4408)
	at org.jooq.impl.AbstractResultQuery.execute(AbstractResultQuery.java:230)
	at org.jooq.impl.AbstractQuery.execute(AbstractQuery.java:329)
	... 25 more
Caused by: org.h2.mvstore.MVStoreException: Reading from file sun.nio.ch.FileChannelImpl@5ec4c79d failed at 6164313006 (length -1), read 0, remaining 512 [2.2.224/1]
	at org.h2.mvstore.DataUtils.newMVStoreException(DataUtils.java:996)
	at org.h2.mvstore.DataUtils.readFully(DataUtils.java:455)
	at org.h2.mvstore.FileStore.readFully(FileStore.java:719)
	at org.h2.mvstore.SingleFileStore.readFully(SingleFileStore.java:60)
	at org.h2.mvstore.SingleFileStore.readFully(SingleFileStore.java:28)
	at org.h2.mvstore.SFChunk.readFully(SFChunk.java:35)
	at org.h2.mvstore.Chunk.readBufferForPage(Chunk.java:465)
	at org.h2.mvstore.FileStore.readPage(FileStore.java:1960)
	at org.h2.mvstore.MVStore.readPage(MVStore.java:1021)
	at org.h2.mvstore.MVMap.readPage(MVMap.java:632)
	at org.h2.mvstore.MVMap.rewritePage(MVMap.java:682)
	at org.h2.mvstore.FileStore.rewriteChunks(FileStore.java:1920)
	at org.h2.mvstore.FileStore.compactRewrite(FileStore.java:1896)
	at org.h2.mvstore.FileStore.rewriteChunks(FileStore.java:1857)
	at org.h2.mvstore.RandomAccessStore.lambda$doHousekeeping$4(RandomAccessStore.java:728)
	at org.h2.mvstore.MVStore.tryExecuteUnderStoreLock(MVStore.java:937)
	at org.h2.mvstore.RandomAccessStore.doHousekeeping(RandomAccessStore.java:723)
	at org.h2.mvstore.FileStore.writeInBackground(FileStore.java:1837)
	at org.h2.mvstore.FileStore$BackgroundWriterThread.run(FileStore.java:2248)
Caused by: java.nio.channels.AsynchronousCloseException
	at java.base/java.nio.channels.spi.AbstractInterruptibleChannel.end(Unknown Source)
	at java.base/sun.nio.ch.FileChannelImpl.endBlocking(Unknown Source)
	at java.base/sun.nio.ch.FileChannelImpl.readInternal(Unknown Source)
	at java.base/sun.nio.ch.FileChannelImpl.read(Unknown Source)
	at org.h2.mvstore.DataUtils.readFully(DataUtils.java:441)
	... 17 more
[INFO] 2024-01-29 13:49:47 brs.BlockchainProcessorImpl - Error in blockchain download thread
org.jooq.exception.DataAccessException: SQL [select (exists (select 1 "one" from "block" where "block"."id" = 4435643953206244011))]; The database has been closed [90098-224]
	at org.jooq_3.16.23.H2.debug(Unknown Source)
	at org.jooq.impl.Tools.translate(Tools.java:3130)
	at org.jooq.impl.DefaultExecuteContext.sqlException(DefaultExecuteContext.java:727)
	at org.jooq.impl.AbstractQuery.execute(AbstractQuery.java:343)
	at org.jooq.impl.AbstractResultQuery.fetchLazy(AbstractResultQuery.java:295)
	at org.jooq.impl.AbstractResultQuery.fetchLazyNonAutoClosing(AbstractResultQuery.java:316)
	at org.jooq.impl.SelectImpl.fetchLazyNonAutoClosing(SelectImpl.java:2867)
	at org.jooq.impl.ResultQueryTrait.fetchOne(ResultQueryTrait.java:506)
	at org.jooq.impl.Tools.attach(Tools.java:1376)
	at org.jooq.impl.DefaultDSLContext.fetchOne(DefaultDSLContext.java:4629)
	at org.jooq.impl.DefaultDSLContext.lambda$fetchValue$48(DefaultDSLContext.java:4649)
	at org.jooq.impl.Tools.attach(Tools.java:1376)
	at org.jooq.impl.DefaultDSLContext.fetchValue(DefaultDSLContext.java:4649)
	at org.jooq.impl.DefaultDSLContext.fetchValue(DefaultDSLContext.java:4659)
	at org.jooq.impl.DefaultDSLContext.fetchExists(DefaultDSLContext.java:4741)
	at brs.db.sql.SqlBlockDb.lambda$hasBlock$1(SqlBlockDb.java:36)
	at brs.db.sql.Db.useDSLContext(Db.java:215)
	at brs.db.sql.SqlBlockDb.hasBlock(SqlBlockDb.java:35)
	at brs.BlockchainImpl.hasBlock(BlockchainImpl.java:92)
	at brs.util.DownloadCacheImpl.hasBlock(DownloadCacheImpl.java:319)
	at brs.BlockchainProcessorImpl$1.getCommonMilestoneBlockId(BlockchainProcessorImpl.java:456)
	at brs.BlockchainProcessorImpl$1.run(BlockchainProcessorImpl.java:271)
	at brs.util.ThreadPool.lambda$start$0(ThreadPool.java:104)
	at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
	at java.base/java.util.concurrent.FutureTask.runAndReset(Unknown Source)
	at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(Unknown Source)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
	at java.base/java.lang.Thread.run(Unknown Source)
Caused by: org.h2.jdbc.JdbcSQLNonTransientConnectionException: The database has been closed [90098-224]
	at org.h2.message.DbException.getJdbcSQLException(DbException.java:690)
	at org.h2.message.DbException.getJdbcSQLException(DbException.java:489)
	at org.h2.message.DbException.get(DbException.java:212)
	at org.h2.engine.SessionLocal.getTransaction(SessionLocal.java:1610)
	at org.h2.engine.SessionLocal.startStatementWithinTransaction(SessionLocal.java:1631)
	at org.h2.command.Command.executeQuery(Command.java:186)
	at org.h2.jdbc.JdbcStatement.executeInternal(JdbcStatement.java:257)
	at org.h2.jdbc.JdbcStatement.execute(JdbcStatement.java:231)
	at com.zaxxer.hikari.pool.ProxyStatement.execute(ProxyStatement.java:94)
	at com.zaxxer.hikari.pool.HikariProxyStatement.execute(HikariProxyStatement.java)
	at org.jooq.tools.jdbc.DefaultStatement.execute(DefaultStatement.java:102)
	at org.jooq.impl.SettingsEnabledPreparedStatement.execute(SettingsEnabledPreparedStatement.java:227)
	at org.jooq.impl.Tools.executeStatementAndGetFirstResultSet(Tools.java:4408)
	at org.jooq.impl.AbstractResultQuery.execute(AbstractResultQuery.java:230)
	at org.jooq.impl.AbstractQuery.execute(AbstractQuery.java:329)
	... 25 more
Caused by: org.h2.mvstore.MVStoreException: Reading from file sun.nio.ch.FileChannelImpl@5ec4c79d failed at 6164313006 (length -1), read 0, remaining 512 [2.2.224/1]
	at org.h2.mvstore.DataUtils.newMVStoreException(DataUtils.java:996)
	at org.h2.mvstore.DataUtils.readFully(DataUtils.java:455)
	at org.h2.mvstore.FileStore.readFully(FileStore.java:719)
	at org.h2.mvstore.SingleFileStore.readFully(SingleFileStore.java:60)
	at org.h2.mvstore.SingleFileStore.readFully(SingleFileStore.java:28)
	at org.h2.mvstore.SFChunk.readFully(SFChunk.java:35)
	at org.h2.mvstore.Chunk.readBufferForPage(Chunk.java:465)
	at org.h2.mvstore.FileStore.readPage(FileStore.java:1960)
	at org.h2.mvstore.MVStore.readPage(MVStore.java:1021)
	at org.h2.mvstore.MVMap.readPage(MVMap.java:632)
	at org.h2.mvstore.MVMap.rewritePage(MVMap.java:682)
	at org.h2.mvstore.FileStore.rewriteChunks(FileStore.java:1920)
	at org.h2.mvstore.FileStore.compactRewrite(FileStore.java:1896)
	at org.h2.mvstore.FileStore.rewriteChunks(FileStore.java:1857)
	at org.h2.mvstore.RandomAccessStore.lambda$doHousekeeping$4(RandomAccessStore.java:728)
	at org.h2.mvstore.MVStore.tryExecuteUnderStoreLock(MVStore.java:937)
	at org.h2.mvstore.RandomAccessStore.doHousekeeping(RandomAccessStore.java:723)
	at org.h2.mvstore.FileStore.writeInBackground(FileStore.java:1837)
	at org.h2.mvstore.FileStore$BackgroundWriterThread.run(FileStore.java:2248)
Caused by: java.nio.channels.AsynchronousCloseException
	at java.base/java.nio.channels.spi.AbstractInterruptibleChannel.end(Unknown Source)
	at java.base/sun.nio.ch.FileChannelImpl.endBlocking(Unknown Source)
	at java.base/sun.nio.ch.FileChannelImpl.readInternal(Unknown Source)
	at java.base/sun.nio.ch.FileChannelImpl.read(Unknown Source)
	at org.h2.mvstore.DataUtils.readFully(DataUtils.java:441)
	... 17 more

image

josergc avatar Jan 29 '24 05:01 josergc

@frankTheTank72 didn't you get this issue also... I made some research and it looks like it is an resource problem (memory?) - this needs further investigation.

https://github.com/h2database/h2database/blob/master/h2/src/main/org/h2/api/ErrorCode.java#L1620

ohager avatar Jan 29 '24 10:01 ohager

@josergc can you paste your machines spec here? OS, RAM, Cores, HDD size?

ohager avatar Jan 29 '24 10:01 ohager

Maybe this helps?

https://stackoverflow.com/questions/60658184/h2-database-java-heap-issue

ohager avatar Jan 29 '24 10:01 ohager

The machine which got this issue is an Acer Aspire ES 17 laptop running Win11. The node is running with the bundle Java VM8, the one that appears as "Zulu Platform x64 Architecture" in the Task Manager. The node is launched using the signum-node.exe from the release for Windows.

  • CPU: Intel Pentium Quad Core Processor N4200
  • Video: Intel HD Graphics
  • RAM: 6GB DDR3
  • HDD: 500GB of SSD (upgraded since the original 1TB HDD died).
Jan 29, 2024 3:20:53 PM brs.Burst loadProperties
INFO: Initializing Signum Node version v3.8.0
Jan 29, 2024 3:20:55 PM brs.Burst loadProperties
INFO: Configurations from folder ./conf
Jan 29, 2024 3:20:55 PM brs.Burst loadProperties
INFO: Custom user properties file node.properties not loaded
Jan 29, 2024 3:20:55 PM brs.util.LoggerConfigurator init
INFO: Custom user logging.properties not loaded
[INFO] 2024-01-29 15:21:23 brs.db.sql.Db - Running flyway migration
[INFO] 2024-01-29 15:21:31 brs.db.sql.Db - Using SQL Backend with Dialect H2 - Version 2.2.224
[INFO] 2024-01-29 15:21:33 brs.BlockchainProcessorImpl - Genesis block already in database
[INFO] 2024-01-29 15:21:34 brs.BlockchainProcessorImpl - Last block height: 1238735, baseTarget: 1694326, averageCommitmentNQT 1931746213888
[INFO] 2024-01-29 15:21:43 brs.peer.Peers - P2P max connections: 20
[WARNING] 2024-01-29 15:21:51 brs.peer.Peers - Tried to establish UPnP, but it was denied by the network.
[INFO] 2024-01-29 15:21:52 brs.peer.GetNextBlocks - P2P max number of blocks: 720
[INFO] 2024-01-29 15:21:53 brs.web.server.WebServerImpl - API docs enabled
[INFO] 2024-01-29 15:21:54 brs.peer.Peers - Started peer networking server at 0.0.0.0:8123
[INFO] 2024-01-29 15:21:55 brs.web.server.WebServerImpl - Started Http API server at 0.0.0.0:8125
[INFO] 2024-01-29 15:21:55 brs.web.server.WebServerImpl - Started [EXPERIMENTAL] Websocket API server at 0.0.0.0:8126
[INFO] 2024-01-29 15:21:55 brs.util.ThreadPool - Using 2 cores
[INFO] 2024-01-29 15:21:55 brs.Burst - Initialization took 57045 ms
[INFO] 2024-01-29 15:21:55 brs.Burst - Signum Multiverse v3.8.0 started successfully.
[INFO] 2024-01-29 15:21:55 brs.Burst - Running network: Signum
[INFO] 2024-01-29 16:21:50 brs.peer.Peers - Finished connecting to 4 well known peers.
[INFO] 2024-01-29 17:06:55 brs.BlockchainProcessorImpl - Rollback from 1238782 to 1238781
[INFO] 2024-01-29 17:06:57 brs.BlockchainProcessorImpl - Forkprocessing complete.
[INFO] 2024-01-29 17:11:56 brs.BlockchainProcessorImpl - Rollback from 1238783 to 1238782
[INFO] 2024-01-29 17:11:57 brs.BlockchainProcessorImpl - Forkprocessing complete.
[INFO] 2024-01-29 18:42:09 brs.BlockchainProcessorImpl - Rollback from 1238807 to 1238806
[INFO] 2024-01-29 18:42:11 brs.BlockchainProcessorImpl - Forkprocessing complete.
[INFO] 2024-01-29 19:29:48 brs.BlockchainProcessorImpl - Rollback from 1238819 to 1238818
[INFO] 2024-01-29 19:29:50 brs.BlockchainProcessorImpl - Forkprocessing complete.
[INFO] 2024-01-29 20:03:37 brs.peer.PeerImpl - Blacklisting 178.143.41.107 (v3.8.0) because of: feeding us a too old fork
[INFO] 2024-01-29 21:17:41 brs.BlockchainProcessorImpl - Rollback from 1238845 to 1238844
[INFO] 2024-01-29 21:17:43 brs.BlockchainProcessorImpl - Forkprocessing complete.

at the same time, it runs a signum-pool 2.2.1

josergc avatar Jan 29 '24 14:01 josergc

see my comment on #791 - not sure how to assign more mem to the exe. I suggest to migrate to MariaDB - this is definitely more stable.

Postgres is still experimental and has a sync issue in main net as reported here #780

ohager avatar Feb 08 '24 20:02 ohager

Now we have 3.8.1 with sqlite support... try sqlite instead. It looks like to be more reliable and less ressource hungry (mem)

ohager avatar May 05 '24 20:05 ohager