Pfthb

I'm unable to configure a SpringBoot project with hibernate and EHCache 2.X. I'm trying to enable 2nd level cache of hibernate.

I'm using:

• SpringBoot 1.5.9 RELEASE


• Hibernate 5.2.13.Final


• 
  EHCache 2.X (imported by spring-boot-starter-cache dependency)

This project exposes RestAPI and when I try to use an endpoint to login the application of this API an exception is thrown:

[INFO ] 2018-11-14 12:34:39.524 [main] TomcatEmbeddedServletContainer - Tomcat started on port(s): 8080 (http)
[INFO ] 2018-11-14 12:34:39.531 [main] Application - Started Application in 14.485 seconds (JVM running for 15.155)
nov 14, 2018 12:34:50 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring FrameworkServlet 'dispatcherServlet'
SEVERE: Servlet.service() for servlet [dispatcherServlet] in context with path threw exception [Filter execution threw an exception] with root cause
java.lang.AbstractMethodError: org.hibernate.cache.ehcache.internal.nonstop.NonstopAwareEntityRegionAccessStrategy.get(Lorg/hibernate/engine/spi/SessionImplementor;Ljava/lang/Object;J)Ljava/lang/Object;
 at org.hibernate.engine.internal.CacheHelper.fromSharedCache(CacheHelper.java:32)
 at org.hibernate.persister.entity.AbstractEntityPersister.isTransient(AbstractEntityPersister.java:4410)
 at org.hibernate.engine.internal.ForeignKeys.isTransient(ForeignKeys.java:226)
 at org.hibernate.event.internal.AbstractSaveEventListener.getEntityState(AbstractSaveEventListener.java:510)
 at org.hibernate.event.internal.DefaultMergeEventListener.onMerge(DefaultMergeEventListener.java:165)
 at org.hibernate.event.internal.DefaultMergeEventListener.onMerge(DefaultMergeEventListener.java:69)
 at org.hibernate.internal.SessionImpl.fireMerge(SessionImpl.java:840)
 at org.hibernate.internal.SessionImpl.merge(SessionImpl.java:822)
 at org.hibernate.internal.SessionImpl.merge(SessionImpl.java:827)
 at org.hibernate.jpa.spi.AbstractEntityManagerImpl.merge(AbstractEntityManagerImpl.java:1161)
 at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
 at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
 at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
 at java.lang.reflect.Method.invoke(Unknown Source)
 at org.springframework.orm.jpa.SharedEntityManagerCreator$SharedEntityManagerInvocationHandler.invoke(SharedEntityManagerCreator.java:298)
 at com.sun.proxy.$Proxy151.merge(Unknown Source)
 at org.springframework.data.jpa.repository.support.SimpleJpaRepository.save(SimpleJpaRepository.java:511)
 at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
 at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
 at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
 at java.lang.reflect.Method.invoke(Unknown Source)
 at org.springframework.data.repository.core.support.RepositoryFactorySupport$QueryExecutorMethodInterceptor.executeMethodOn(RepositoryFactorySupport.java:520)
 at org.springframework.data.repository.core.support.RepositoryFactorySupport$QueryExecutorMethodInterceptor.doInvoke(RepositoryFactorySupport.java:505)
 at org.springframework.data.repository.core.support.RepositoryFactorySupport$QueryExecutorMethodInterceptor.invoke(RepositoryFactorySupport.java:477)
 at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
 at org.springframework.data.projection.DefaultMethodInvokingMethodInterceptor.invoke(DefaultMethodInvokingMethodInterceptor.java:56)
 at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
 at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:99)
 at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:282)
 at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:96)
 at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
 at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.invoke(PersistenceExceptionTranslationInterceptor.java:136)
 at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
 at org.springframework.data.jpa.repository.support.CrudMethodMetadataPostProcessor$CrudMethodMetadataPopulatingMethodInterceptor.invoke(CrudMethodMetadataPostProcessor.java:133)
 at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
 at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:92)
 at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
 at org.springframework.data.repository.core.support.SurroundingTransactionDetectorMethodInterceptor.invoke(SurroundingTransactionDetectorMethodInterceptor.java:57)
 at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
 at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:213)
 at com.sun.proxy.$Proxy184.save(Unknown Source)
 at net.gestion_casos.service.security.UserDetailsService.updateAgent(UserDetailsService.java:66)
 at net.gestion_casos.service.security.UserDetailsService.loadUserByUsername(UserDetailsService.java:60)
 at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
 at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
 at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
 at java.lang.reflect.Method.invoke(Unknown Source)
 at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:333)
 at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:190)
 at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:157)
 at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:99)
 at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:282)
 at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:96)
 at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
 at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:213)
 at com.sun.proxy.$Proxy185.loadUserByUsername(Unknown Source)
 at org.springframework.security.authentication.dao.DaoAuthenticationProvider.retrieveUser(DaoAuthenticationProvider.java:114)
 at org.springframework.security.authentication.dao.AbstractUserDetailsAuthenticationProvider.authenticate(AbstractUserDetailsAuthenticationProvider.java:144)
 at org.springframework.security.authentication.ProviderManager.authenticate(ProviderManager.java:174)
 at org.springframework.security.authentication.ProviderManager.authenticate(ProviderManager.java:199)
 at org.springframework.security.web.authentication.UsernamePasswordAuthenticationFilter.attemptAuthentication(UsernamePasswordAuthenticationFilter.java:94)
 at org.springframework.security.web.authentication.AbstractAuthenticationProcessingFilter.doFilter(AbstractAuthenticationProcessingFilter.java:212)
 at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331)
 at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:116)
 at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331)
 at org.springframework.web.filter.CorsFilter.doFilterInternal(CorsFilter.java:96)
 at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
 at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331)
 at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:105)
 at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331)
 at org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter.doFilterInternal(WebAsyncManagerIntegrationFilter.java:56)
 at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
 at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:331)
 at org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:214)
 at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:177)
 at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:347)
 at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:263)
 at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
 at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
 at org.springframework.web.filter.RequestContextFilter.doFilterInternal(RequestContextFilter.java:99)
 at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
 at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
 at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
 at org.springframework.web.filter.HttpPutFormContentFilter.doFilterInternal(HttpPutFormContentFilter.java:108)
 at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
 at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
 at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
 at org.springframework.web.filter.HiddenHttpMethodFilter.doFilterInternal(HiddenHttpMethodFilter.java:81)
 at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
 at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
 at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
 at org.springframework.web.filter.CharacterEncodingFilter.doFilterInternal(CharacterEncodingFilter.java:197)
 at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
 at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
 at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
 at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:199)
 at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:96)
 at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:478)
 at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:140)
 at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:81)
 at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:87)
 at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:342)
 at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:803)
 at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:66)
 at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:868)
 at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1459)
 at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49)
 at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
 at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
 at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
 at java.lang.Thread.run(Unknown Source)

The full log can be viewed in this link: https://ufile.io/9j69m.
I've enabled debug logging for ehcache and log lines corresponding to this is pre-pended with <<>> string to facilitate locating it.

This post How to solve AbstractMethodError in Hibernate 5? sugests that this could be a dependencies issue between hibernate dependencies.

I'm using gradle for managing dependecies and this is my build.gradle where you can see all my declared dependencies:

buildscript 
 ext 
 springBootVersion = '1.5.9.RELEASE'
 
 repositories 
 mavenCentral()
 
 dependencies 
 classpath("org.springframework.boot:spring-boot-gradle-plugin:$springBootVersion")
 


apply plugin: 'java'
apply plugin: 'eclipse'
apply plugin: 'org.springframework.boot'

def manifestPath = "src/main/resources/Manifest.txt"

Properties props = new Properties()
props.load(new FileInputStream(String.format("%s/%s", projectDir, manifestPath)))

group = 'net.integraciones.co.osi'
version = props.getProperty("Implementation-Version")
sourceCompatibility = 1.8

jar 
 baseName = 'service'
 version = version

 manifest 
 from(manifestPath)
 
 ant.propertyfile(
 file: "env.properties") 
 entry(key: "CURRENT_VERSION", value: version)
 


repositories 
 mavenCentral()


dependencies 

 compile('org.springframework.boot:spring-boot-starter-web:1.5.9.RELEASE') 
 exclude group: 'org.springframework.boot', module: 'spring-boot-starter-logging'
 

 compile('org.springframework.boot:spring-boot-starter-security:1.5.9.RELEASE') 
 exclude group: 'org.springframework.boot', module: 'spring-boot-starter-logging'
 

 // log4j2
 compile 'org.apache.logging.log4j:log4j-api:2.5'
 compile 'org.apache.logging.log4j:log4j-core:2.5'
 // log4j2 bridge con slf4j
 compile group: 'org.apache.logging.log4j', name: 'log4j-slf4j-impl', version: '2.1'

 // Jackson
 compile 'com.fasterxml.jackson.dataformat:jackson-dataformat-yaml:2.7.3'
 //compile 'com.fasterxml.jackson.core:jackson-databind:2.5.4'
 // support for Java 8 date/time types (specified in JSR-310 specification)
 compile group: 'com.fasterxml.jackson.datatype', name: 'jackson-datatype-jsr310', version: '2.9.3'
 // https://mvnrepository.com/artifact/com.fasterxml.jackson.datatype/jackson-datatype-hibernate5
 compile group: 'com.fasterxml.jackson.datatype', name: 'jackson-datatype-hibernate5', version: '2.9.6'


 // springfox-swagger2
 compile 'io.springfox:springfox-swagger2:2.7.0'
 compile 'io.springfox:springfox-swagger-ui:2.7.0'

 // Database dependencies 
 compile (group: 'org.springframework.boot', name: 'spring-boot-starter-data-jpa', version: '1.5.10.RELEASE')
 exclude group: 'org.springframework.boot', module: 'spring-boot-starter-logging'
 
 compile group: 'org.hibernate', name: 'hibernate-java8', version: '5.2.13.Final'
 compile 'org.aspectj:aspectjweaver:1.8.9'
 compile group: 'mysql', name: 'mysql-connector-java', version: '5.1.45'

 compile group: 'org.hibernate', name: 'hibernate-ehcache', version: '5.2.14.Final'
 compile('org.springframework.boot:spring-boot-starter-cache') 
 exclude group: 'org.springframework.boot', module: 'spring-boot-starter-logging'
 

 // Apache
 compile 'org.apache.commons:commons-lang3:3.0'
 compile('net.sf.dozer:dozer:5.4.0') 
 exclude group: 'org.slf4j', module: 'slf4j-log4j12'
 

 compile fileTree(dir: 'libs', include: ['*.jar'])

 compile group: 'org.projectlombok', name: 'lombok', version: '1.16.8'
 compile('com.google.guava:guava:21.0')

 compile group: 'org.springframework.ws', name: 'spring-ws-core', version: '3.0.0.RELEASE'

 compile group: 'org.apache.poi', name: 'poi-ooxml', version: '3.16'

 compile group: 'org.apache.pdfbox', name: 'pdfbox', version: '2.0.11' 

 //test
 testCompile('org.springframework.boot:spring-boot-starter-test') 
 exclude group: 'org.springframework.boot', module: 'spring-boot-starter-test-logging'
 
 testCompile group: 'org.mockito', name: 'mockito-all', version: '1.10.19'
 testCompile group: 'org.apache.logging.log4j', name:'log4j-api', version: '2.5'
 testCompile group: 'org.apache.logging.log4j', name:'log4j-core', version: '2.5'
 testCompile group: 'org.apache.logging.log4j', name: 'log4j-web', version: '2.10.0'
 testCompile group: 'com.h2database', name: 'h2', version: '1.4.194'

Dependencies tree printed by "gradle dependencies" command can be viewed here: https://ufile.io/ldwof

I'd also configured hibernate second level cache in application.yaml of springboot. This is the relevant part:

spring:
 datasource:
 name: mysql
 driverClassName: com.mysql.jdbc.Driver
 url: jdbc:mysql://192.168.41.211:3306/SpringBootProject?verifyServerCertificate=false&useSSL=false
 username: root
 password: root
 jpa:
 show-sql: true
 properties:
 javax:
 persistence:
 sharedCache:
 mode: ALL
 hibernate:
 cache:
 region:
 factory_class: org.hibernate.cache.ehcache.SingletonEhCacheRegionFactory
 use_second_level_cache: true
 globally_quoted_identifiers: true
 hibernate:
 dialect: org.hibernate.dialect.MySQL5Dialect
 ddl-auto: validate
 naming:
 implicit-strategy: org.hibernate.boot.model.naming.ImplicitNamingStrategyLegacyJpaImpl
 physical-strategy: org.hibernate.boot.model.naming.PhysicalNamingStrategyStandardImpl

server:
 port: 8080

My ehcache.xml config:

<?xml version="1.0" encoding="UTF-8"?>
<!DOCTYPE ehcache>
<ehcache 
 name="MY_CACHE" 
 xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
 xsi:noNamespaceSchemaLocation="ehcache.xsd" 
 updateCheck="true"
 monitoring="autodetect" 
 dynamicConfig="true">

 <diskStore path="java.io.tmpdir"/>

 <defaultCache 
 maxEntriesLocalHeap="10000" 
 eternal="false"
 timeToIdleSeconds="120" 
 timeToLiveSeconds="240" 
 maxEntriesLocalDisk="100000"
 diskExpiryThreadIntervalSeconds="240"
 memoryStoreEvictionPolicy="LRU">
 <persistence strategy="localTempSwap"/>
 </defaultCache>

 <cache name=a.project.package.Catalog" maxEntriesLocalHeap="1000" />

</ehcache>

I was able to fix this problem.

The problem was that I was declaring a wrong version of hibernate-ehcache dependency in my build.gradle.


In the ehcache docs says that hibernate to be able to use it as a second level cache it is necesary that the hibernate-ehcache dependency match the hibernate-core dependency version used by springboot.


I knew this when I declared the dependency of ehcache in my build.gradle but instead of using the hibernate-core version I use hibernate-java8 version.


By correcting the hibernate-ehcache version the problem was solved.