Spring Boot 2.3.0 won't start with hibernate.search.FieldBridge annotation in use #25111

Activity

1. knoobie

   changed the title [-]Spring Boot 2.3.0 won't start with hibernate.search.FieldBridge annotation in used[/-] [+]Spring Boot 2.3.0 won't start with hibernate.search.FieldBridge annotation in use[/+] on May 20, 2020
2. wilkinsona commented on May 20, 2020

   

   wilkinsona

   on May 20, 2020

   Member

   More actions

   Thanks for the sample. The problem is caused by Spring Boot 2.3 moving to bootstrapping Hibernate asynchronously by default. When Hibernate Search is involved, its bootstrapping results in a call back into the bean factory via SpringBeanContainer and a deadlock occurs. This will have to be investigated by the Spring Framework team. We'll transfer this issue to them shortly so that they can take a look. In the meantime, you can avoid the problem by disabling deferred bootstrapping:

   spring:
     data:
       jpa:
         repositories:
           bootstrap_mode: default

   👍React with 👍9Reacted by Knoobie, Jérôme Bertaux, Filip Glazar, Andrew Blejde, Aaron Loes, Gayan Nettasinghe, Andrei Ivantsov, Marconi Filho and LifeIsStrange

   ❤️React with ❤️1Reacted by times29
3. knoobie commented on May 20, 2020

   

   knoobie

   on May 20, 2020

   Author

   More actions

   Thanks @wilkinsona!
4. bclozel

   transferred this issue fromspring-projects/spring-booton May 20, 2020
5. spring-projects-issues

   added

   status: waiting-for-triageAn issue we've not yet triaged or decided onAn issue we've not yet triaged or decided on

   on May 20, 2020
6. jhoeller

   self-assigned this

   on May 20, 2020
7. yrodiere commented on May 25, 2020

   

   yrodiere

   on May 25, 2020

   Contributor

   More actions

   Hi, Hibernate Search developer here. Maybe this can shed some light on the problem:

   From what I understand (I might be wrong), Spring doesn't initialize Hibernate ORM lazily; it just instructs Hibernate ORM to resolve beans lazily, while performing the whole bootstrap process eagerly. That's possible for Hibernate ORM because the beans (converters, ...) are only used at runtime.

   Hibernate Search, on the other hand, retrieves "bridges" through Spring. The "bridges" provide metadata that is needed at bootstrap, and thus they must be resolved eagerly at startup, so that the bootstrap process completes. Thus the "deferred" bootstrap mode in Spring cannot currently work out of the box in Hibernate Search.

   There is a feature in Hibernate Search that defers the whole bootstrap process of Hibernate Search to a later time, but I'm not sure it would help, as a) Spring doesn't include any integration code specific to Hibernate Search right now (and I'm not sure you'll want that) and b) that feature only delays the bootstrap, it does not make it "lazy". See org.hibernate.search.hcore.impl.ExtendedBeanManagerSynchronizer for an example implementation (for CDI). That implementation is enabled thanks to org.hibernate.search.hcore.impl.ExtendedBeanManagerSynchronizerContributor, which is enabled through a service file: META-INF/services/org.hibernate.service.spi.ServiceContributor.

   👍React with 👍2Reacted by H.Lo and Aaron Loes
8. wilkinsona commented on May 26, 2020

   

   wilkinsona

   on May 26, 2020

   Member

   More actions

   The problem doesn't appear to be limited to apps that use Hibernate search. @ctmay4 shared a thread dump on the Spring Boot issue that switched the default to deferred which shows Hibernate ORM code calling back into the bean factory via SpringBeanContainer and deadlocking:

   "main@1" prio=5 tid=0x1 nid=NA waiting
     java.lang.Thread.State: WAITING
   	 blocks task-1@7519
   	  at jdk.internal.misc.Unsafe.park(Unsafe.java:-1)
   	  at java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
   	  at java.util.concurrent.FutureTask.awaitDone(FutureTask.java:447)
   	  at java.util.concurrent.FutureTask.get(FutureTask.java:190)
   	  at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean.getNativeEntityManagerFactory(AbstractEntityManagerFactoryBean.java:540)
   	  at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean.invokeProxyMethod(AbstractEntityManagerFactoryBean.java:497)
   	  at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean$ManagedEntityManagerFactoryInvocationHandler.invoke(AbstractEntityManagerFactoryBean.java:680)
   	  at com.sun.proxy.$Proxy93.getMetamodel(Unknown Source:-1)
   	  at org.springframework.data.jpa.repository.config.JpaMetamodelMappingContextFactoryBean$$Lambda$859.436399072.apply(Unknown Source:-1)
   	  at java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:195)
   	  at java.util.Iterator.forEachRemaining(Iterator.java:133)
   	  at java.util.Spliterators$IteratorSpliterator.forEachRemaining(Spliterators.java:1801)
   	  at java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:484)
   	  at java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:474)
   	  at java.util.stream.ReduceOps$ReduceOp.evaluateSequential(ReduceOps.java:913)
   	  at java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234)
   	  at java.util.stream.ReferencePipeline.collect(ReferencePipeline.java:578)
   	  at org.springframework.data.jpa.repository.config.JpaMetamodelMappingContextFactoryBean.getMetamodels(JpaMetamodelMappingContextFactoryBean.java:106)
   	  at org.springframework.data.jpa.repository.config.JpaMetamodelMappingContextFactoryBean.createInstance(JpaMetamodelMappingContextFactoryBean.java:80)
   	  at org.springframework.data.jpa.repository.config.JpaMetamodelMappingContextFactoryBean.createInstance(JpaMetamodelMappingContextFactoryBean.java:44)
   	  at org.springframework.beans.factory.config.AbstractFactoryBean.afterPropertiesSet(AbstractFactoryBean.java:142)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1855)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1792)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:595)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:517)
   	  at org.springframework.beans.factory.support.AbstractBeanFactory.lambda$doGetBean$0(AbstractBeanFactory.java:323)
   	  at org.springframework.beans.factory.support.AbstractBeanFactory$$Lambda$318.1466413743.getObject(Unknown Source:-1)
   	  at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:226)
   	  - locked <0x273d> (a java.util.concurrent.ConcurrentHashMap)
   	  at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:321)
   	  at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:202)
   	  at org.springframework.beans.factory.support.BeanDefinitionValueResolver.resolveReference(BeanDefinitionValueResolver.java:330)
   	  at org.springframework.beans.factory.support.BeanDefinitionValueResolver.resolveValueIfNecessary(BeanDefinitionValueResolver.java:113)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.applyPropertyValues(AbstractAutowireCapableBeanFactory.java:1699)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.populateBean(AbstractAutowireCapableBeanFactory.java:1444)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:594)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:517)
   	  at org.springframework.beans.factory.support.AbstractBeanFactory.lambda$doGetBean$0(AbstractBeanFactory.java:323)
   	  at org.springframework.beans.factory.support.AbstractBeanFactory$$Lambda$318.1466413743.getObject(Unknown Source:-1)
   	  at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:226)
   	  at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:321)
   	  at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:207)
   	  at org.springframework.context.support.AbstractApplicationContext.getBean(AbstractApplicationContext.java:1114)
   	  at org.springframework.data.repository.support.Repositories.cacheRepositoryFactory(Repositories.java:99)
   	  - locked <0x273e> (a org.springframework.data.repository.support.Repositories)
   	  at org.springframework.data.repository.support.Repositories.populateRepositoryFactoryInformation(Repositories.java:92)
   	  at org.springframework.data.repository.support.Repositories.<init>(Repositories.java:85)
   	  at org.springframework.data.repository.support.DomainClassConverter.setApplicationContext(DomainClassConverter.java:109)
   	  at org.springframework.data.web.config.SpringDataWebConfiguration.addFormatters(SpringDataWebConfiguration.java:130)
   	  at org.springframework.web.servlet.config.annotation.WebMvcConfigurerComposite.addFormatters(WebMvcConfigurerComposite.java:81)
   	  at org.springframework.web.servlet.config.annotation.DelegatingWebMvcConfiguration.addFormatters(DelegatingWebMvcConfiguration.java:78)
   	  at org.springframework.boot.autoconfigure.web.servlet.WebMvcAutoConfiguration$EnableWebMvcConfiguration.mvcConversionService(WebMvcAutoConfiguration.java:435)
   	  at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(NativeMethodAccessorImpl.java:-1)
   	  at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   	  at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   	  at java.lang.reflect.Method.invoke(Method.java:566)
   	  at org.springframework.beans.factory.support.SimpleInstantiationStrategy.instantiate(SimpleInstantiationStrategy.java:154)
   	  at org.springframework.beans.factory.support.ConstructorResolver.instantiate(ConstructorResolver.java:651)
   	  at org.springframework.beans.factory.support.ConstructorResolver.instantiateUsingFactoryMethod(ConstructorResolver.java:636)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.instantiateUsingFactoryMethod(AbstractAutowireCapableBeanFactory.java:1338)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:1177)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:557)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:517)
   	  at org.springframework.beans.factory.support.AbstractBeanFactory.lambda$doGetBean$0(AbstractBeanFactory.java:323)
   	  at org.springframework.beans.factory.support.AbstractBeanFactory$$Lambda$318.1466413743.getObject(Unknown Source:-1)
   	  at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:226)
   	  at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:321)
   	  at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:202)
   	  at org.springframework.beans.factory.config.DependencyDescriptor.resolveCandidate(DependencyDescriptor.java:276)
   	  at org.springframework.beans.factory.support.DefaultListableBeanFactory.doResolveDependency(DefaultListableBeanFactory.java:1306)
   	  at org.springframework.beans.factory.support.DefaultListableBeanFactory.resolveDependency(DefaultListableBeanFactory.java:1226)
   	  at org.springframework.beans.factory.support.ConstructorResolver.resolveAutowiredArgument(ConstructorResolver.java:885)
   	  at org.springframework.beans.factory.support.ConstructorResolver.createArgumentArray(ConstructorResolver.java:789)
   	  at org.springframework.beans.factory.support.ConstructorResolver.instantiateUsingFactoryMethod(ConstructorResolver.java:539)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.instantiateUsingFactoryMethod(AbstractAutowireCapableBeanFactory.java:1338)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:1177)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:557)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:517)
   	  at org.springframework.beans.factory.support.AbstractBeanFactory.lambda$doGetBean$0(AbstractBeanFactory.java:323)
   	  at org.springframework.beans.factory.support.AbstractBeanFactory$$Lambda$318.1466413743.getObject(Unknown Source:-1)
   	  at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:226)
   	  at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:321)
   	  at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:202)
   	  at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:895)
   	  at org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:878)
   	  at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:550)
   	  - locked <0x273f> (a java.lang.Object)
   	  at org.springframework.boot.web.servlet.context.ServletWebServerApplicationContext.refresh(ServletWebServerApplicationContext.java:143)
   	  at org.springframework.boot.SpringApplication.refresh(SpringApplication.java:758)
   	  at org.springframework.boot.SpringApplication.refresh(SpringApplication.java:750)
   	  at org.springframework.boot.SpringApplication.refreshContext(SpringApplication.java:397)
   	  at org.springframework.boot.SpringApplication.run(SpringApplication.java:315)
   	  at org.springframework.boot.SpringApplication.run(SpringApplication.java:1237)
   	  at org.springframework.boot.SpringApplication.run(SpringApplication.java:1226)
   	  at com.imsweb.seerdms.admin.AdminApplication.main(AdminApplication.java:34)
   
   "task-1@7519" prio=5 tid=0x181 nid=NA waiting for monitor entry
     java.lang.Thread.State: BLOCKED
   	 waiting for main@1 to release lock on <0x273d> (a java.util.concurrent.ConcurrentHashMap)
   	  at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:183)
   	  at org.springframework.beans.factory.support.AbstractBeanFactory.isTypeMatch(AbstractBeanFactory.java:517)
   	  at org.springframework.beans.factory.support.DefaultListableBeanFactory.doGetBeanNamesForType(DefaultListableBeanFactory.java:533)
   	  at org.springframework.beans.factory.support.DefaultListableBeanFactory.getBeanNamesForType(DefaultListableBeanFactory.java:505)
   	  at org.springframework.beans.factory.BeanFactoryUtils.beanNamesForTypeIncludingAncestors(BeanFactoryUtils.java:265)
   	  at org.springframework.beans.factory.support.DefaultListableBeanFactory.findAutowireCandidates(DefaultListableBeanFactory.java:1472)
   	  at org.springframework.beans.factory.support.DefaultListableBeanFactory.doResolveDependency(DefaultListableBeanFactory.java:1269)
   	  at org.springframework.beans.factory.support.DefaultListableBeanFactory.resolveDependency(DefaultListableBeanFactory.java:1226)
   	  at org.springframework.beans.factory.support.ConstructorResolver.resolveAutowiredArgument(ConstructorResolver.java:885)
   	  at org.springframework.beans.factory.support.ConstructorResolver.createArgumentArray(ConstructorResolver.java:789)
   	  at org.springframework.beans.factory.support.ConstructorResolver.autowireConstructor(ConstructorResolver.java:228)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.autowireConstructor(AbstractAutowireCapableBeanFactory.java:1358)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:1204)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:557)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:517)
   	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:353)
   	  at org.springframework.orm.hibernate5.SpringBeanContainer.createBean(SpringBeanContainer.java:147)
   	  at org.springframework.orm.hibernate5.SpringBeanContainer.getBean(SpringBeanContainer.java:105)
   	  at org.hibernate.resource.beans.internal.ManagedBeanRegistryImpl.getBean(ManagedBeanRegistryImpl.java:61)
   	  at org.hibernate.boot.model.convert.internal.ClassBasedConverterDescriptor.createManagedBean(ClassBasedConverterDescriptor.java:38)
   	  at org.hibernate.boot.model.convert.internal.AbstractConverterDescriptor.createJpaAttributeConverter(AbstractConverterDescriptor.java:107)
   	  at org.hibernate.mapping.SimpleValue.buildAttributeConverterTypeAdapter(SimpleValue.java:570)
   	  at org.hibernate.mapping.SimpleValue.setTypeUsingReflection(SimpleValue.java:531)
   	  at org.hibernate.cfg.annotations.SimpleValueBinder.fillSimpleValue(SimpleValueBinder.java:511)
   	  at org.hibernate.cfg.SetSimpleValueTypeSecondPass.doSecondPass(SetSimpleValueTypeSecondPass.java:25)
   	  at org.hibernate.boot.internal.InFlightMetadataCollectorImpl.processSecondPasses(InFlightMetadataCollectorImpl.java:1693)
   	  at org.hibernate.boot.internal.InFlightMetadataCollectorImpl.processSecondPasses(InFlightMetadataCollectorImpl.java:1651)
   	  at org.hibernate.boot.model.process.spi.MetadataBuildingProcess.complete(MetadataBuildingProcess.java:286)
   	  at org.hibernate.jpa.boot.internal.EntityManagerFactoryBuilderImpl.metadata(EntityManagerFactoryBuilderImpl.java:1214)
   	  at org.hibernate.jpa.boot.internal.EntityManagerFactoryBuilderImpl.build(EntityManagerFactoryBuilderImpl.java:1245)
   	  at org.springframework.orm.jpa.vendor.SpringHibernateJpaPersistenceProvider.createContainerEntityManagerFactory(SpringHibernateJpaPersistenceProvider.java:58)
   	  at org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean.createNativeEntityManagerFactory(LocalContainerEntityManagerFactoryBean.java:365)
   	  at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean.buildNativeEntityManagerFactory(AbstractEntityManagerFactoryBean.java:391)
   	  at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean$$Lambda$769.882838692.call(Unknown Source:-1)
   	  at java.util.concurrent.FutureTask.run$$$capture(FutureTask.java:264)
   	  at java.util.concurrent.FutureTask.run(FutureTask.java:-1)
   	  at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
   	  at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
   	  at java.lang.Thread.run(Thread.java:834)
   
   "Catalina-utility-1@7279" prio=1 tid=0x17e nid=NA waiting
     java.lang.Thread.State: WAITING
   	  at jdk.internal.misc.Unsafe.park(Unsafe.java:-1)
   	  at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:234)
   	  at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123)
   	  at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1182)
   	  at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:899)
   	  at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
   	  at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
   	  at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
   	  at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
   	  at java.lang.Thread.run(Thread.java:834)
   
   "Catalina-utility-2@7283" prio=1 tid=0x17f nid=NA waiting
     java.lang.Thread.State: WAITING
   	  at jdk.internal.misc.Unsafe.park(Unsafe.java:-1)
   	  at java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
   	  at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
   	  at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1177)
   	  at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:899)
   	  at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
   	  at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
   	  at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
   	  at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
   	  at java.lang.Thread.run(Thread.java:834)
   
   "RMI Scheduler(0)@3836" daemon prio=5 tid=0x13 nid=NA waiting
     java.lang.Thread.State: WAITING
   	  at jdk.internal.misc.Unsafe.park(Unsafe.java:-1)
   	  at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:234)
   	  at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123)
   	  at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1182)
   	  at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:899)
   	  at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
   	  at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
   	  at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
   	  at java.lang.Thread.run(Thread.java:834)
   
   "HikariPool-1 housekeeper@8907" daemon prio=5 tid=0x184 nid=NA waiting
     java.lang.Thread.State: WAITING
   	  at jdk.internal.misc.Unsafe.park(Unsafe.java:-1)
   	  at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:234)
   	  at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123)
   	  at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1182)
   	  at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:899)
   	  at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
   	  at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
   	  at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
   	  at java.lang.Thread.run(Thread.java:834)
   
   "Common-Cleaner@1773" daemon prio=8 tid=0xa nid=NA waiting
     java.lang.Thread.State: WAITING
   	  at java.lang.Object.wait(Object.java:-1)
   	  at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:155)
   	  at jdk.internal.ref.CleanerImpl.run(CleanerImpl.java:148)
   	  at java.lang.Thread.run(Thread.java:834)
   	  at jdk.internal.misc.InnocuousThread.run(InnocuousThread.java:134)
   
   "RMI TCP Accept-0@1714" daemon prio=5 tid=0x10 nid=NA runnable
     java.lang.Thread.State: RUNNABLE
   	  at java.net.PlainSocketImpl.accept0(PlainSocketImpl.java:-1)
   	  at java.net.PlainSocketImpl.socketAccept(PlainSocketImpl.java:159)
   	  at java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:458)
   	  at java.net.ServerSocket.implAccept(ServerSocket.java:565)
   	  at java.net.ServerSocket.accept(ServerSocket.java:533)
   	  at sun.management.jmxremote.LocalRMIServerSocketFactory$1.accept(LocalRMIServerSocketFactory.java:52)
   	  at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.executeAcceptLoop(TCPTransport.java:394)
   	  at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.run(TCPTransport.java:366)
   	  at java.lang.Thread.run(Thread.java:834)
   
   "RMI TCP Connection(1)-172.22.34.23@3482" daemon prio=5 tid=0x12 nid=NA runnable
     java.lang.Thread.State: RUNNABLE
   	  at java.net.SocketInputStream.socketRead0(SocketInputStream.java:-1)
   	  at java.net.SocketInputStream.socketRead(SocketInputStream.java:115)
   	  at java.net.SocketInputStream.read(SocketInputStream.java:168)
   	  at java.net.SocketInputStream.read(SocketInputStream.java:140)
   	  at java.io.BufferedInputStream.fill(BufferedInputStream.java:252)
   	  at java.io.BufferedInputStream.read(BufferedInputStream.java:271)
   	  - locked <0x2742> (a java.io.BufferedInputStream)
   	  at java.io.FilterInputStream.read(FilterInputStream.java:83)
   	  at sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:544)
   	  at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:796)
   	  at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.lambda$run$0(TCPTransport.java:677)
   	  at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler$$Lambda$222.498706880.run(Unknown Source:-1)
   	  at java.security.AccessController.doPrivileged(AccessController.java:-1)
   	  at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:676)
   	  at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
   	  at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
   	  at java.lang.Thread.run(Thread.java:834)
   
   "container-0@7293" prio=5 tid=0x180 nid=NA sleeping
     java.lang.Thread.State: TIMED_WAITING
   	  at java.lang.Thread.sleep(Thread.java:-1)
   	  at org.apache.catalina.core.StandardServer.await(StandardServer.java:570)
   	  at org.springframework.boot.web.embedded.tomcat.TomcatWebServer$1.run(TomcatWebServer.java:197)
   
   "Reference Handler@10043" daemon prio=10 tid=0x2 nid=NA runnable
     java.lang.Thread.State: RUNNABLE
   	  at java.lang.ref.Reference.waitForReferencePendingList(Reference.java:-1)
   	  at java.lang.ref.Reference.processPendingReferences(Reference.java:241)
   	  at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:213)
   
   "Finalizer@9857" daemon prio=8 tid=0x3 nid=NA waiting
     java.lang.Thread.State: WAITING
   	  at java.lang.Object.wait(Object.java:-1)
   	  at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:155)
   	  at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:176)
   	  at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:170)
   
   "Signal Dispatcher@10044" daemon prio=9 tid=0x4 nid=NA runnable
     java.lang.Thread.State: RUNNABLE
   
   "Attach Listener@3193" daemon prio=5 tid=0x5 nid=NA runnable
     java.lang.Thread.State: RUNNABLE
   

   👍React with 👍2Reacted by Chengchen JI and Konrad Paumann
9. chengchen commented on May 28, 2020

   

   chengchen

   on May 28, 2020

   More actions

   Yes, it's the same for us. This is happening randomly.

   main thread which waits for the Future to complete
   

   task-1 thread executing the Future
   

   The main thread waits for getNativeEntityManagerFactory() (done asynchronously on task-1 thread) to complete and at the same time it has already acquired the lock in DefaultSingletionBeanRegistry. And task-1 thread also requires a Hikari connection to be ready. However, at this moment, the Hikari connection pool is not yet initialized so it has to access this DefaultSingletionBeanRegistry as well trying to enter the synchronized block (but it's blocked by main thread).

   If we switch to DEFAULT mode, it works fine as before.
10. snicoll commented on Aug 19, 2020

    

    snicoll

    on Aug 19, 2020

    Member

    More actions

    Once we have a fix for this issue, testing it against https://github.com/hgarus/entitylistener-deadlock is in order as it's yet another occurence of this issue.
11. pyn0t commented on Aug 21, 2020

    

    pyn0t

    on Aug 21, 2020

    More actions

    Adding @EnableJpaRepositories to DemoApplication seems to fix the issue
12. dan1els commented on Sep 21, 2020

    

    dan1els

    on Sep 21, 2020

    Last edited by dan1els

    More actions

    It seems you can't inject anything into entity listeners when using BoostrapMode.DEFAULT, but using deferred mode fixed both issues.
    @EnableJpaRepositories(bootstrapMode = BootstrapMode.DEFERRED)
13. hgarus commented on Sep 29, 2020

    

    hgarus

    on Sep 29, 2020

    More actions

    @pyn0t , @dan1els

    Adding @EnableJpaRepositories to DemoApplication seems to fix the issue

    Yes it does, as does setting spring.data.jpa.repositories.bootstrap-mode=default in application.properties.

    Both cause the creation of the EntityManagerFactory in AbstractEntityManagerFactoryBean to be synchronous.

    Spring-Boot changed the default for spring.data.jpa.repositories.bootstrap-mode to lazy with 2.3 which causes JpaRepositoriesAutoConfiguration to configure a bootstrapExecutor to create the EntityManagerFactory asynchronously.

    Somewhat interestingly @EnableJpaRepositories(bootstrapMode = BootstrapMode.LAZY) doesn't set a bootstrapExecutor (and I don't see another way to set one using the annotation either), so @EnableJpaRepositories "fixes" the deadlock regardless of bootstrapMode.
14. matf commented on Feb 11, 2021

    

    matf

    on Feb 11, 2021

    More actions

    Encountered the same issue, hangs sometimes during startup while trying to inject EntityManagerFactory instances into HibernateMetricsAutoConfiguration. Here's the thread dump if it helps:

    "main@1" prio=5 tid=0x1 nid=NA waiting
      java.lang.Thread.State: WAITING
    	 blocks task-1@8951
    	  at jdk.internal.misc.Unsafe.park(Unsafe.java:-1)
    	  at java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
    	  at java.util.concurrent.FutureTask.awaitDone(FutureTask.java:447)
    	  at java.util.concurrent.FutureTask.get(FutureTask.java:190)
    	  at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean.getNativeEntityManagerFactory(AbstractEntityManagerFactoryBean.java:540)
    	  at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean.invokeProxyMethod(AbstractEntityManagerFactoryBean.java:497)
    	  at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean$ManagedEntityManagerFactoryInvocationHandler.invoke(AbstractEntityManagerFactoryBean.java:680)
    	  at com.sun.proxy.$Proxy157.unwrap(Unknown Source:-1)
    	  at org.springframework.boot.actuate.autoconfigure.metrics.orm.jpa.HibernateMetricsAutoConfiguration.bindEntityManagerFactoryToRegistry(HibernateMetricsAutoConfiguration.java:67)
    	  at org.springframework.boot.actuate.autoconfigure.metrics.orm.jpa.HibernateMetricsAutoConfiguration.lambda$bindEntityManagerFactoriesToRegistry$0(HibernateMetricsAutoConfiguration.java:60)
    	  at org.springframework.boot.actuate.autoconfigure.metrics.orm.jpa.HibernateMetricsAutoConfiguration$$Lambda$1179.1394343499.accept(Unknown Source:-1)
    	  at java.util.LinkedHashMap.forEach(LinkedHashMap.java:684)
    	  at org.springframework.boot.actuate.autoconfigure.metrics.orm.jpa.HibernateMetricsAutoConfiguration.bindEntityManagerFactoriesToRegistry(HibernateMetricsAutoConfiguration.java:60)
    	  at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(NativeMethodAccessorImpl.java:-1)
    	  at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
    	  at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    	  at java.lang.reflect.Method.invoke(Method.java:566)
    	  at org.springframework.beans.factory.annotation.AutowiredAnnotationBeanPostProcessor$AutowiredMethodElement.inject(AutowiredAnnotationBeanPostProcessor.java:755)
    	  at org.springframework.beans.factory.annotation.InjectionMetadata.inject(InjectionMetadata.java:130)
    	  at org.springframework.beans.factory.annotation.AutowiredAnnotationBeanPostProcessor.postProcessProperties(AutowiredAnnotationBeanPostProcessor.java:399)
    	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.populateBean(AbstractAutowireCapableBeanFactory.java:1420)
    	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:593)
    	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:516)
    	  at org.springframework.beans.factory.support.AbstractBeanFactory.lambda$doGetBean$0(AbstractBeanFactory.java:324)
    	  at org.springframework.beans.factory.support.AbstractBeanFactory$$Lambda$327.605705199.getObject(Unknown Source:-1)
    	  at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:226)
    	  - locked <0x2f53> (a java.util.concurrent.ConcurrentHashMap)
    	  at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:322)
    	  at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:202)
    	  at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:897)
    	  at org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:879)
    	  at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:551)
    	  - locked <0x2f54> (a java.lang.Object)
    	  at org.springframework.boot.web.servlet.context.ServletWebServerApplicationContext.refresh(ServletWebServerApplicationContext.java:143)
    	  at org.springframework.boot.SpringApplication.refresh(SpringApplication.java:758)
    	  at org.springframework.boot.SpringApplication.refresh(SpringApplication.java:750)
    	  at org.springframework.boot.SpringApplication.refreshContext(SpringApplication.java:397)
    	  at org.springframework.boot.SpringApplication.run(SpringApplication.java:315)
    	  at org.springframework.boot.SpringApplication.run(SpringApplication.java:1237)
    	  at org.springframework.boot.SpringApplication.run(SpringApplication.java:1226)
    	  at xyz.vehicledata.Application.main(Application.java:19)
    
    "task-1@8951" prio=5 tid=0x28 nid=NA waiting for monitor entry
      java.lang.Thread.State: BLOCKED
    	 waiting for main@1 to release lock on <0x2f53> (a java.util.concurrent.ConcurrentHashMap)
    	  at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:183)
    	  at org.springframework.beans.factory.support.AbstractBeanFactory.isTypeMatch(AbstractBeanFactory.java:523)
    	  at org.springframework.beans.factory.support.DefaultListableBeanFactory.doGetBeanNamesForType(DefaultListableBeanFactory.java:530)
    	  at org.springframework.beans.factory.support.DefaultListableBeanFactory.getBeanNamesForType(DefaultListableBeanFactory.java:503)
    	  at org.springframework.beans.factory.BeanFactoryUtils.beanNamesForTypeIncludingAncestors(BeanFactoryUtils.java:265)
    	  at org.springframework.beans.factory.support.DefaultListableBeanFactory.findAutowireCandidates(DefaultListableBeanFactory.java:1473)
    	  at org.springframework.beans.factory.support.DefaultListableBeanFactory.doResolveDependency(DefaultListableBeanFactory.java:1270)
    	  at org.springframework.beans.factory.support.DefaultListableBeanFactory.resolveDependency(DefaultListableBeanFactory.java:1227)
    	  at org.springframework.beans.factory.support.ConstructorResolver.resolveAutowiredArgument(ConstructorResolver.java:884)
    	  at org.springframework.beans.factory.support.ConstructorResolver.createArgumentArray(ConstructorResolver.java:788)
    	  at org.springframework.beans.factory.support.ConstructorResolver.autowireConstructor(ConstructorResolver.java:227)
    	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.autowireConstructor(AbstractAutowireCapableBeanFactory.java:1356)
    	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:1203)
    	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:556)
    	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:516)
    	  at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:353)
    	  at org.springframework.orm.hibernate5.SpringBeanContainer.createBean(SpringBeanContainer.java:147)
    	  at org.springframework.orm.hibernate5.SpringBeanContainer.getBean(SpringBeanContainer.java:105)
    	  at org.hibernate.resource.beans.internal.ManagedBeanRegistryImpl.getBean(ManagedBeanRegistryImpl.java:61)
    	  at org.hibernate.jpa.event.internal.CallbackBuilderLegacyImpl.resolveEntityCallbacks(CallbackBuilderLegacyImpl.java:200)
    	  at org.hibernate.jpa.event.internal.CallbackBuilderLegacyImpl.buildCallbacksForEntity(CallbackBuilderLegacyImpl.java:74)
    	  at org.hibernate.event.service.internal.EventListenerRegistryImpl.prepare(EventListenerRegistryImpl.java:146)
    	  at org.hibernate.boot.internal.MetadataImpl.initSessionFactory(MetadataImpl.java:379)
    	  at org.hibernate.internal.SessionFactoryImpl.<init>(SessionFactoryImpl.java:213)
    	  at org.hibernate.boot.internal.SessionFactoryBuilderImpl.build(SessionFactoryBuilderImpl.java:469)
    	  at org.hibernate.jpa.boot.internal.EntityManagerFactoryBuilderImpl.build(EntityManagerFactoryBuilderImpl.java:1259)
    	  at org.springframework.orm.jpa.vendor.SpringHibernateJpaPersistenceProvider.createContainerEntityManagerFactory(SpringHibernateJpaPersistenceProvider.java:58)
    	  at org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean.createNativeEntityManagerFactory(LocalContainerEntityManagerFactoryBean.java:365)
    	  at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean.buildNativeEntityManagerFactory(AbstractEntityManagerFactoryBean.java:391)
    	  at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean$$Lambda$931.256719132.call(Unknown Source:-1)
    	  at java.util.concurrent.FutureTask.run$$$capture(FutureTask.java:264)
    	  at java.util.concurrent.FutureTask.run(FutureTask.java:-1)
    	  at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
    	  at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
    	  at java.lang.Thread.run(Thread.java:834)
    
    "Catalina-utility-1@8461" prio=1 tid=0x22 nid=NA waiting
      java.lang.Thread.State: WAITING
    	  at jdk.internal.misc.Unsafe.park(Unsafe.java:-1)
    	  at java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
    	  at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
    	  at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1177)
    	  at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:899)
    	  at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
    	  at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
    	  at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
    	  at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
    	  at java.lang.Thread.run(Thread.java:834)
    
    "Catalina-utility-2@8467" prio=1 tid=0x23 nid=NA waiting
      java.lang.Thread.State: WAITING
    	  at jdk.internal.misc.Unsafe.park(Unsafe.java:-1)
    	  at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:234)
    	  at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123)
    	  at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1182)
    	  at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:899)
    	  at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
    	  at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
    	  at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
    	  at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
    	  at java.lang.Thread.run(Thread.java:834)
    
    "RMI Scheduler(0)@2870" daemon prio=5 tid=0x14 nid=NA waiting
      java.lang.Thread.State: WAITING
    	  at jdk.internal.misc.Unsafe.park(Unsafe.java:-1)
    	  at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:234)
    	  at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123)
    	  at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1182)
    	  at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:899)
    	  at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
    	  at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
    	  at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
    	  at java.lang.Thread.run(Thread.java:834)
    
    "hikari-cp-camiuns-vehicledata-scs housekeeper@8734" daemon prio=5 tid=0x26 nid=NA waiting
      java.lang.Thread.State: WAITING
    	  at jdk.internal.misc.Unsafe.park(Unsafe.java:-1)
    	  at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:234)
    	  at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123)
    	  at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1182)
    	  at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:899)
    	  at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
    	  at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
    	  at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
    	  at java.lang.Thread.run(Thread.java:834)
    
    "Common-Cleaner@1631" daemon prio=8 tid=0xb nid=NA waiting
      java.lang.Thread.State: WAITING
    	  at java.lang.Object.wait(Object.java:-1)
    	  at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:155)
    	  at jdk.internal.ref.CleanerImpl.run(CleanerImpl.java:148)
    	  at java.lang.Thread.run(Thread.java:834)
    	  at jdk.internal.misc.InnocuousThread.run(InnocuousThread.java:134)
    
    "RMI TCP Accept-0@1723" daemon prio=5 tid=0x10 nid=NA runnable
      java.lang.Thread.State: RUNNABLE
    	  at java.net.PlainSocketImpl.socketAccept(PlainSocketImpl.java:-1)
    	  at java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:458)
    	  at java.net.ServerSocket.implAccept(ServerSocket.java:565)
    	  at java.net.ServerSocket.accept(ServerSocket.java:533)
    	  at sun.management.jmxremote.LocalRMIServerSocketFactory$1.accept(LocalRMIServerSocketFactory.java:52)
    	  at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.executeAcceptLoop(TCPTransport.java:394)
    	  at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.run(TCPTransport.java:366)
    	  at java.lang.Thread.run(Thread.java:834)
    
    "RMI TCP Connection(1)-127.0.0.1@2625" daemon prio=5 tid=0x13 nid=NA runnable
      java.lang.Thread.State: RUNNABLE
    	  at java.net.SocketInputStream.socketRead0(SocketInputStream.java:-1)
    	  at java.net.SocketInputStream.socketRead(SocketInputStream.java:115)
    	  at java.net.SocketInputStream.read(SocketInputStream.java:168)
    	  at java.net.SocketInputStream.read(SocketInputStream.java:140)
    	  at java.io.BufferedInputStream.fill(BufferedInputStream.java:252)
    	  at java.io.BufferedInputStream.read(BufferedInputStream.java:271)
    	  - locked <0x2f57> (a java.io.BufferedInputStream)
    	  at java.io.FilterInputStream.read(FilterInputStream.java:83)
    	  at sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:544)
    	  at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:796)
    	  at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.lambda$run$0(TCPTransport.java:677)
    	  at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler$$Lambda$141.605553038.run(Unknown Source:-1)
    	  at java.security.AccessController.doPrivileged(AccessController.java:-1)
    	  at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:676)
    	  at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
    	  at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
    	  at java.lang.Thread.run(Thread.java:834)
    
    "container-0@8477" prio=5 tid=0x24 nid=NA sleeping
      java.lang.Thread.State: TIMED_WAITING
    	  at java.lang.Thread.sleep(Thread.java:-1)
    	  at org.apache.catalina.core.StandardServer.await(StandardServer.java:570)
    	  at org.springframework.boot.web.embedded.tomcat.TomcatWebServer$1.run(TomcatWebServer.java:197)
    
    "Keep-Alive-Timer@11851" daemon prio=8 tid=0x83 nid=NA sleeping
      java.lang.Thread.State: TIMED_WAITING
    	  at java.lang.Thread.sleep(Thread.java:-1)
    	  at sun.net.www.http.KeepAliveCache.run(KeepAliveCache.java:168)
    	  at java.lang.Thread.run(Thread.java:834)
    	  at jdk.internal.misc.InnocuousThread.run(InnocuousThread.java:134)
    
    "Reference Handler@12111" daemon prio=10 tid=0x2 nid=NA runnable
      java.lang.Thread.State: RUNNABLE
    	  at java.lang.ref.Reference.waitForReferencePendingList(Reference.java:-1)
    	  at java.lang.ref.Reference.processPendingReferences(Reference.java:241)
    	  at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:213)
    
    "Finalizer@12112" daemon prio=8 tid=0x3 nid=NA waiting
      java.lang.Thread.State: WAITING
    	  at java.lang.Object.wait(Object.java:-1)
    	  at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:155)
    	  at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:176)
    	  at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:170)
    
    "PostgreSQL-JDBC-SharedTimer-1@8722" daemon prio=5 tid=0x25 nid=NA waiting
      java.lang.Thread.State: WAITING
    	  at java.lang.Object.wait(Object.java:-1)
    	  at java.lang.Object.wait(Object.java:328)
    	  at java.util.TimerThread.mainLoop(Timer.java:527)
    	  at java.util.TimerThread.run(Timer.java:506)
    
    "Signal Dispatcher@12113" daemon prio=9 tid=0x4 nid=NA runnable
      java.lang.Thread.State: RUNNABLE
    
    "Attach Listener@2293" daemon prio=9 tid=0x12 nid=NA runnable
      java.lang.Thread.State: RUNNABLE
    
    
15. snicoll commented on Feb 11, 2021

    

    snicoll

    on Feb 11, 2021

    Member

    More actions

    @matf using deferred initialization for JPA means that you shouldn't be touching the JPA infrastructure on startup. It's not obvious why that is which is why we've decided to switch back to the default mode in Spring Boot, see spring-projects/spring-boot#24249.

    Encountered the same issue, hangs sometimes during startup while trying to inject EntityManagerFactory instances into HibernateMetricsAutoConfiguration

    If that's the regular auto-configuration, it shouldn't do that per spring-projects/spring-boot#23740.
16. rstoyanchev

    added

    in: dataIssues in data modules (jdbc, orm, oxm, tx)Issues in data modules (jdbc, orm, oxm, tx)

    on Nov 10, 2021
17. jhoeller commented on Nov 24, 2023

    

    jhoeller

    on Nov 24, 2023

    Contributor

    More actions

    If there is nothing that we can do about this from the core JPA support side, let's rather close this issue.
18. jhoeller

    closed this as completedon Nov 24, 2023
19. jhoeller

    added

    status: invalidAn issue that we don't feel is validAn issue that we don't feel is valid

    and removed

    status: waiting-for-triageAn issue we've not yet triaged or decided onAn issue we've not yet triaged or decided on

    on Nov 24, 2023
20. snicoll

    closed this as not plannedon Nov 24, 2023