Caused by: java.sql.SQLException: Connection not established 错误

liu · 2022 年4 月 25 日 07:40

我们项目之前一直使用没问题，但是突然从几天开始出现下面错误，重启中间件后恢复正常，用户在用一段时间后又会出现问题，时间可能是半天或者一天，报错不显示具体业务代码逻问题，目前我们排查不出原因，中间件数据库连接池没有被用完，数据库也没有问题，希望帮助排查下原因，我会上传完整日志连接链接: https://pan.baidu.com/s/1usXKi9CJ-hNp4coIsKJQLA?pwd=jhvx

2022-04-21 16:57:43.755 ERROR [cuba_core_scheduler-1] org.springframework.scheduling.support.TaskUtils$LoggingErrorHandler - Unexpected error occurred in scheduled task.
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) org.eclipse.persistence.exceptions.DatabaseException: 
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) Internal Exception: java.sql.SQLException: Connection not established
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) Error Code: -79730
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.eclipse.persistence.exceptions.DatabaseException.sqlException(DatabaseException.java:342) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.eclipse.persistence.internal.databaseaccess.DatabaseAccessor.processExceptionForCommError(DatabaseAccessor.java:1694) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.eclipse.persistence.internal.databaseaccess.DatabaseAccessor.basicRollbackTransaction(DatabaseAccessor.java:1792) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.eclipse.persistence.internal.databaseaccess.DatasourceAccessor.rollbackTransaction(DatasourceAccessor.java:690) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.eclipse.persistence.internal.databaseaccess.DatabaseAccessor.rollbackTransaction(DatabaseAccessor.java:1776) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.eclipse.persistence.internal.sessions.AbstractSession.basicRollbackTransaction(AbstractSession.java:828) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.eclipse.persistence.sessions.server.ClientSession.basicRollbackTransaction(ClientSession.java:209) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.eclipse.persistence.internal.sessions.AbstractSession.rollbackTransaction(AbstractSession.java:3965) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.rollbackTransaction(UnitOfWorkImpl.java:4815) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.eclipse.persistence.internal.sessions.RepeatableWriteUnitOfWork.rollbackTransaction(RepeatableWriteUnitOfWork.java:534) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.release(UnitOfWorkImpl.java:4615) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.eclipse.persistence.internal.jpa.transaction.EntityTransactionImpl.rollback(EntityTransactionImpl.java:189) ~[org.eclipse.persistence.jpa-2.7.3-6-cuba.jar:na]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.springframework.orm.jpa.JpaTransactionManager.doRollback(JpaTransactionManager.java:559) ~[spring-orm-5.1.6.RELEASE.jar:5.1.6.RELEASE]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.springframework.transaction.support.AbstractPlatformTransactionManager.processRollback(AbstractPlatformTransactionManager.java:838) ~[spring-tx-5.1.6.RELEASE.jar:5.1.6.RELEASE]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.springframework.transaction.support.AbstractPlatformTransactionManager.rollback(AbstractPlatformTransactionManager.java:812) ~[spring-tx-5.1.6.RELEASE.jar:5.1.6.RELEASE]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at com.haulmont.cuba.core.sys.TransactionImpl.end(TransactionImpl.java:125) ~[cuba-core-7.1.1.jar:7.1.1]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at com.haulmont.cuba.core.app.scheduling.DbBasedCoordinator.begin(DbBasedCoordinator.java:76) ~[cuba-core-7.1.1.jar:7.1.1]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at com.haulmont.cuba.core.app.scheduling.Scheduling.processScheduledTasks(Scheduling.java:113) ~[cuba-core-7.1.1.jar:7.1.1]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at com.haulmont.cuba.core.app.scheduling.Scheduling.processScheduledTasks(Scheduling.java:95) ~[cuba-core-7.1.1.jar:7.1.1]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at sun.reflect.GeneratedMethodAccessor194.invoke(Unknown Source) ~[na:na]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_161]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_161]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.springframework.scheduling.support.ScheduledMethodRunnable.run(ScheduledMethodRunnable.java:84) ~[spring-context-5.1.6.RELEASE.jar:5.1.6.RELEASE]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.springframework.scheduling.support.DelegatingErrorHandlingRunnable.run(DelegatingErrorHandlingRunnable.java:54) ~[spring-context-5.1.6.RELEASE.jar:5.1.6.RELEASE]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [na:1.8.0_161]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) [na:1.8.0_161]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180) [na:1.8.0_161]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294) [na:1.8.0_161]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at com.haulmont.cuba.core.sys.CubaThreadPoolTaskScheduler$TaskDecorator.run(CubaThreadPoolTaskScheduler.java:121) [cuba-global-7.1.1.jar:7.1.1]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_161]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_161]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at java.lang.Thread.run(Thread.java:748) [na:1.8.0_161]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) Caused by: java.sql.SQLException: Connection not established
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at com.informix.util.IfxErrMsg.getSQLException(IfxErrMsg.java:408) ~[na:na]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at com.informix.jdbc.IfxSqliConnect.rollback(IfxSqliConnect.java:2140) ~[na:na]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.jboss.jca.adapters.jdbc.BaseWrapperManagedConnection.jdbcRollback(BaseWrapperManagedConnection.java:1106) ~[na:na]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.jboss.jca.adapters.jdbc.WrappedConnection.rollback(WrappedConnection.java:924) ~[na:na]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at com.haulmont.cuba.core.sys.jdbc.ProxyConnection.rollback(ProxyConnection.java:68) ~[cuba-core-7.1.1.jar:7.1.1]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	at org.eclipse.persistence.internal.databaseaccess.DatabaseAccessor.basicRollbackTransaction(DatabaseAccessor.java:1786) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-21 16:57:43,755 INFO  [stdout] (cuba_core_scheduler-1) 	... 29 common frames omitted

AnJingjing · 2022 年4 月 25 日 08:42

项目的部署架构是怎样？用的什么中间件？看了 log，似乎都是在 BPM 的后台任务中报的错，项目的界面能正常访问吗？

liu · 2022 年4 月 25 日 09:15

我们用的cuba版本是7.1.1,部署架构是前端块和后端块分离部署，各两台服务器，中间件用的wildfly，负载均衡用的apache，一旦出先次错误只能显示出登录页，登录会报错，两个后端服务如果只有一个报错，别一个可以正常使用，如果都有问题就彻底无法登陆了。如果是BPM任务报错怎么定位是那个任务报出来的？谢谢

AnJingjing · 2022 年4 月 25 日 10:03

好的，我们这边这种部署架构的经验不多。在英文论坛提了帖子，也联系了开发让他们有时间先看看你的问题。

AnJingjing · 2022 年4 月 25 日 12:34

你看看这个跟你的问题相关么？提供的方案是：

Upgrade to the next fixpack - 12.10.xC9

似乎是要升级 INFORMIX SERVER

https://www.ibm.com/support/pages/apar/IT18401

liu · 2022 年4 月 27 日 09:23

今天我尝试升级了最新的数据库驱动，但是问题依旧存在，从日志上看首次产生是一个定时任务执行后出现的，我现在怎么能确定这个cuba的定时任务是哪个任务呢？我怀疑这个定时任务有BUG，请帮帮忙吧，我们已经被用户骂了好几天了

2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) Internal Exception: java.sql.SQLException: Connection not established
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) Error Code: -79730
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.eclipse.persistence.exceptions.DatabaseException.sqlException(DatabaseException.java:342) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.eclipse.persistence.internal.databaseaccess.DatabaseAccessor.processExceptionForCommError(DatabaseAccessor.java:1694) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.eclipse.persistence.internal.databaseaccess.DatabaseAccessor.basicRollbackTransaction(DatabaseAccessor.java:1792) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.eclipse.persistence.internal.databaseaccess.DatasourceAccessor.rollbackTransaction(DatasourceAccessor.java:690) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.eclipse.persistence.internal.databaseaccess.DatabaseAccessor.rollbackTransaction(DatabaseAccessor.java:1776) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.eclipse.persistence.internal.sessions.AbstractSession.basicRollbackTransaction(AbstractSession.java:828) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.eclipse.persistence.sessions.server.ClientSession.basicRollbackTransaction(ClientSession.java:209) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.eclipse.persistence.internal.sessions.AbstractSession.rollbackTransaction(AbstractSession.java:3965) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.rollbackTransaction(UnitOfWorkImpl.java:4815) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.eclipse.persistence.internal.sessions.RepeatableWriteUnitOfWork.rollbackTransaction(RepeatableWriteUnitOfWork.java:534) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.release(UnitOfWorkImpl.java:4615) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.eclipse.persistence.internal.jpa.transaction.EntityTransactionImpl.rollback(EntityTransactionImpl.java:189) ~[org.eclipse.persistence.jpa-2.7.3-6-cuba.jar:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.springframework.orm.jpa.JpaTransactionManager.doRollback(JpaTransactionManager.java:559) ~[spring-orm-5.1.6.RELEASE.jar:5.1.6.RELEASE]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.springframework.transaction.support.AbstractPlatformTransactionManager.processRollback(AbstractPlatformTransactionManager.java:838) ~[spring-tx-5.1.6.RELEASE.jar:5.1.6.RELEASE]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.springframework.transaction.support.AbstractPlatformTransactionManager.rollback(AbstractPlatformTransactionManager.java:812) ~[spring-tx-5.1.6.RELEASE.jar:5.1.6.RELEASE]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at com.haulmont.cuba.core.sys.TransactionImpl.end(TransactionImpl.java:125) ~[cuba-core-7.1.1.jar:7.1.1]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at com.haulmont.cuba.core.app.scheduling.DbBasedCoordinator.begin(DbBasedCoordinator.java:76) ~[cuba-core-7.1.1.jar:7.1.1]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at com.haulmont.cuba.core.app.scheduling.Scheduling.processScheduledTasks(Scheduling.java:113) ~[cuba-core-7.1.1.jar:7.1.1]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at com.haulmont.cuba.core.app.scheduling.Scheduling.processScheduledTasks(Scheduling.java:95) ~[cuba-core-7.1.1.jar:7.1.1]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at sun.reflect.GeneratedMethodAccessor273.invoke(Unknown Source) ~[na:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_161]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_161]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.springframework.scheduling.support.ScheduledMethodRunnable.run(ScheduledMethodRunnable.java:84) ~[spring-context-5.1.6.RELEASE.jar:5.1.6.RELEASE]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.springframework.scheduling.support.DelegatingErrorHandlingRunnable.run(DelegatingErrorHandlingRunnable.java:54) ~[spring-context-5.1.6.RELEASE.jar:5.1.6.RELEASE]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [na:1.8.0_161]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) [na:1.8.0_161]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180) [na:1.8.0_161]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294) [na:1.8.0_161]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at com.haulmont.cuba.core.sys.CubaThreadPoolTaskScheduler$TaskDecorator.run(CubaThreadPoolTaskScheduler.java:121) [cuba-global-7.1.1.jar:7.1.1]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_161]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_161]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at java.lang.Thread.run(Thread.java:748) [na:1.8.0_161]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) Caused by: java.sql.SQLException: Connection not established
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at com.informix.util.IfxErrMsg.buildExceptionWithMessage(IfxErrMsg.java:422) ~[na:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at com.informix.util.IfxErrMsg.buildException(IfxErrMsg.java:397) ~[na:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at com.informix.util.IfxErrMsg.getSQLException(IfxErrMsg.java:379) ~[na:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at com.informix.jdbc.IfxSqliConnect.rollback(IfxSqliConnect.java:2112) ~[na:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.jboss.jca.adapters.jdbc.BaseWrapperManagedConnection.jdbcRollback(BaseWrapperManagedConnection.java:1106) ~[na:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.jboss.jca.adapters.jdbc.WrappedConnection.rollback(WrappedConnection.java:924) ~[na:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at com.haulmont.cuba.core.sys.jdbc.ProxyConnection.rollback(ProxyConnection.java:68) ~[cuba-core-7.1.1.jar:7.1.1]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at org.eclipse.persistence.internal.databaseaccess.DatabaseAccessor.basicRollbackTransaction(DatabaseAccessor.java:1786) ~[org.eclipse.persistence.core-2.7.3-6-cuba.jar:na]
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	... 29 common frames omitted

AnJingjing · 2022 年4 月 27 日 09:35

定时任务本身的信息没有在日志中，但是你看看下面的日志，给出了执行的查询语句：

com.haulmont.cuba.security.app.UserSessions$UserSessionInfo: 6ae1f5d5-12ac-2a48-393a-9cfe9c65e799 [zhengliwen], since: Thu Apr 21 16:29:41 CST 2022, lastUsed: Thu Apr 21 16:33:04 CST 2022 (100657 bytes)
2022-04-21 16:33:02,128 INFO  [stdout] (default task-17) 2022-04-21 16:33:02.128 DEBUG [default task-17/ajyth-core/zhangding] com.haulmont.cuba.core.app.RdbmsStore - getCount: metaClass=jpm_ToolBaseInfo, query=select e from jpm_ToolBaseInfo e where e.scrapState.code = '0' order by e.toolTestCycle, e.toolValueLow
2022-04-21 16:33:02,409 INFO  [stdout] (default task-28) 2022-04-21 16:33:02.409 DEBUG [default task-28/ajyth-core/yankailong] com.haulmont.cuba.core.app.RdbmsStore - loadList: metaClass=uap_News, view=com.sjzl.uap.entity.News/news-view, query=select e from uap_News e,IN(e.agency) p where p =:agency and e.id not in (select ob.newsId from uap_ObtainedNews ob where ob.userId =:userId or (ob.userId is null and ob.read=:read))
2022-04-21 16:33:02,421 INFO  [stdout] (default task-28) 2022-04-21 16:33:02.421 DEBUG [default task-28/ajyth-core/yankailong] com.haulmont.cuba.core.app.RdbmsStore - loadList: metaClass=uap_News, view=com.sjzl.uap.entity.News/news-view, query=select e from uap_News e,IN(e.user) p where p.login =:login and e.id not in (select ob.newsId from uap_ObtainedNews ob where ob.userId =:userId or (ob.userId is null and ob.read=:read))
2022-04-21 16:33:02,430 INFO  [stdout] (default task-28) 2022-04-21 16:33:02.430 DEBUG [default task-28/ajyth-core/yankailong] com.haulmont.cuba.core.app.RdbmsStore - loadList: metaClass=uap_News, view=com.sjzl.uap.entity.News/news-view, query=select e from uap_News e where e.range='全员' and e.id not in (select ob.newsId from uap_ObtainedNews ob where ob.userId =:userId or (ob.userId is null and ob.read=:read))
2022-04-21 16:33:02,476 INFO  [stdout] (default task-28) 2022-04-21 16:33:02.476 DEBUG [default task-28/ajyth-core/yankailong] com.haulmont.cuba.core.app.RdbmsStore - loadList: metaClass=uap_DataDictionaryDetail, view=com.sjzl.uap.entity.DataDictionaryDetail/dataDictionaryDetail-view, query=select e from uap_DataDictionaryDetail e where e.dataDictionary.code=:ddCode order by e.code asc
2022-04-21 16:33:02,480 INFO  [stdout] (default task-28) 2022-04-21 16:33:02.480 DEBUG [default task-28/ajyth-core/yankailong] com.haulmont.cuba.core.app.RdbmsStore - loadList: metaClass=ibm_StatuteInfo, view=impc.aj.generalbizmgt.entity.statutemanage.StatuteInfo/statuteInfo-view, query=select e from ibm_StatuteInfo e where e.category.code = :type order by e.createTs desc, max=10
2022-04-21 16:33:02,532 INFO  [stdout] (default task-28) 2022-04-21 16:33:02.532 DEBUG [default task-28/ajyth-core/yankailong] com.haulmont.cuba.core.app.RdbmsStore - loadList: metaClass=ibm_StatuteInfo, view=impc.aj.generalbizmgt.entity.statutemanage.StatuteInfo/statuteInfo-view, query=select e from ibm_StatuteInfo e where e.category.code = :type order by e.createTs desc, max=10
2022-04-21 16:33:02,617 INFO  [stdout] (default task-28) 2022-04-21 16:33:02.617 DEBUG [default task-28/ajyth-core/yankailong] com.haulmont.cuba.core.app.RdbmsStore - loadList: metaClass=ibm_StatuteInfo, view=impc.aj.generalbizmgt.entity.statutemanage.StatuteInfo/statuteInfo-view, query=select e from ibm_StatuteInfo e where e.category.code = :type order by e.createTs desc, max=10
2022-04-21 16:33:02,661 INFO  [stdout] (default task-28) 2022-04-21 16:33:02.661 DEBUG [default task-28/ajyth-core/yankailong] com.haulmont.cuba.core.app.RdbmsStore - loadList: metaClass=ibm_SafeDynamicNewsBill, view=impc.aj.generalbizmgt.entity.safedynamic.SafeDynamicNewsBill/safeDynamicNewsBill-view, query=select e from ibm_SafeDynamicNewsBill e where e.types = :type and e.newsStatus.code = '02' order by e.createTs desc, max=10
2022-04-21 16:33:02,756 INFO  [stdout] (cuba_core_scheduler-5) 2022-04-21 16:33:02.755 ERROR [cuba_core_scheduler-5] org.springframework.scheduling.support.TaskUtils$LoggingErrorHandler - Unexpected error occurred in scheduled task.
2022-04-21 16:33:02,756 INFO  [stdout] (cuba_core_scheduler-5) org.eclipse.persistence.exceptions.DatabaseException: 
2022-04-21 16:33:02,756 INFO  [stdout] (cuba_core_scheduler-5) Internal Exception: java.sql.SQLException: Connection not established

类似这样的日志，还有下面这个，提到了一个流程定义没找到：

2022-04-21 16:33:05,718 INFO  [stdout] (default task-28) 2022-04-21 16:33:05.718 INFO  [default task-28/ajyth-core/sghggydl] com.haulmont.cuba.core.sys.QueryImpl - null----
2022-04-21 16:33:05,720 INFO  [stdout] (default task-28) 2022-04-21 16:33:05.720 DEBUG [default task-28/ajyth-core/sghggydl] com.sjzl.uap.service.BpmService - Process definition with code '施工安全市局三措一案流程-50002000' not found
2022-04-21 16:33:05,721 INFO  [stdout] (default task-28) 2022-04-21 16:33:05.721 INFO  [default task-28/ajyth-core/sghggydl] com.haulmont.cuba.core.sys.QueryImpl - null----
2022-04-21 16:33:05,756 INFO  [stdout] (cuba_core_scheduler-7) 2022-04-21 16:33:05.756 ERROR [cuba_core_scheduler-7] org.springframework.scheduling.support.TaskUtils$LoggingErrorHandler - Unexpected error occurred in scheduled task.
2022-04-21 16:33:05,756 INFO  [stdout] (cuba_core_scheduler-7) org.eclipse.persistence.exceptions.DatabaseException: 
2022-04-21 16:33:05,756 INFO  [stdout] (cuba_core_scheduler-7) Internal Exception: java.sql.SQLException: Connection not established

可以尝试修改看看。还有上面我回帖中提到的 InforMix，得确定升级一下，感觉跟这个有关，错误堆栈是从这个库发起的：

2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) Caused by: java.sql.SQLException: Connection not established
2022-04-27 15:49:42,009 INFO  [stdout] (cuba_core_scheduler-7) 	at com.informix.util.IfxErrMsg.buildExceptionWithMessage(IfxErrMsg.java:422) ~[na:na]

liu · 2022 年4 月 27 日 09:47

cuba_core_scheduler-7 这个是干什么的定时任务，打出sql语句的是default task-28吧，这个是我们的业务逻辑，没问题的，还有那个流程定义没找到是正常的，那是我们业务判断