스프링 부트에서 JPA를 사용해서 구현했는데 오래 걸리는 원인을 못 찾겠습니다.

Question

안녕하세요 jpa로 포트폴리오 만들고 있는 취업준비생입니다.처음에 코드를 잘못 짜서 N+1문제를 생각하지 않고 즉시로딩이 되게끔 코드를 짰습니다.상품이름으로 상품검색하는 기능을 구현했는데 "상품1", "상품2", "상품3",...."상품 1000"이 있을 때 "상품"이라는 키워드로 검색을 하면 상품 테이블과 연관관계 매핑된 상품 이미지 테이블을조회하는 1000개의 select 쿼리가 추가적으로 나가게 됩니다.그런데 10초가 걸리는 원인을 모르겠습니다. 아무리 1000개의 쿼리가 발생한다고 해도 10초가 걸리지는 않을 거 같은데 10초가 걸리는 이유를 도저히 모르겠ㅅ브니다.도와주십시오Product.java@Entity @ToString @Builder @NoArgsConstructor @AllArgsConstructor @Getter @Table(name = "tbl_product") @EntityListeners(AuditingEntityListener.class) public class Product { @Id @GeneratedValue(strategy = GenerationType.IDENTITY) private Long pno; private String pname; private int price; private String pdesc; private boolean delFlag; private Long categoryNum; @CreatedDate private LocalDateTime date; @Builder.Default private Long viewCount= Long.valueOf(0); @ManyToOne(fetch = FetchType.EAGER) private User seller; @ElementCollection(fetch = FetchType.LAZY) @Builder.Default private List imageList = new ArrayList<>(); public void changePrice(int price) { this.price = price; } public void changeDesc(String desc) { this.pdesc = desc; } public void changeName(String name) { this.pname = name; } public void addImage(ProductImage image) { image.setOrd(this.imageList.size()); imageList.add(image); } public void addImageString(String fileName) { ProductImage productImage = ProductImage.builder() .fileName(fileName) .build(); addImage(productImage); } public void clearList() { this.imageList.clear(); } public void setSeller(User seller) { this.seller = seller; } }ProductImage.java@Embeddable @Getter @ToString @Builder @AllArgsConstructor @NoArgsConstructor public class ProductImage { private String fileName; private int ord; public void setOrd(int ord){ this.ord = ord; } }ProductController.java @GetMapping("/search") public ResponseEntity searchProducts(@RequestParam String query) { try { List products = productService.searchProducts(query); log.info(products); return ResponseEntity.ok(products); } catch (Exception e) { return ResponseEntity.status(HttpStatus.INTERNAL_SERVER_ERROR).body(e.getMessage()); } }ProductService.javapublic interface ProductService { List searchProducts(String query); }ProductServiceImpl.java @Override public List searchProducts(String query) { //검색어를 포함하는 상품 리스트를 가져온다. List products = productRepository.findByPnameContainingIgnoreCase(query); List dtoList = products.stream().map(el -> entityToDTO(el)).collect(Collectors.toList()); return dtoList; }ProductRepository.javapublic interface ProductRepository extends JpaRepository { List findByPnameContainingIgnoreCase(String query); }"상품1", "상품2", "상품3",...."상품 1000"이 있을 때 "상품"이라는 키워드로 검색 할때 결과위와 같이 Product_image_list 테이블의 추가 select 쿼리가 나가게 됩니다. 그러나 1000개의 select 쿼리가 발생한다 해도 10초가 걸리지는 않을거 같은데 postman으로 측정하고 controller 시작과 끝 지점에 log로 찍어서 시간을 측정해도 거의 10초 내외로 끝나게 됩니다. 원인을 알 수 있는 방법 없을까요?N+1문제는 해결했지만 왜 10초나 걸리는지 알고 싶습니다.

장독깨기 · Accepted Answer

일단, select * from table 을 실행해서 조회하는 것과,쿼리문 1000개를 실행하는건 다릅니다. 그러니, 오래 걸릴 수 있습니다.좀 이상한 부분이 있는데요,지금 sql 문을 보면 상품테이블과 사용자 테이블을 조인하지 않고 있습니다.ManyToOne 관계에 Eagle 로 했는데, 왜 조인이 되지 않고 별도로 쿼리가 실행 되는지 모르겠군요.그리고, 상품이미지는 상품의 자식 관계잖아요, OneToMay 관계가 될테고, 그럼, Lazy 로 하셔야죠.그래서, 상품이 1000개면, 사용자테이블 조회 1000번, 상품이미지 조회 1000번 이렇게 되니까,쿼리문이 대략 2000개가 실행 될 거 같습니다.이럼 10초 걸릴 수 있겠네요.제가 JPA 를 사용하지 않아서요,일단, 상품과 사용자 테이블부터 조인이 되게 해결해야 할 거 같습니다.아, 또 있네요, 상품명 조건에 upper 이게 왜 붙어 있는거죠. 이것도 없어야 합니다.

Clickin · Answer

10초가 걸리지는 않을 것 같다는 근거가 뭔가요? 없지 않나요?1000개의 select를 쿼리 툴에서 한방에 다 돌려보면 제일 간편하게 측정 가능하고사실은 쿼리 로그에 수행시간을 찍는 편이 더 좋긴 하겠죠https://stackoverflow.com/questions/12656452/hibernate-show-query-execution-time하이버네이트 설정 바꿔서 좀 더 자세한 로그를 뽑아보고 분석해보시는 게 좋겠습니다.

집킨 · Answer

쿼리 로그 출력을 활성화해서 10초 걸린 것 같은데요

charlatan · Answer

상품과 상품이미지의 관계가 어떻게 되나요? 상품 1000개가 있으면 상품 이미지 1000개가 추가적으로 가져오는 것이라면 상품과 상품 이미지는 OneToOne으로 한거 아닌가 모르겠네요?

개못남 · Answer

ProductDto 로 변환하면서 ProductImage 에 뭔가를 호출하는거 아닌가요?

스프링 부트에서 JPA를 사용해서 구현했는데 오래 걸리는 원인을 못 찾겠습니다.

5개의 답변

#hibernate 목록