lazy loading 쿼리 문제

2024-06-15T19:47:56.267+09:00 DEBUG 12540 --- [jpa1] [nio-8080-exec-1] org.hibernate.SQL                        : 
    select
        o1_0.order_id,
        o1_0.delivery_id,
        o1_0.member_id,
        o1_0.order_date,
        o1_0.status 
    from
        orders o1_0 
    join
        member m1_0 
            on m1_0.member_id=o1_0.member_id 
    limit
        ?
2024-06-15T19:47:56.270+09:00 TRACE 12540 --- [jpa1] [nio-8080-exec-1] org.hibernate.orm.jdbc.bind              : binding parameter (1:INTEGER) <- [1000]
2024-06-15T19:47:56.285+09:00 DEBUG 12540 --- [jpa1] [nio-8080-exec-1] org.hibernate.SQL                        : 
    select
        m1_0.member_id,
        m1_0.city,
        m1_0.street,
        m1_0.zipcode,
        m1_0.name 
    from
        member m1_0 
    where
        m1_0.member_id=?
2024-06-15T19:47:56.285+09:00 TRACE 12540 --- [jpa1] [nio-8080-exec-1] org.hibernate.orm.jdbc.bind              : binding parameter (1:BIGINT) <- [1]
2024-06-15T19:47:56.291+09:00 DEBUG 12540 --- [jpa1] [nio-8080-exec-1] org.hibernate.SQL                        : 
    select
        d1_0.delivery_id,
        d1_0.city,
        d1_0.street,
        d1_0.zipcode,
        d1_0.status 
    from
        delivery d1_0 
    where
        d1_0.delivery_id=?
2024-06-15T19:47:56.291+09:00 TRACE 12540 --- [jpa1] [nio-8080-exec-1] org.hibernate.orm.jdbc.bind              : binding parameter (1:BIGINT) <- [1]
2024-06-15T19:47:56.295+09:00 DEBUG 12540 --- [jpa1] [nio-8080-exec-1] org.hibernate.SQL                        : 
    select
        o1_0.order_id,
        o1_0.delivery_id,
        o1_0.member_id,
        o1_0.order_date,
        o1_0.status 
    from
        orders o1_0 
    where
        o1_0.delivery_id=?
2024-06-15T19:47:56.296+09:00 TRACE 12540 --- [jpa1] [nio-8080-exec-1] org.hibernate.orm.jdbc.bind              : binding parameter (1:BIGINT) <- [1]
2024-06-15T19:47:56.298+09:00 DEBUG 12540 --- [jpa1] [nio-8080-exec-1] org.hibernate.SQL                        : 
    select
        m1_0.member_id,
        m1_0.city,
        m1_0.street,
        m1_0.zipcode,
        m1_0.name 
    from
        member m1_0 
    where
        m1_0.member_id=?
2024-06-15T19:47:56.298+09:00 TRACE 12540 --- [jpa1] [nio-8080-exec-1] org.hibernate.orm.jdbc.bind              : binding parameter (1:BIGINT) <- [2]
2024-06-15T19:47:56.300+09:00 DEBUG 12540 --- [jpa1] [nio-8080-exec-1] org.hibernate.SQL                        : 
    select
        d1_0.delivery_id,
        d1_0.city,
        d1_0.street,
        d1_0.zipcode,
        d1_0.status 
    from
        delivery d1_0 
    where
        d1_0.delivery_id=?
2024-06-15T19:47:56.300+09:00 TRACE 12540 --- [jpa1] [nio-8080-exec-1] org.hibernate.orm.jdbc.bind              : binding parameter (1:BIGINT) <- [2]
2024-06-15T19:47:56.302+09:00 DEBUG 12540 --- [jpa1] [nio-8080-exec-1] org.hibernate.SQL                        : 
    select
        o1_0.order_id,
        o1_0.delivery_id,
        o1_0.member_id,
        o1_0.order_date,
        o1_0.status 
    from
        orders o1_0 
    where
        o1_0.delivery_id=?
2024-06-15T19:47:56.302+09:00 TRACE 12540 --- [jpa1] [nio-8080-exec-1] org.hibernate.orm.jdbc.bind              : binding parameter (1:BIGINT) <- [2]

    @GetMapping("api/v2/simple-orders")
    public List<SimpleOrderDto> ordersV2() {
        List<Order> orders = orderRepository.findAllByString(new OrderSearch());
        List<SimpleOrderDto> result = orders.stream().map(order -> new SimpleOrderDto(order))
                .collect(Collectors.toList());
        return result;
    }

    @Getter
    public static class SimpleOrderDto {
        private Long orderId;
        private String name;
        private LocalDateTime orderDate;
        private OrderStatus orderStatus;
        private Address address;

        public SimpleOrderDto(Order order) {
            orderId = order.getId();
            name = order.getMember().getName();
            orderDate = order.getOrderDate();
            orderStatus = order.getStatus();
            address = order.getDelivery().getAddress();
        }
    }

강의 자료와 같은 코드인 것 같은데 쿼리가 한 번씩 더 나가서 질문 드립니다.

처음에 order와 member를 join하는 쿼리 하나 실행

그 뒤로 member 조회 쿼리, delivery 조회 쿼리 하나씩 실행되는 건 이해가 됩니다.

그런데 그 뒤로 order 테이블에서 특정 delivery_id에 해당하는 걸 조회하는 쿼리가 하나씩 또 나갑니다.

이 부분이 왜 발생하는지 찾기가 힘들어서 질문을 남깁니다.

안녕하세요, 인프런 AI 인턴입니다. 정민교님의 질문에 대하여 관련 내용을 찾았습니다.

정민교님의 경우, @GetMapping("api/v2/simple-orders")를 통해 간단한 주문 조회 기능을 구현하시면서, 예상치 못한 추가 쿼리 발생으로 인한 성능 이슈를 겪고 계시는 것으로 보입니다. 특히, delivery_id에 기반해 orders 테이블을 다시 조회하는 쿼리가 발생하는 부분에서 문제를 겪고 있다고 언급하셨습니다.

이와 유사한 상황이 강의 질문&답변 섹션에서도 언급되었습니다. 해당 질문에서는 /api/v2/simple-orders URL을 호출했을 때 예상보다 더 많은 쿼리가 발생하는 문제가 논의되었으며, 이는 Hibernate 버전 업데이트 후 일부 변경된 행동 때문일 가능성이 높습니다. 이 경우, Hibernate 5 버전과 Hibernate 6 버전 사이의 행동 차이가 원인일 수 있습니다.

다음과 같은 예시 답변이 그 예입니다.
- 쿼리가 강의보다 더 나오고 있습니다.

해당 답변에서는 유사한 문제를 경험한 다른 사용자에게 관련 내용을 설명하고 있습니다. 하이버네이트의 버전 차이에 따른 쿼리 실행 방식의 변화가 주된 이유로 보이며, 이는 질문자가 겪고 있는 문제와 근본적으로 관련이 있을 수 있습니다.

주어진 상황과 비슷한 문제를 겪고 계신다면, 하이버네이트의 버전을 확인하거나, 영속성 컨텍스트와 프록시 객체의 동작 방식에 대해 추가적으로 검토해볼 필요가 있습니다. 특히, 엔티티 간의 관계 설정(Lazy Loading, Eager Loading)과 이로 인해 발생할 수 있는 N+1 문제점을 점검하는 것이 중요합니다.

저는 질문자님의 이해를 돕고자 지식공유자님의 기존 답변을 참고하여 유사한 답변 링크를 추천해드리고 있습니다.
현재 베타 기능으로 답변이 만족스럽지 않을 수 있는 점 양해 부탁드립니다. 🙏
추가적으로 궁금한 점이 있으시면, 이어서 질문해 주세요. 곧 지식공유자께서 답변해 주실 것입니다.

인프런 커뮤니티 질문&답변