3

在 DB 断开空闲连接或 DB 关闭并备份后,我在我的 webapp 中收到以下错误:

javax.persistence.PersistenceException: org.hibernate.exception.JDBCConnectionException: could not inspect JDBC autocommit mode
    at org.hibernate.ejb.AbstractEntityManagerImpl.convert(AbstractEntityManagerImpl.java:1365)
    at org.hibernate.ejb.AbstractEntityManagerImpl.convert(AbstractEntityManagerImpl.java:1293)
    at org.hibernate.ejb.QueryImpl.getResultList(QueryImpl.java:265)    
... 60 more
Caused by: org.hibernate.exception.JDBCConnectionException: could not inspect JDBC autocommit mode
    at org.hibernate.exception.internal.SQLStateConversionDelegate.convert(SQLStateConversionDelegate.java:131)
    at org.hibernate.exception.internal.StandardSQLExceptionConverter.convert(StandardSQLExceptionConverter.java:49)
    at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:125)
    at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:110)
    at org.hibernate.engine.jdbc.internal.LogicalConnectionImpl.isAutoCommit(LogicalConnectionImpl.java:395)
    at org.hibernate.engine.transaction.internal.TransactionCoordinatorImpl.afterNonTransactionalQuery(TransactionCoordinatorImpl.java:195)
    at org.hibernate.internal.SessionImpl.afterOperation(SessionImpl.java:565)
    at org.hibernate.internal.SessionImpl.list(SessionImpl.java:1220)
    at org.hibernate.internal.QueryImpl.list(QueryImpl.java:101)
    at org.hibernate.ejb.QueryImpl.getResultList(QueryImpl.java:256)
... 70 more
Caused by: org.postgresql.util.PSQLException: This connection has been closed.
    at org.postgresql.jdbc2.AbstractJdbc2Connection.checkClosed(AbstractJdbc2Connection.java:712)
    at org.postgresql.jdbc2.AbstractJdbc2Connection.getAutoCommit(AbstractJdbc2Connection.java:678)
    at sun.reflect.GeneratedMethodAccessor138.invoke(Unknown Source)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:601)
    at org.apache.tomcat.jdbc.pool.ProxyConnection.invoke(ProxyConnection.java:126)
    at org.apache.tomcat.jdbc.pool.JdbcInterceptor.invoke(JdbcInterceptor.java:99)
    at org.apache.tomcat.jdbc.pool.DisposableConnectionFacade.invoke(DisposableConnectionFacade.java:63)
    at $Proxy66.getAutoCommit(Unknown Source)
    at org.hibernate.engine.jdbc.internal.LogicalConnectionImpl.isAutoCommit(LogicalConnectionImpl.java:392)

当这开始时,我得到一个

SQL Error: 0, SQLState: 08006 - An I/O error occured while sending to the backend.

但在那之后它只是:

SQL Error: 0, SQLState: 08003 - This connection has been closed.

问题是:我已经设置了 testOnBorrow,所以我希望只获得打开的连接。

如果这有帮助:池通常包含好连接和坏连接,问题似乎随着时间的推移而消失,但我让服务器运行了 >12 小时,但仍然返回了坏连接。重新启动后一切正常(一段时间)。

我已经对问题进行了更多调试,似乎池返回了错误的连接,例如,如果我在 DB 上杀死了所有连接后,我得到:

SQL Error: 0, SQLState: 57P01

然后是通常的东西 - 从池中返回被杀死的连接。问题是:这是应用程序问题吗?

我尝试通过 JMX 清除池,但这似乎没有任何效果。另一个奇怪的事情是,即使应用程序显然没有做任何事情(通过线程转储检查),JMX bean 仍显示 7 个活动连接和 0 个空闲连接。当我执行一个需要访问数据库的请求时,我会立即得到响应(尽管没有可用的空闲连接),但之后 JMX 显示 7 个活动连接和 0 个空闲连接。

PS。也许我遗漏了一些明显的东西,这是我的连接管理问题?我正在使用通过 persistence.xml 配置的 JPA EntityManager,所以也许我做错了什么并且使用后连接没有正确关闭(返回)?

4

3 回答 3

6

实际上,当我怀疑应用程序错误时,我是对的。

这在第 730 期中有很好的描述:自动启动的 UnitOfWork 永远不会结束

使用 JpaPersistService 时,如果您尝试访问活动 UnitOfWork 之外的 EntityManager,Guice 将自动为您启动一个。然而,由于 Guice 不(也不可能)知道何时结束这个 UnitOfWork,所以它永远不会知道。

结果?在应用程序的整个生命周期中,有问题的线程将被同一个 EntityManager 卡住。这对于应用程序运行来说是一个糟糕的状态,我们不可避免地会在一段时间后耗尽可用内存并崩溃。

这里真正的杀手是当你犯了这个错误时一点都不明显。唯一真正的提示是您在不同线程之间从数据库中获取不一致的数据(由于 EM 一级缓存),或者应用程序的内存消耗不断增长。在我的情况下,是池中的活动连接让我怀疑它,然后,当我打开详细日志记录时,我注意到应用程序根本没有从池中借用连接,而是重用了已经持有的连接未关闭的EntityManager。

实际上,报告了此问题的很多重复项:http ://code.google.com/p/google-guice/issues/list?can=1&q=UnitOfWork

于 2012-10-26T12:41:36.527 回答
5

一个狂野的镜头:这里的代码表明,validationInterval也检查了testOnBorrow

由于您将此值从默认的 30 秒设置为 5 分钟,这意味着在数据库断开连接后的 5 分钟内,您仍然可以获得该陈旧连接。如果您的数据库超时时间少于 5 分钟...运气不好。

为了测试这个理论,你可以设置validationInterval一个荒谬的低值。

如果这有帮助(阅读:我们找到了正确的旋钮),您应该至少将其设置为比 DB 超时更短的时间。因此,当数据库决定丢弃空闲连接时,下层validationInterval将确保在下一次借用之前检查该连接。由于数据库服务器重新启动(即没有超时)而关闭的连接不会受到此解决方案的影响,但至少恢复正常状态的时间也较短。

注意:我刚刚向 Google 询问了代码。我不知道这是实际代码还是古代代码。

于 2012-10-16T20:10:28.877 回答
0

如果你修改了你META-INF/context.xml的包含validationQuery,Tomcat 很可能会缓存旧的定义在conf/engine/host/webapp.xml. 关闭 Tomcat,删除该文件,然后重新启动 Tomcat。work在 Tomcat 关闭时删除该目录也没有什么坏处。

于 2012-10-16T14:30:57.257 回答