본문 바로가기

Back-End

Spring - Unable to acquire JDBC Connection 이슈

잘 되던 서비스가 갑자기 

Could not open JPA EntityManager for transaction; nested exception is org.hibernate.exception.JDBCConnectionException: Unable to acquire JDBC Connection

Caused by: java.sql.SQLTransientConnectionException: HikariPool-1 - Connection is not available, request timed out after 30000ms.

위와 같은 에러를 내었다. JDBC connection을 못가져온다고??

그래서 위에 로그를 봤더니 30초가 지나도록 connection을 못가져오고 있었다. 왜 이럴까?

org.springframework.transaction.CannotCreateTransactionException: Could not open JPA EntityManager for transaction; nested exception is org.hibernate.exception.JDBCConnectionException: Unable to acquire JDBC Connection
2019. 8. 2. 오후 2:46:29	at org.springframework.orm.jpa.JpaTransactionManager.doBegin(JpaTransactionManager.java:450)
2019. 8. 2. 오후 2:46:29	at org.springframework.transaction.support.AbstractPlatformTransactionManager.getTransaction(AbstractPlatformTransactionManager.java:378)
2019. 8. 2. 오후 2:46:29	at org.springframework.transaction.interceptor.TransactionAspectSupport.createTransactionIfNecessary(TransactionAspectSupport.java:474)
2019. 8. 2. 오후 2:46:29	at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:289)
2019. 8. 2. 오후 2:46:29	at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:98)
2019. 8. 2. 오후 2:46:29	at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:185)
2019. 8. 2. 오후 2:46:29	at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.invoke(PersistenceExceptionTranslationInterceptor.java:139)
2019. 8. 2. 오후 2:46:29	at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:185)
2019. 8. 2. 오후 2:46:29	at org.springframework.data.jpa.repository.support.CrudMethodMetadataPostProcessor$CrudMethodMetadataPopulatingMethodInterceptor.invoke(CrudMethodMetadataPostProcessor.java:135)
2019. 8. 2. 오후 2:46:29	at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:185)
2019. 8. 2. 오후 2:46:29	at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:92)
2019. 8. 2. 오후 2:46:29	at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:185)
2019. 8. 2. 오후 2:46:29	at org.springframework.data.repository.core.support.SurroundingTransactionDetectorMethodInterceptor.invoke(SurroundingTransactionDetectorMethodInterceptor.java:61)
2019. 8. 2. 오후 2:46:29	at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:185)
2019. 8. 2. 오후 2:46:29	at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:212)
2019. 8. 2. 오후 2:46:29	at com.sun.proxy.$Proxy113.saveAndFlush(Unknown Source)
2019. 8. 2. 오후 2:46:29	at com.waug.common.log.util.CommonLogUtil.insertLog(CommonLogUtil.java:25)
2019. 8. 2. 오후 2:46:29	at com.waug.common.log.util.CommonLogUtil.insertLogWithPrefix(CommonLogUtil.java:35)
2019. 8. 2. 오후 2:46:29	at com.waug.cube.v1.seller.service.WaugOrderService.requestCheckOrderApiToLegacy(WaugOrderService.java:156)
2019. 8. 2. 오후 2:46:29	at com.waug.cube.v1.seller.controller.SupplierController.requestAvailableOrder(SupplierController.java:208)
2019. 8. 2. 오후 2:46:29	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
2019. 8. 2. 오후 2:46:29	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
2019. 8. 2. 오후 2:46:29	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
2019. 8. 2. 오후 2:46:29	at java.base/java.lang.reflect.Method.invoke(Method.java:564)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:209)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:136)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:102)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:877)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:783)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:87)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:991)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:925)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:974)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:877)
2019. 8. 2. 오후 2:46:29	at javax.servlet.http.HttpServlet.service(HttpServlet.java:661)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:851)
2019. 8. 2. 오후 2:46:29	at javax.servlet.http.HttpServlet.service(HttpServlet.java:742)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:231)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
2019. 8. 2. 오후 2:46:29	at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:52)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
2019. 8. 2. 오후 2:46:29	at org.springframework.boot.actuate.web.trace.servlet.HttpTraceFilter.doFilterInternal(HttpTraceFilter.java:90)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.filter.RequestContextFilter.doFilterInternal(RequestContextFilter.java:99)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.filter.HttpPutFormContentFilter.doFilterInternal(HttpPutFormContentFilter.java:109)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.filter.HiddenHttpMethodFilter.doFilterInternal(HiddenHttpMethodFilter.java:93)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
2019. 8. 2. 오후 2:46:29	at org.springframework.boot.actuate.metrics.web.servlet.WebMvcMetricsFilter.filterAndRecordMetrics(WebMvcMetricsFilter.java:155)
2019. 8. 2. 오후 2:46:29	at org.springframework.boot.actuate.metrics.web.servlet.WebMvcMetricsFilter.filterAndRecordMetrics(WebMvcMetricsFilter.java:123)
2019. 8. 2. 오후 2:46:29	at org.springframework.boot.actuate.metrics.web.servlet.WebMvcMetricsFilter.doFilterInternal(WebMvcMetricsFilter.java:108)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.filter.CharacterEncodingFilter.doFilterInternal(CharacterEncodingFilter.java:200)
2019. 8. 2. 오후 2:46:29	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:198)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:96)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:493)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:140)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:81)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:87)
2019. 8. 2. 오후 2:46:29	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:342)
2019. 8. 2. 오후 2:46:29	at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:800)
2019. 8. 2. 오후 2:46:29	at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:66)
2019. 8. 2. 오후 2:46:29	at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:800)
2019. 8. 2. 오후 2:46:29	at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1471)
2019. 8. 2. 오후 2:46:29	at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49)
2019. 8. 2. 오후 2:46:29	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1135)
2019. 8. 2. 오후 2:46:29	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
2019. 8. 2. 오후 2:46:29	at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
2019. 8. 2. 오후 2:46:29	at java.base/java.lang.Thread.run(Thread.java:844)
2019. 8. 2. 오후 2:46:29Caused by: org.hibernate.exception.JDBCConnectionException: Unable to acquire JDBC Connection
2019. 8. 2. 오후 2:46:29	at org.hibernate.exception.internal.SQLExceptionTypeDelegate.convert(SQLExceptionTypeDelegate.java:48)
2019. 8. 2. 오후 2:46:29	at org.hibernate.exception.internal.StandardSQLExceptionConverter.convert(StandardSQLExceptionConverter.java:42)
2019. 8. 2. 오후 2:46:29	at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:111)
2019. 8. 2. 오후 2:46:29	at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:97)
2019. 8. 2. 오후 2:46:29	at org.hibernate.resource.jdbc.internal.LogicalConnectionManagedImpl.acquireConnectionIfNeeded(LogicalConnectionManagedImpl.java:109)
2019. 8. 2. 오후 2:46:29	at org.hibernate.resource.jdbc.internal.LogicalConnectionManagedImpl.getPhysicalConnection(LogicalConnectionManagedImpl.java:136)
2019. 8. 2. 오후 2:46:29	at org.hibernate.resource.jdbc.internal.LogicalConnectionManagedImpl.getConnectionForTransactionManagement(LogicalConnectionManagedImpl.java:254)
2019. 8. 2. 오후 2:46:29	at org.hibernate.resource.jdbc.internal.LogicalConnectionManagedImpl.begin(LogicalConnectionManagedImpl.java:262)
2019. 8. 2. 오후 2:46:29	at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcResourceLocalTransactionCoordinatorImpl$TransactionDriverControlImpl.begin(JdbcResourceLocalTransactionCoordinatorImpl.java:214)
2019. 8. 2. 오후 2:46:29	at org.hibernate.engine.transaction.internal.TransactionImpl.begin(TransactionImpl.java:56)
2019. 8. 2. 오후 2:46:29	at org.springframework.orm.jpa.vendor.HibernateJpaDialect.beginTransaction(HibernateJpaDialect.java:164)
2019. 8. 2. 오후 2:46:29	at org.springframework.orm.jpa.JpaTransactionManager.doBegin(JpaTransactionManager.java:400)
2019. 8. 2. 오후 2:46:29	... 83 common frames omitted
2019. 8. 2. 오후 2:46:29Caused by: java.sql.SQLTransientConnectionException: HikariPool-1 - Connection is not available, request timed out after 30000ms.
2019. 8. 2. 오후 2:46:29	at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:669)
2019. 8. 2. 오후 2:46:29	at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:183)
2019. 8. 2. 오후 2:46:29	at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:148)
2019. 8. 2. 오후 2:46:29	at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:128)
2019. 8. 2. 오후 2:46:29	at org.hibernate.engine.jdbc.connections.internal.DatasourceConnectionProviderImpl.getConnection(DatasourceConnectionProviderImpl.java:122)
2019. 8. 2. 오후 2:46:29	at org.hibernate.internal.NonContextualJdbcConnectionAccess.obtainConnection(NonContextualJdbcConnectionAccess.java:35)
2019. 8. 2. 오후 2:46:29	at org.hibernate.resource.jdbc.internal.LogicalConnectionManagedImpl.acquireConnectionIfNeeded(LogicalConnectionManagedImpl.java:106)
2019. 8. 2. 오후 2:46:29	... 90 common frames omitted