Spring Boot项目启动耗时突增问题排查求助

问题现象 #

近期Spring Boot项目启动耗时突然变长，从日志片段可见，启动过程在Hibernate实体映射阶段出现明显卡顿：

2023-03-14 10:36:04,113 [restartedMain] DEBUG o.h.i.internal.IntegratorServiceImpl               - 添加集成器 [org.hibernate.cfg.beanvalidation.BeanValidationIntegrator].
2023-03-14 10:36:04,247 [restartedMain] DEBUG o.h.i.internal.IntegratorServiceImpl               - 添加集成器 [org.hibernate.secure.spi.JaccIntegrator].
2023-03-14 10:36:04,395 [restartedMain] DEBUG o.h.i.internal.IntegratorServiceImpl               - 添加集成器 [org.hibernate.cache.internal.CollectionCacheInvalidator].
2023-03-14 10:36:04,660 [restartedMain] INFO  org.hibernate.Version                              - HHH000412: Hibernate Core {5.4.9.Final}
2023-03-14 10:36:04,760 [restartedMain] DEBUG org.hibernate.cfg.Environment                      - HHH000206: 未找到hibernate.properties
2023-03-14 10:36:04,913 [restartedMain] DEBUG org.hibernate.service.spi.ServiceBinding           - 覆盖现有服务绑定 [org.hibernate.secure.spi.JaccService]
2023-03-14 10:36:04,995 [restartedMain] DEBUG o.h.c.internal.RegionFactoryInitiator              - 无法基于已注册策略默认RegionFactory，因为未注册任何`[]` RegionFactory策略
2023-03-14 10:36:05,131 [restartedMain] DEBUG o.h.c.internal.RegionFactoryInitiator              - 缓存区域工厂: org.hibernate.cache.internal.NoCachingRegionFactory
2023-03-14 10:36:05,288 [restartedMain] INFO  org.hibernate.annotations.common.Version           - HCANN000001: Hibernate Commons Annotations {5.1.0.Final}
2023-03-14 10:36:05,449 [restartedMain] DEBUG org.hibernate.type.BasicTypeRegistry               - 添加类型注册 boolean -> org.hibernate.type.BooleanType@2801d36c

...

2023-03-14 10:42:34,943 [restartedMain] DEBUG org.hibernate.cfg.Ejb3Column                       - 绑定列: Ejb3Column{table=org.hibernate.mapping.Table(bulk_transfer_details), mappingColumn=resp, insertable=true, updatable=true, unique=false}
2023-03-14 10:42:35,569 [restartedMain] DEBUG o.h.cfg.annotations.PropertyBinder                 - MetadataSourceProcessor属性resp的lazy=false
2023-03-14 10:42:36,171 [restartedMain] DEBUG org.hibernate.cfg.AbstractPropertyHolder           - 尝试为属性 [com.ideationhouse.paddieswitch.domains.BulkBankTransferDetail:resp] 查找自动应用的AttributeConverter
2023-03-14 10:42:36,799 [restartedMain] DEBUG o.h.cfg.annotations.SimpleValueBinder              - 为resp构建SimpleValue
2023-03-14 10:42:37,413 [restartedMain] DEBUG o.h.cfg.annotations.PropertyBinder                 - 构建属性resp
2023-03-14 10:42:38,008 [restartedMain] DEBUG org.hibernate.cfg.Ejb3Column                       - 绑定列: Ejb3Column{table=org.hibernate.mapping.Table(bulk_transfer_details), mappingColumn=response_code, insertable=true, updatable=true, unique=false}
2023-03-14 10:42:38,639 [restartedMain] DEBUG o.h.cfg.annotations.PropertyBinder                 - MetadataSourceProcessor属性responseCode的lazy=false
2023-03-14 10:42:39,298 [restartedMain] DEBUG org.hibernate.cfg.AbstractPropertyHolder           - 尝试为属性 [com.ideationhouse.paddieswitch.domains.BulkBankTransferDetail:responseCode] 查找自动应用的AttributeConverter

从时间戳可见，Hibernate从初始化到解析BulkBankTransferDetail实体的属性，耗时超过6分钟，这是启动变慢的核心原因。

可能成因 #

• 实体规模或复杂度提升：近期新增大量实体类，或实体之间新增了复杂的关联关系、嵌套结构，导致Hibernate需要花费更多时间解析注解、绑定数据库列、处理属性映射。
• AttributeConverter扫描效率低下：日志反复出现查找自动应用转换器的操作，若自定义转换器过多、未明确标注@AutoApplyConverter，或转换器扫描范围不合理，会导致Hibernate每次解析属性都要全量扫描转换器，增加耗时。
• Hibernate元数据缓存未启用：日志显示使用NoCachingRegionFactory，未启用元数据缓存，每次启动都要重新解析所有实体元数据，无法复用缓存结果。
• 类路径扫描范围过大：Spring Boot自动扫描范围过广，加上Hibernate需要处理所有扫描到的实体，进一步拉长解析时间。
• 依赖版本问题：Hibernate 5.4.9可能存在元数据解析的性能bug，或与Spring Boot、Spring Data JPA等依赖版本不兼容，导致启动阶段性能下降。

解决思路 #

1. 优化实体解析流程 #

• 清理冗余实体：删除不再使用的实体类，拆分过于复杂的实体结构，减少Hibernate需要解析的对象数量。
• 限定实体扫描范围：通过@EntityScan注解指定实体所在的包，或在application.properties中配置实体扫描路径，避免全类路径扫描。

2. 优化AttributeConverter处理 #

• 明确转换器应用规则：给自定义转换器添加@AutoApplyConverter注解，让Hibernate直接识别应用范围，避免逐个属性查找；或在实体属性上通过@Convert指定转换器，减少自动扫描开销。
• 精简转换器：合并功能重复的转换器，移除不必要的自定义转换器。

3. 启用Hibernate元数据缓存 #

• 配置二级缓存实现：选择合适的缓存提供商（如Ehcache、Redis），添加以下配置：

  spring.jpa.properties.hibernate.cache.region.factory_class=org.hibernate.cache.jcache.JCacheRegionFactory
  spring.jpa.properties.hibernate.cache.use_metadata_cache=true
  spring.jpa.properties.hibernate.cache.use_second_level_cache=true
  

  启用元数据缓存后，Hibernate会复用已解析的实体元数据，减少启动时的解析时间。

4. 排查依赖与版本 #

• 升级Hibernate版本：将Hibernate Core升级到5.4.x系列的最新稳定版，修复已知的性能bug；确保Spring Boot与Hibernate版本兼容（如Spring Boot 2.2.x适配Hibernate 5.4.x）。
• 排查新增依赖：检查近期引入的依赖，确认是否有组件会干扰Hibernate的元数据解析流程，必要时移除或替换。

5. 启动性能 profiling #

• 使用Spring Boot Actuator：开启spring-boot-starter-actuator依赖，配置management.endpoints.web.exposure.include=startup，通过/actuator/startup端点获取启动阶段的耗时详情，定位具体瓶颈步骤。
• 使用JVM监控工具：用JProfiler、VisualVM等工具跟踪启动时的线程栈，查看Hibernate解析阶段具体卡在哪个方法，针对性优化。

内容的提问来源于stack exchange，提问作者Olumayokun Fowowe