Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Another instance of dead pool, no new connection can be created #2197

Open
KazzmanK opened this issue May 3, 2024 · 0 comments
Open

Another instance of dead pool, no new connection can be created #2197

KazzmanK opened this issue May 3, 2024 · 0 comments

Comments

@KazzmanK
Copy link

KazzmanK commented May 3, 2024

Once again, after VM was touched by administrators , connection pool become invalid. All connections are gone, new connections could not be created.

com.zaxxer:HikariCP:jar:5.0.1
com.microsoft.sqlserver:mssql-jdbc:jar:12.4.2.jre11

Here are the logs, my guesses is

  1. create connection hangs inside pool entry creator. 17 active connection adders are in unknown state
  2. driver issue, if it reuses connections inside and does not care of dead connections somehow.

Logs (with translation of localized messages)

FIRST STRIKE

2024-05-01 06:32:47.161 |T| WARN  | scheduling-1         | hikari.pool.PoolBase | isConnectionDead          | 179  | NmaHikariCP - Failed to validate connection ConnectionID:12233 ClientConnectionId: 4cfe22cd-8675-4d65-8c29-ed3948c97ac9 (Соединение закрыто.  <--**Connection closed**). Possibly consider using a shorter maxLifetime value.
2024-05-01 06:32:47.171 |T| WARN  | 65-8c29-ed3948c97ac9 | rver.jdbc.TDSCommand | log                       | 7505 | TDSCommand@11052571 (SQLServerStatement:208895 executeXXX): Command could not be timed out. Reason: Socket closed
2024-05-01 06:32:52.537 |T| WARN  | scheduling-1         | hikari.pool.PoolBase | isConnectionDead          | 179  | NmaHikariCP - Failed to validate connection ConnectionID:12235 ClientConnectionId: ba201e2b-2bdf-4fb8-b4b6-d48f708b678c (Соединение закрыто.). Possibly consider using a shorter maxLifetime value.
2024-05-01 06:32:57.539 |T| WARN  | scheduling-1         | hikari.pool.PoolBase | isConnectionDead          | 179  | NmaHikariCP - Failed to validate connection ConnectionID:12236 ClientConnectionId: dc432869-e1e8-4bad-8253-58b6e96f291d (Соединение закрыто.). Possibly consider using a shorter maxLifetime value.
2024-05-01 06:33:02.585 |T| WARN  | scheduling-1         | hikari.pool.PoolBase | isConnectionDead          | 179  | NmaHikariCP - Failed to validate connection ConnectionID:12237 ClientConnectionId: 6f011ed0-ad77-413c-ac88-00cd3c72b0c3 (Соединение закрыто.). Possibly consider using a shorter maxLifetime value.
2024-05-01 06:33:02.621 |T| WARN  | 3c-ac88-00cd3c72b0c3 | rver.jdbc.TDSCommand | log                       | 7505 | TDSCommand@bf2e1c5 (SQLServerStatement:208898 executeXXX): Command could not be timed out. Reason: Socket closed
2024-05-01 06:33:07.763 |T| WARN  | scheduling-1         | hikari.pool.PoolBase | isConnectionDead          | 179  | NmaHikariCP - Failed to validate connection ConnectionID:12240 ClientConnectionId: 6ee307d4-aaba-4184-9784-456dd375d095 (Соединение закрыто.). Possibly consider using a shorter maxLifetime value.
2024-05-01 06:33:12.903 |T| WARN  | scheduling-1         | hikari.pool.PoolBase | isConnectionDead          | 179  | NmaHikariCP - Failed to validate connection ConnectionID:12241 ClientConnectionId: a271b289-d3cd-41bf-87c5-b0287e9dcaa0 (Соединение закрыто.). Possibly consider using a shorter maxLifetime value.
2024-05-01 06:33:12.982 |T| WARN  | scheduling-1         HERE IS MY CODE ERROR LOG 
com.microsoft.sqlserver.jdbc.SQLServerException: Соединение закрыто. <--**Connection closed**
	at com.microsoft.sqlserver.jdbc.SQLServerException.makeFromDriverError(SQLServerException.java:231)
	at com.microsoft.sqlserver.jdbc.SQLServerConnection.checkClosed(SQLServerConnection.java:1728)
	at com.microsoft.sqlserver.jdbc.SQLServerConnection.setNetworkTimeout(SQLServerConnection.java:6959)
	at com.zaxxer.hikari.pool.PoolBase.setNetworkTimeout(PoolBase.java:561)
	at com.zaxxer.hikari.pool.PoolBase.isConnectionDead(PoolBase.java:168)
	at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:170)
	... 56 common frames omitted
Wrapped by: java.sql.SQLTransientConnectionException: NmaHikariCP - Connection is not available, request timed out after 30822ms.
	at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:696)
	at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:181)
	at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:146)
	at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:128)
	at org.springframework.jdbc.datasource.DataSourceUtils.fetchConnection(DataSourceUtils.java:160)
	at org.springframework.jdbc.datasource.DataSourceUtils.doGetConnection(DataSourceUtils.java:118)
	at org.springframework.jdbc.datasource.DataSourceUtils.getConnection(DataSourceUtils.java:81)
	... 51 common frames omitted
Wrapped by: org.springframework.jdbc.CannotGetJdbcConnectionException: Failed to obtain JDBC Connection
	at org.springframework.jdbc.datasource.DataSourceUtils.getConnection(DataSourceUtils.java:84)
	at org.springframework.jdbc.core.JdbcTemplate.execute(JdbcTemplate.java:388)
	at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:476)
	at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:486)
	*****
	STACK MASKED
	*****

OTHER LOG LINES

2024-05-01 06:33:19.655 |T| WARN  | 17000-exec-37-[.bEq] | hikari.pool.PoolBase | isConnectionDead          | 179  | NmaHikariCP - Failed to validate connection ConnectionID:12242 ClientConnectionId: 43d2c5d5-7b5b-4695-9f67-af9291abc2ca (Соединение закрыто.  <--**Connection closed**). Possibly consider using a shorter maxLifetime value.
2024-05-01 06:33:21.030 |T| WARN  | 17000-exec-17-[.CLB] | hikari.pool.PoolBase | isConnectionDead          | 179  | NmaHikariCP - Failed to validate connection ConnectionID:12243 ClientConnectionId: dbe64df2-5967-4324-9478-e72c9c219b5d (Соединение закрыто.). Possibly consider using a shorter maxLifetime value.
2024-05-01 06:33:21.055 |T| WARN  | 24-9478-e72c9c219b5d | rver.jdbc.TDSCommand | log                       | 7505 | TDSCommand@4417bfbc (SQLServerStatement:208902 executeXXX): Command could not be timed out. Reason: Socket closed
2024-05-01 06:33:24.706 |T| WARN  | 17000-exec-37-[.bEq] | hikari.pool.PoolBase | isConnectionDead          | 179  | NmaHikariCP - Failed to validate connection ConnectionID:12244 ClientConnectionId: c11601b2-8be8-43f3-b535-76e59b758b4a (Соединение закрыто.). Possibly consider using a shorter maxLifetime value.
2024-05-01 06:33:44.568 |T| WARN  | 17000-exec-37-[.bEq] | i.SqlExceptionHelper | logExceptions             | 145  | SQL Error: 0, SQLState: 08S01
2024-05-01 06:33:44.573 |T| ERROR | 17000-exec-37-[.bEq] | i.SqlExceptionHelper | logExceptions             | 150  | NmaHikariCP - Connection is not available, request timed out after 30000ms.
2024-05-01 06:33:44.574 |T| ERROR | 17000-exec-37-[.bEq] | i.SqlExceptionHelper | logExceptions             | 150  | Соединение закрыто.  <--**Connection closed**
2024-05-01 06:33:44.591 |T| ERROR | 17000-exec-37-[.bEq] | e.app.utils.LogUtils | logResponse               | 35   | ->-> Exception class: org.springframework.transaction.CannotCreateTransactionException ->-> Generated by request POST *******
{}
com.microsoft.sqlserver.jdbc.SQLServerException: Соединение закрыто. <--**Connection closed**
	at com.microsoft.sqlserver.jdbc.SQLServerException.makeFromDriverError(SQLServerException.java:231)
	at com.microsoft.sqlserver.jdbc.SQLServerConnection.checkClosed(SQLServerConnection.java:1728)
	at com.microsoft.sqlserver.jdbc.SQLServerConnection.setNetworkTimeout(SQLServerConnection.java:6959)
	at com.zaxxer.hikari.pool.PoolBase.setNetworkTimeout(PoolBase.java:561)
	at com.zaxxer.hikari.pool.PoolBase.isConnectionDead(PoolBase.java:168)
	at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:170)
	... 106 common frames omitted
Wrapped by: java.sql.SQLTransientConnectionException: NmaHikariCP - Connection is not available, request timed out after 30000ms.
	at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:696)
	at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:181)
	at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:146)
	at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:128)
	at org.hibernate.engine.jdbc.connections.internal.DatasourceConnectionProviderImpl.getConnection(DatasourceConnectionProviderImpl.java:122)
	at org.hibernate.internal.NonContextualJdbcConnectionAccess.obtainConnection(NonContextualJdbcConnectionAccess.java:38)
	at org.hibernate.resource.jdbc.internal.LogicalConnectionManagedImpl.acquireConnectionIfNeeded(LogicalConnectionManagedImpl.java:113)
	... 101 common frames omitted
Wrapped by: org.hibernate.exception.JDBCConnectionException: Unable to acquire JDBC Connection [NmaHikariCP - Connection is not available, request timed out after 30000ms.] [n/a]
	at org.hibernate.exception.internal.SQLExceptionTypeDelegate.convert(SQLExceptionTypeDelegate.java:51)
	at org.hibernate.exception.internal.StandardSQLExceptionConverter.convert(StandardSQLExceptionConverter.java:58)
	at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:108)
	at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:94)
	at org.hibernate.resource.jdbc.internal.LogicalConnectionManagedImpl.acquireConnectionIfNeeded(LogicalConnectionManagedImpl.java:116)
	at org.hibernate.resource.jdbc.internal.LogicalConnectionManagedImpl.getPhysicalConnection(LogicalConnectionManagedImpl.java:143)
	at org.springframework.orm.jpa.vendor.HibernateJpaDialect.beginTransaction(HibernateJpaDialect.java:164)
	at org.springframework.orm.jpa.JpaTransactionManager.doBegin(JpaTransactionManager.java:420)
	... 98 common frames omitted
Wrapped by: org.springframework.transaction.CannotCreateTransactionException: Could not open JPA EntityManager for transaction
	at org.springframework.orm.jpa.JpaTransactionManager.doBegin(JpaTransactionManager.java:466)
	at org.springframework.transaction.support.AbstractPlatformTransactionManager.startTransaction(AbstractPlatformTransactionManager.java:531)
	at org.springframework.transaction.support.AbstractPlatformTransactionManager.getTransaction(AbstractPlatformTransactionManager.java:405)
	at org.springframework.transaction.interceptor.TransactionAspectSupport.createTransactionIfNecessary(TransactionAspectSupport.java:610)
	at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:379)
	at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:119)
	at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184)
	at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.invoke(PersistenceExceptionTranslationInterceptor.java:137)
	at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184)
	at org.springframework.data.jpa.repository.support.CrudMethodMetadataPostProcessor$CrudMethodMetadataPopulatingMethodInterceptor.invoke(CrudMethodMetadataPostProcessor.java:164)
	at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184)
	at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:97)
	at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184)
	at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:249)
	at jdk.proxy2/jdk.proxy2.$Proxy175.findById(Unknown Source)
	*****
	STACK MASKED
	*****

OTHER LINES

2024-05-01 06:33:46.033 |T| WARN  | 17000-exec-17-[.CLB] | tractHealthIndicator | logExceptionIfPresent     | 94   | DataSource health check failed
com.microsoft.sqlserver.jdbc.SQLServerException: Соединение закрыто. <--**Connection closed**
	at com.microsoft.sqlserver.jdbc.SQLServerException.makeFromDriverError(SQLServerException.java:231)
	at com.microsoft.sqlserver.jdbc.SQLServerConnection.checkClosed(SQLServerConnection.java:1728)
	at com.microsoft.sqlserver.jdbc.SQLServerConnection.setNetworkTimeout(SQLServerConnection.java:6959)
	at com.zaxxer.hikari.pool.PoolBase.setNetworkTimeout(PoolBase.java:561)
	at com.zaxxer.hikari.pool.PoolBase.isConnectionDead(PoolBase.java:168)
	at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:170)
	at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:146)
	at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:128)
	at org.hibernate.engine.jdbc.connections.internal.DatasourceConnectionProviderImpl.getConnection(DatasourceConnectionProviderImpl.java:122)
	at org.hibernate.internal.NonContextualJdbcConnectionAccess.obtainConnection(NonContextualJdbcConnectionAccess.java:38)
	at org.hibernate.resource.jdbc.internal.LogicalConnectionManagedImpl.acquireConnectionIfNeeded(LogicalConnectionManagedImpl.java:113)
	at org.hibernate.resource.jdbc.internal.LogicalConnectionManagedImpl.getPhysicalConnection(LogicalConnectionManagedImpl.java:143)
	at org.springframework.orm.jpa.vendor.HibernateJpaDialect.beginTransaction(HibernateJpaDialect.java:164)
	at org.springframework.orm.jpa.JpaTransactionManager.doBegin(JpaTransactionManager.java:420)
	at org.springframework.transaction.support.AbstractPlatformTransactionManager.startTransaction(AbstractPlatformTransactionManager.java:531)
	at org.springframework.transaction.support.AbstractPlatformTransactionManager.getTransaction(AbstractPlatformTransactionManager.java:405)
	at org.springframework.transaction.interceptor.TransactionAspectSupport.createTransactionIfNecessary(TransactionAspectSupport.java:610)
	at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:379)
	at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:119)
	at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184)
	at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.invoke(PersistenceExceptionTranslationInterceptor.java:137)
	at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184)
	at org.springframework.data.jpa.repository.support.CrudMethodMetadataPostProcessor$CrudMethodMetadataPopulatingMethodInterceptor.invoke(CrudMethodMetadataPostProcessor.java:164)
	at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184)
	at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:97)
	at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184)
	at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:249)
	*****
	STACK MASKED
	*****
	... 39 common frames omitted
Wrapped by: java.sql.SQLTransientConnectionException: NmaHikariCP - Connection is not available, request timed out after 30001ms.
	at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:696)
	at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:181)
	at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:146)
	at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:128)
	at org.springframework.jdbc.datasource.DataSourceUtils.fetchConnection(DataSourceUtils.java:160)
	at org.springframework.jdbc.datasource.DataSourceUtils.doGetConnection(DataSourceUtils.java:118)
	at org.springframework.jdbc.datasource.DataSourceUtils.getConnection(DataSourceUtils.java:81)
	... 101 common frames omitted
Wrapped by: org.springframework.jdbc.CannotGetJdbcConnectionException: Failed to obtain JDBC Connection
	at org.springframework.jdbc.datasource.DataSourceUtils.getConnection(DataSourceUtils.java:84)
	at org.springframework.jdbc.core.JdbcTemplate.execute(JdbcTemplate.java:342)
	at org.springframework.boot.actuate.jdbc.DataSourceHealthIndicator.getProduct(DataSourceHealthIndicator.java:122)
	at org.springframework.boot.actuate.jdbc.DataSourceHealthIndicator.doDataSourceHealthCheck(DataSourceHealthIndicator.java:105)
	at org.springframework.boot.actuate.jdbc.DataSourceHealthIndicator.doHealthCheck(DataSourceHealthIndicator.java:100)
	at org.springframework.boot.actuate.health.AbstractHealthIndicator.health(AbstractHealthIndicator.java:82)
	at org.springframework.boot.actuate.health.HealthIndicator.getHealth(HealthIndicator.java:37)
	at org.springframework.boot.actuate.health.HealthEndpointWebExtension.getHealth(HealthEndpointWebExtension.java:94)
	at org.springframework.boot.actuate.health.HealthEndpointWebExtension.getHealth(HealthEndpointWebExtension.java:47)
	at org.springframework.boot.actuate.health.HealthEndpointSupport.getLoggedHealth(HealthEndpointSupport.java:172)
	at org.springframework.boot.actuate.health.HealthEndpointSupport.getContribution(HealthEndpointSupport.java:145)
	at org.springframework.boot.actuate.health.HealthEndpointSupport.getAggregateContribution(HealthEndpointSupport.java:156)
	at org.springframework.boot.actuate.health.HealthEndpointSupport.getContribution(HealthEndpointSupport.java:141)
	at org.springframework.boot.actuate.health.HealthEndpointSupport.getHealth(HealthEndpointSupport.java:110)
	at org.springframework.boot.actuate.health.HealthEndpointSupport.getHealth(HealthEndpointSupport.java:81)
	at org.springframework.boot.actuate.health.HealthEndpointWebExtension.health(HealthEndpointWebExtension.java:80)
	at org.springframework.boot.actuate.health.HealthEndpointWebExtension.health(HealthEndpointWebExtension.java:69)
	at jdk.internal.reflect.GeneratedMethodAccessor502.invoke(Unknown Source)
	*****
	STACK MASKED
	*****
	at java.base/java.lang.Thread.run(Thread.java:833)
2024-05-01 06:33:46.056 |T| WARN  | 17000-exec-17-[.CLB] | ealthEndpointSupport | getLoggedHealth           | 181  | Health contributor org.springframework.boot.actuate.jdbc.DataSourceHealthIndicator (db) took 30009ms to respond

*** A LOT OF OTHER LINES WITH EXCEPTIONS
*** DEBUG LEVEL FOR HIKARI SET

#logback.classic pattern: %d{yyyy-MM-dd HH:mm:ss.SSS, UTC} |T| %-5level | %-20.20thread | %-20.20class | %-25.25method | %-4.4line | %message%n%rEx
2024-05-01 07:00:10.599 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Before cleanup stats (total=0, active=0, idle=0, waiting=1)
2024-05-01 07:00:10.603 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - After cleanup  stats (total=0, active=0, idle=0, waiting=1)
2024-05-01 07:00:12.247 |T| DEBUG | scheduling-1         | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Timeout failure stats (total=0, active=0, idle=0, waiting=0)
2024-05-01 07:00:12.247 |T| WARN  | scheduling-1         | e.CustomCacheManager | reloadCache               | 135  | Cache refresh error. {}
com.microsoft.sqlserver.jdbc.SQLServerException: Соединение закрыто. <--**Connection closed**
	at com.microsoft.sqlserver.jdbc.SQLServerException.makeFromDriverError(SQLServerException.java:231)
	at com.microsoft.sqlserver.jdbc.SQLServerConnection.checkClosed(SQLServerConnection.java:1728)
	at com.microsoft.sqlserver.jdbc.SQLServerConnection.setNetworkTimeout(SQLServerConnection.java:6959)
	at com.zaxxer.hikari.pool.PoolBase.setNetworkTimeout(PoolBase.java:561)
	at com.zaxxer.hikari.pool.PoolBase.isConnectionDead(PoolBase.java:168)
	at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:170)
	at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:146)
	at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:128)
	at org.hibernate.engine.jdbc.connections.internal.DatasourceConnectionProviderImpl.getConnection(DatasourceConnectionProviderImpl.java:122)
	***
	SAME STACK AS BEFORE
	***
	at java.base/java.lang.Thread.run(Thread.java:833)
2024-05-01 07:00:12.248 |T| DEBUG | scheduling-1         | kari.pool.HikariPool | addBagItem                | 335  | NmaHikariCP - Add connection elided, waiting=1, adders pending/running=17
2024-05-01 07:00:16.095 |T| DEBUG | 17000-exec-43-[.9op] | kari.pool.HikariPool | addBagItem                | 335  | NmaHikariCP - Add connection elided, waiting=2, adders pending/running=17
2024-05-01 07:00:40.605 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Before cleanup stats (total=0, active=0, idle=0, waiting=2)
2024-05-01 07:00:40.605 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - After cleanup  stats (total=0, active=0, idle=0, waiting=2)
2024-05-01 07:00:42.250 |T| DEBUG | scheduling-1         | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Timeout failure stats (total=0, active=0, idle=0, waiting=1)
2024-05-01 07:00:42.251 |T| DEBUG | scheduling-1         | kari.pool.HikariPool | addBagItem                | 335  | NmaHikariCP - Add connection elided, waiting=2, adders pending/running=17
2024-05-01 07:00:46.097 |T| DEBUG | 17000-exec-43-[.9op] | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Timeout failure stats (total=0, active=0, idle=0, waiting=1)
2024-05-01 07:00:46.097 |T| WARN  | 17000-exec-43-[.9op] | tractHealthIndicator | logExceptionIfPresent     | 94   | DataSource health check failed
2024-05-01 07:00:46.098 |T| WARN  | 17000-exec-43-[.9op] | ealthEndpointSupport | getLoggedHealth           | 181  | Health contributor org.springframework.boot.actuate.jdbc.DataSourceHealthIndicator (db) took 30003ms to respond
2024-05-01 07:01:10.608 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Before cleanup stats (total=0, active=0, idle=0, waiting=1)
2024-05-01 07:01:10.608 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - After cleanup  stats (total=0, active=0, idle=0, waiting=1)
2024-05-01 07:01:12.254 |T| DEBUG | scheduling-1         | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Timeout failure stats (total=0, active=0, idle=0, waiting=0)
2024-05-01 07:01:16.209 |T| DEBUG | 17000-exec-24-[.6rc] | kari.pool.HikariPool | addBagItem                | 335  | NmaHikariCP - Add connection elided, waiting=1, adders pending/running=17
2024-05-01 07:01:40.609 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Before cleanup stats (total=0, active=0, idle=0, waiting=1)
2024-05-01 07:01:40.609 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - After cleanup  stats (total=0, active=0, idle=0, waiting=1)
2024-05-01 07:01:42.234 |T| DEBUG | scheduling-1         | kari.pool.HikariPool | addBagItem                | 335  | NmaHikariCP - Add connection elided, waiting=2, adders pending/running=17
2024-05-01 07:01:46.211 |T| DEBUG | 17000-exec-24-[.6rc] | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Timeout failure stats (total=0, active=0, idle=0, waiting=1)
2024-05-01 07:01:46.212 |T| WARN  | 17000-exec-24-[.6rc] | tractHealthIndicator | logExceptionIfPresent     | 94   | DataSource health check failed
2024-05-01 07:01:46.213 |T| WARN  | 17000-exec-24-[.6rc] | ealthEndpointSupport | getLoggedHealth           | 181  | Health contributor org.springframework.boot.actuate.jdbc.DataSourceHealthIndicator (db) took 30003ms to respond
2024-05-01 07:02:10.611 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Before cleanup stats (total=0, active=0, idle=0, waiting=1)
2024-05-01 07:02:10.611 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - After cleanup  stats (total=0, active=0, idle=0, waiting=1)
2024-05-01 07:02:12.235 |T| DEBUG | scheduling-1         | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Timeout failure stats (total=0, active=0, idle=0, waiting=0)
2024-05-01 07:02:16.041 |T| DEBUG | 17000-exec-40-[.Tir] | kari.pool.HikariPool | addBagItem                | 335  | NmaHikariCP - Add connection elided, waiting=1, adders pending/running=17
#logback.classic pattern: %d{yyyy-MM-dd HH:mm:ss.SSS, UTC} |T| %-5level | %-20.20thread | %-20.20class | %-25.25method | %-4.4line | %message%n%rEx
2024-05-01 07:02:40.622 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Before cleanup stats (total=0, active=0, idle=0, waiting=1)
2024-05-01 07:02:40.622 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - After cleanup  stats (total=0, active=0, idle=0, waiting=1)
2024-05-01 07:02:42.243 |T| DEBUG | scheduling-1         | kari.pool.HikariPool | addBagItem                | 335  | NmaHikariCP - Add connection elided, waiting=2, adders pending/running=17
2024-05-01 07:02:46.053 |T| DEBUG | 17000-exec-40-[.Tir] | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Timeout failure stats (total=0, active=0, idle=0, waiting=1)
2024-05-01 07:02:46.053 |T| WARN  | 17000-exec-40-[.Tir] | tractHealthIndicator | logExceptionIfPresent     | 94   | DataSource health check failed
2024-05-01 07:02:46.055 |T| WARN  | 17000-exec-40-[.Tir] | ealthEndpointSupport | getLoggedHealth           | 181  | Health contributor org.springframework.boot.actuate.jdbc.DataSourceHealthIndicator (db) took 30014ms to respond
2024-05-01 07:03:10.635 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Before cleanup stats (total=0, active=0, idle=0, waiting=1)
2024-05-01 07:03:10.635 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - After cleanup  stats (total=0, active=0, idle=0, waiting=1)
2024-05-01 07:03:12.255 |T| DEBUG | scheduling-1         | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Timeout failure stats (total=0, active=0, idle=0, waiting=0)
2024-05-01 07:03:12.256 |T| WARN  | scheduling-1         | e.CustomCacheManager | reloadCache               | 135  | Cache positions refresh error. {}
com.microsoft.sqlserver.jdbc.SQLServerException: Соединение закрыто.
	at com.microsoft.sqlserver.jdbc.SQLServerException.makeFromDriverError(SQLServerException.java:231)
	at com.microsoft.sqlserver.jdbc.SQLServerConnection.checkClosed(SQLServerConnection.java:1728)
	at com.microsoft.sqlserver.jdbc.SQLServerConnection.setNetworkTimeout(SQLServerConnection.java:6959)
	at com.zaxxer.hikari.pool.PoolBase.setNetworkTimeout(PoolBase.java:561)
	at com.zaxxer.hikari.pool.PoolBase.isConnectionDead(PoolBase.java:168)
	at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:170)
	at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:146)
	at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:128)
	at org.hibernate.engine.jdbc.connections.internal.DatasourceConnectionProviderImpl.getConnection(DatasourceConnectionProviderImpl.java:122)
	at org.hibernate.internal.NonContextualJdbcConnectionAccess.obtainConnection(NonContextualJdbcConnectionAccess.java:38)
	at org.hibernate.resource.jdbc.internal.LogicalConnectionManagedImpl.acquireConnectionIfNeeded(LogicalConnectionManagedImpl.java:113)
	at org.hibernate.resource.jdbc.internal.LogicalConnectionManagedImpl.getPhysicalConnection(LogicalConnectionManagedImpl.java:143)
	at org.springframework.orm.jpa.vendor.HibernateJpaDialect.beginTransaction(HibernateJpaDialect.java:164)
	at org.springframework.orm.jpa.JpaTransactionManager.doBegin(JpaTransactionManager.java:420)
	at org.springframework.transaction.support.AbstractPlatformTransactionManager.startTransaction(AbstractPlatformTransactionManager.java:531)
	at org.springframework.transaction.support.AbstractPlatformTransactionManager.getTransaction(AbstractPlatformTransactionManager.java:405)
	at org.springframework.transaction.interceptor.TransactionAspectSupport.createTransactionIfNecessary(TransactionAspectSupport.java:610)
	at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:379)
	at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:119)
	at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184)
	at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.invoke(PersistenceExceptionTranslationInterceptor.java:137)
	at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184)
	at org.springframework.data.jpa.repository.support.CrudMethodMetadataPostProcessor$CrudMethodMetadataPopulatingMethodInterceptor.invoke(CrudMethodMetadataPostProcessor.java:164)
	at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184)
	at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:97)
	at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184)
	at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:249)
	**************************
... 1 common frames omitted
Wrapped by: java.sql.SQLTransientConnectionException: NmaHikariCP - Connection is not available, request timed out after 30001ms.
	at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:696)
	at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:181)
	at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:146)
	at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:128)
	at org.springframework.jdbc.datasource.DataSourceUtils.fetchConnection(DataSourceUtils.java:160)
	at org.springframework.jdbc.datasource.DataSourceUtils.doGetConnection(DataSourceUtils.java:118)
	at org.springframework.jdbc.datasource.DataSourceUtils.getConnection(DataSourceUtils.java:81)
	... 51 common frames omitted
Wrapped by: org.springframework.jdbc.CannotGetJdbcConnectionException: Failed to obtain JDBC Connection
	at org.springframework.jdbc.datasource.DataSourceUtils.getConnection(DataSourceUtils.java:84)
	at org.springframework.jdbc.core.JdbcTemplate.execute(JdbcTemplate.java:388)
	at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:476)
	at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:486)
	*******************
	at java.base/java.lang.Thread.run(Thread.java:833)
2024-05-01 07:03:16.181 |T| DEBUG | -17000-exec-5-[.FJL] | kari.pool.HikariPool | addBagItem                | 335  | NmaHikariCP - Add connection elided, waiting=1, adders pending/running=17
2024-05-01 07:03:39.863 |T| DEBUG | 17000-exec-38-[.mBV] | kari.pool.HikariPool | addBagItem                | 335  | NmaHikariCP - Add connection elided, waiting=2, adders pending/running=17
2024-05-01 07:03:40.646 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Before cleanup stats (total=0, active=0, idle=0, waiting=2)
2024-05-01 07:03:40.646 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - After cleanup  stats (total=0, active=0, idle=0, waiting=2)
2024-05-01 07:03:42.262 |T| DEBUG | scheduling-1         | kari.pool.HikariPool | addBagItem                | 335  | NmaHikariCP - Add connection elided, waiting=3, adders pending/running=17
2024-05-01 07:03:46.194 |T| DEBUG | -17000-exec-5-[.FJL] | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Timeout failure stats (total=0, active=0, idle=0, waiting=2)

***** SO ON

***** APP RESTART

#logback.classic pattern: %d{yyyy-MM-dd HH:mm:ss.SSS, UTC} |T| %-5level | %-20.20thread | %-20.20class | %-25.25method | %-4.4line | %message%n%rEx
2024-05-01 07:05:03.006 |T| INFO  | background-preinit   | nternal.util.Version | <clinit>                  | 21   | HV000001: Hibernate Validator 8.0.1.Final
2024-05-01 07:05:03.157 |T| INFO  | main                 | ot.StartupInfoLogger | logStarting               | 50   | Starting Application v3.0 using Java 17.0.7 with PID 7676 ()
2024-05-01 07:05:03.159 |T| INFO  | main                 | ot.SpringApplication | logStartupProfileInfo     | 653  | No active profile set, falling back to 1 default profile: "default"
2024-05-01 07:05:06.195 |T| INFO  | main                 | onfigurationDelegate | registerRepositoriesIn    | 139  | Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2024-05-01 07:05:06.346 |T| INFO  | main                 | onfigurationDelegate | registerRepositoriesIn    | 208  | Finished Spring Data repository scanning in 133 ms. Found 5 JPA repository interfaces.
2024-05-01 07:05:08.225 |T| INFO  | main                 | mcat.TomcatWebServer | initialize                | 108  | Tomcat initialized with port 17000 (http)
2024-05-01 07:05:08.243 |T| INFO  | main                 | logging.DirectJDKLog | log                       | 173  | Initializing ProtocolHandler ["http-nio-17000"]
2024-05-01 07:05:08.246 |T| INFO  | main                 | logging.DirectJDKLog | log                       | 173  | Starting service [Tomcat]
2024-05-01 07:05:08.246 |T| INFO  | main                 | logging.DirectJDKLog | log                       | 173  | Starting Servlet engine: [Apache Tomcat/10.1.16]
2024-05-01 07:05:08.335 |T| INFO  | main                 | logging.DirectJDKLog | log                       | 173  | Initializing Spring embedded WebApplicationContext
2024-05-01 07:05:08.336 |T| INFO  | main                 | erApplicationContext | pareWebApplicationContext | 296  | Root WebApplicationContext: initialization completed in 5032 ms
**************8
2024-05-01 07:05:11.272 |T| DEBUG | main                 | .hikari.HikariConfig | attemptFromContextLoader  | 968  | Driver class com.microsoft.sqlserver.jdbc.SQLServerDriver found in Thread context class loader TomcatEmbeddedWebappClassLoader
  context: *****
  delegate: true
----------> Parent Classloader:
org.springframework.boot.loader.launch.LaunchedClassLoader@1f17ae12

2024-05-01 07:05:11.486 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1100 | NmaHikariCP - configuration:
2024-05-01 07:05:11.493 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | allowPoolSuspension.............false
2024-05-01 07:05:11.494 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | autoCommit......................true
2024-05-01 07:05:11.494 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | catalog.........................none
2024-05-01 07:05:11.495 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | connectionInitSql...............none
2024-05-01 07:05:11.495 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | connectionTestQuery.............none
2024-05-01 07:05:11.495 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | connectionTimeout...............30000
2024-05-01 07:05:11.496 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | dataSource......................none
2024-05-01 07:05:11.496 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | dataSourceClassName.............none
2024-05-01 07:05:11.497 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | dataSourceJNDI..................none
2024-05-01 07:05:11.498 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | dataSourceProperties............{password=<masked>}
2024-05-01 07:05:11.498 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | driverClassName................."com.microsoft.sqlserver.jdbc.SQLServerDriver"
2024-05-01 07:05:11.499 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | exceptionOverrideClassName......none
2024-05-01 07:05:11.499 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | healthCheckProperties...........{}
2024-05-01 07:05:11.500 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | healthCheckRegistry.............none
2024-05-01 07:05:11.500 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | idleTimeout.....................600000
2024-05-01 07:05:11.500 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | initializationFailTimeout.......1
2024-05-01 07:05:11.501 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | isolateInternalQueries..........false
2024-05-01 07:05:11.501 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | jdbcUrl.........................jdbc:sqlserver://*********************
2024-05-01 07:05:11.502 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | keepaliveTime...................0
2024-05-01 07:05:11.502 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | leakDetectionThreshold..........0
2024-05-01 07:05:11.503 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | maxLifetime.....................1800000
2024-05-01 07:05:11.503 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | maximumPoolSize.................20
2024-05-01 07:05:11.503 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | metricRegistry..................none
2024-05-01 07:05:11.504 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | metricsTrackerFactory...........none
2024-05-01 07:05:11.504 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | minimumIdle.....................10
2024-05-01 07:05:11.505 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | password........................<masked>
2024-05-01 07:05:11.505 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | poolName........................"NmaHikariCP"
2024-05-01 07:05:11.505 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | readOnly........................false
2024-05-01 07:05:11.506 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | registerMbeans..................false
2024-05-01 07:05:11.506 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | scheduledExecutor...............none
2024-05-01 07:05:11.507 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | schema..........................none
2024-05-01 07:05:11.507 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | threadFactory...................internal
2024-05-01 07:05:11.508 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | transactionIsolation............default
2024-05-01 07:05:11.508 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | username........................*********
2024-05-01 07:05:11.508 |T| DEBUG | main                 | .hikari.HikariConfig | logConfiguration          | 1132 | validationTimeout...............5000
2024-05-01 07:05:11.508 |T| INFO  | main                 | ari.HikariDataSource | getConnection             | 110  | NmaHikariCP - Starting...
2024-05-01 07:05:12.402 |T| INFO  | main                 | kari.pool.HikariPool | checkFailFast             | 565  | NmaHikariCP - Added connection ConnectionID:1 ClientConnectionId: c1b56dec-ba8b-442b-9cb2-f23bc7f3d9ab
2024-05-01 07:05:12.406 |T| INFO  | main                 | ari.HikariDataSource | getConnection             | 123  | NmaHikariCP - Start completed.
2024-05-01 07:05:12.507 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Before cleanup stats (total=1, active=0, idle=1, waiting=0)
2024-05-01 07:05:12.521 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - After cleanup  stats (total=1, active=0, idle=1, waiting=0)
2024-05-01 07:05:12.534 |T| INFO  | main                 | ernal.util.LogHelper | ersistenceUnitInformation | 31   | HHH000204: Processing PersistenceUnitInfo [name: default]
2024-05-01 07:05:12.560 |T| DEBUG | iCP connection adder | ool$PoolEntryCreator | call                      | 738  | NmaHikariCP - Added connection ConnectionID:2 ClientConnectionId: 709e31b1-7a7a-443b-b29c-5f8c187a4749
2024-05-01 07:05:12.611 |T| DEBUG | iCP connection adder | ool$PoolEntryCreator | call                      | 738  | NmaHikariCP - Added connection ConnectionID:3 ClientConnectionId: 16d882ee-78f2-494b-a42e-dfaa05b15454
2024-05-01 07:05:12.675 |T| DEBUG | iCP connection adder | ool$PoolEntryCreator | call                      | 738  | NmaHikariCP - Added connection ConnectionID:4 ClientConnectionId: cdd0b546-a437-44eb-b7a2-d6f7c6f7d03a
2024-05-01 07:05:12.718 |T| DEBUG | iCP connection adder | ool$PoolEntryCreator | call                      | 738  | NmaHikariCP - Added connection ConnectionID:5 ClientConnectionId: 76e010ed-9270-4ceb-be3a-a37bf3512c46
2024-05-01 07:05:12.756 |T| INFO  | main                 | rg.hibernate.Version | logVersion                | 44   | HHH000412: Hibernate ORM core version 6.3.1.Final
2024-05-01 07:05:12.771 |T| DEBUG | iCP connection adder | ool$PoolEntryCreator | call                      | 738  | NmaHikariCP - Added connection ConnectionID:6 ClientConnectionId: d8b12052-a470-497f-95b2-b6b291d85d75
2024-05-01 07:05:12.820 |T| DEBUG | iCP connection adder | ool$PoolEntryCreator | call                      | 738  | NmaHikariCP - Added connection ConnectionID:7 ClientConnectionId: d1b7f848-83e2-40e5-9b80-e3b82263f838
2024-05-01 07:05:12.865 |T| DEBUG | iCP connection adder | ool$PoolEntryCreator | call                      | 738  | NmaHikariCP - Added connection ConnectionID:8 ClientConnectionId: 7dca2c66-e691-4c6a-8773-422550e9054d
2024-05-01 07:05:12.883 |T| INFO  | main                 | gionFactoryInitiator | initiateService           | 50   | HHH000026: Second-level cache disabled
2024-05-01 07:05:12.908 |T| DEBUG | iCP connection adder | ool$PoolEntryCreator | call                      | 738  | NmaHikariCP - Added connection ConnectionID:9 ClientConnectionId: 57bffd7b-0c8b-4ae9-bb7b-e052eb1622f0
2024-05-01 07:05:12.948 |T| DEBUG | iCP connection adder | ool$PoolEntryCreator | call                      | 738  | NmaHikariCP - Added connection ConnectionID:10 ClientConnectionId: cf88428a-ed05-4b0d-83f2-b8f634b35920
2024-05-01 07:05:12.959 |T| DEBUG | iCP connection adder | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - After adding stats (total=10, active=0, idle=10, waiting=0)
2024-05-01 07:05:13.545 |T| INFO  | main                 | gPersistenceUnitInfo | addTransformer            | 87   | No LoadTimeWeaver setup: ignoring JPA class transformer
2024-05-01 07:05:15.693 |T| INFO  | main                 | JtaPlatformInitiator | initiateService           | 58   | HHH000489: No JTA platform available (set 'hibernate.transaction.jta.platform' to enable JTA platform integration)
2024-05-01 07:05:42.535 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Before cleanup stats (total=10, active=1, idle=9, waiting=0)
2024-05-01 07:05:42.536 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - After cleanup  stats (total=10, active=1, idle=9, waiting=0)
2024-05-01 07:05:42.586 |T| DEBUG | iCP connection adder | ool$PoolEntryCreator | call                      | 738  | NmaHikariCP - Added connection ConnectionID:11 ClientConnectionId: cfeb5eb8-a2e6-4421-b7a7-0f09af1c5b1d
2024-05-01 07:05:42.598 |T| DEBUG | iCP connection adder | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - After adding stats (total=11, active=1, idle=10, waiting=0)
2024-05-01 07:06:12.553 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - Before cleanup stats (total=11, active=1, idle=10, waiting=0)
2024-05-01 07:06:12.554 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | logPoolState              | 414  | NmaHikariCP - After cleanup  stats (total=11, active=1, idle=10, waiting=0)
2024-05-01 07:06:12.554 |T| DEBUG | HikariCP housekeeper | kari.pool.HikariPool | fillPool                  | 521  | NmaHikariCP - Fill pool skipped, pool has sufficient level or currently being filled (queueDepth=0).

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

1 participant