DONE이 갑자기 연속적으로 2개가 세이브되는 현상 발생

[Wooin-dev]

2024-07-19T05:27:00.348Z TRACE 1 --- [nio-8080-exec-5] o.s.t.i.TransactionInterceptor           : Getting transaction for [com.wooin.dailyone.service.UserService.loadUserByEmail]
2024-07-19T05:27:00.352Z  INFO 1 --- [nio-8080-exec-5] c.w.d.repository.UserCacheRepository     : Get User from Redis USER:wooin@done.com - null
2024-07-19T05:27:00.353Z TRACE 1 --- [nio-8080-exec-5] o.s.t.i.TransactionInterceptor           : No need to create transaction for [org.springframework.data.jpa.repository.support.SimpleJpaRepository.findByEmail]: This method is not transactional.
Hibernate: 
    select
        u1_0.id,
        u1_0.created_at,
        u1_0.created_by,
        u1_0.deleted_at,
        u1_0.email,
        u1_0.kakao_id,
        u1_0.modified_at,
        u1_0.modified_by,
        u1_0.nickname,
        u1_0.password,
        u1_0.role 
    from
        users u1_0 
    where
        (
            u1_0.deleted_at is NULL
        ) 
        and u1_0.email=?
2024-07-19T05:27:00.367Z TRACE 1 --- [nio-8080-exec-5] o.s.t.i.TransactionInterceptor           : Completing transaction for [com.wooin.dailyone.service.UserService.loadUserByEmail]
2024-07-19T05:27:00.371Z DEBUG 1 --- [nio-8080-exec-5] o.s.web.servlet.DispatcherServlet        : POST "/api/v1/done/6", parameters={}
2024-07-19T05:27:00.372Z DEBUG 1 --- [nio-8080-exec-5] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped to com.wooin.dailyone.controller.DoneController#createDone(Long, Authentication)
2024-07-19T05:27:00.495Z TRACE 1 --- [nio-8080-exec-5] o.s.t.i.TransactionInterceptor           : Getting transaction for [com.wooin.dailyone.service.DoneService.createDone]
2024-07-19T05:27:00.498Z TRACE 1 --- [nio-8080-exec-5] o.s.t.i.TransactionInterceptor           : Getting transaction for [org.springframework.data.jpa.repository.support.SimpleJpaRepository.getReferenceById]
2024-07-19T05:27:00.511Z TRACE 1 --- [nio-8080-exec-5] o.s.t.i.TransactionInterceptor           : Completing transaction for [org.springframework.data.jpa.repository.support.SimpleJpaRepository.getReferenceById]
2024-07-19T05:27:00.511Z TRACE 1 --- [nio-8080-exec-5] o.s.t.i.TransactionInterceptor           : No need to create transaction for [org.springframework.data.jpa.repository.support.SimpleJpaRepository.findByPromiseGoalAndCreatedAtBetween]: This method is not transactional.
Hibernate: 
    select
        d1_0.id,
        d1_0.created_at,
        d1_0.deleted_at,
        d1_0.modified_at,
        d1_0.promise_goal_id 
    from
        done d1_0 
    where
        (
            d1_0.deleted_at is NULL
        ) 
        and d1_0.promise_goal_id=? 
        and d1_0.created_at between ? and ?
2024-07-19T05:27:00.522Z TRACE 1 --- [nio-8080-exec-5] o.s.t.i.TransactionInterceptor           : Getting transaction for [org.springframework.data.jpa.repository.support.SimpleJpaRepository.save]
2024-07-19T05:27:01.059Z TRACE 1 --- [nio-8080-exec-3] o.s.t.i.TransactionInterceptor           : Getting transaction for [com.wooin.dailyone.service.UserService.loadUserByEmail]
2024-07-19T05:27:01.061Z  INFO 1 --- [nio-8080-exec-3] c.w.d.repository.UserCacheRepository     : Get User from Redis USER:wooin@done.com - null
2024-07-19T05:27:01.061Z TRACE 1 --- [nio-8080-exec-3] o.s.t.i.TransactionInterceptor           : No need to create transaction for [org.springframework.data.jpa.repository.support.SimpleJpaRepository.findByEmail]: This method is not transactional.
Hibernate: 
    select
        u1_0.id,
        u1_0.created_at,
        u1_0.created_by,
        u1_0.deleted_at,
        u1_0.email,
        u1_0.kakao_id,
        u1_0.modified_at,
        u1_0.modified_by,
        u1_0.nickname,
        u1_0.password,
        u1_0.role 
    from
        users u1_0 
    where
        (
            u1_0.deleted_at is NULL
        ) 
        and u1_0.email=?
2024-07-19T05:27:01.072Z TRACE 1 --- [nio-8080-exec-3] o.s.t.i.TransactionInterceptor           : Completing transaction for [com.wooin.dailyone.service.UserService.loadUserByEmail]
2024-07-19T05:27:01.076Z DEBUG 1 --- [nio-8080-exec-3] o.s.web.servlet.DispatcherServlet        : POST "/api/v1/done/6", parameters={}
2024-07-19T05:27:01.077Z DEBUG 1 --- [nio-8080-exec-3] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped to com.wooin.dailyone.controller.DoneController#createDone(Long, Authentication)
2024-07-19T05:27:01.079Z TRACE 1 --- [nio-8080-exec-3] o.s.t.i.TransactionInterceptor           : Getting transaction for [com.wooin.dailyone.service.DoneService.createDone]
2024-07-19T05:27:01.080Z TRACE 1 --- [nio-8080-exec-3] o.s.t.i.TransactionInterceptor           : Getting transaction for [org.springframework.data.jpa.repository.support.SimpleJpaRepository.getReferenceById]
2024-07-19T05:27:01.081Z TRACE 1 --- [nio-8080-exec-3] o.s.t.i.TransactionInterceptor           : Completing transaction for [org.springframework.data.jpa.repository.support.SimpleJpaRepository.getReferenceById]
2024-07-19T05:27:01.081Z TRACE 1 --- [nio-8080-exec-3] o.s.t.i.TransactionInterceptor           : No need to create transaction for [org.springframework.data.jpa.repository.support.SimpleJpaRepository.findByPromiseGoalAndCreatedAtBetween]: This method is not transactional.
Hibernate: 
    select
        d1_0.id,
        d1_0.created_at,
        d1_0.deleted_at,
        d1_0.modified_at,
        d1_0.promise_goal_id 
    from
        done d1_0 
    where
        (
            d1_0.deleted_at is NULL
        ) 
        and d1_0.promise_goal_id=? 
        and d1_0.created_at between ? and ?
2024-07-19T05:27:01.086Z TRACE 1 --- [nio-8080-exec-3] o.s.t.i.TransactionInterceptor           : Getting transaction for [org.springframework.data.jpa.repository.support.SimpleJpaRepository.save]
Hibernate: 
    insert 
    into
        done
        (created_at, deleted_at, modified_at, promise_goal_id) 
    values
        (?, ?, ?, ?)
Hibernate: 
    insert 
    into
        done
        (created_at, deleted_at, modified_at, promise_goal_id) 
    values
        (?, ?, ?, ?)
2024-07-19T05:27:01.220Z TRACE 1 --- [nio-8080-exec-5] o.s.t.i.TransactionInterceptor           : Completing transaction for [org.springframework.data.jpa.repository.support.SimpleJpaRepository.save]
2024-07-19T05:27:01.221Z TRACE 1 --- [nio-8080-exec-5] o.s.t.i.TransactionInterceptor           : Completing transaction for [com.wooin.dailyone.service.DoneService.createDone]
2024-07-19T05:27:01.221Z TRACE 1 --- [nio-8080-exec-3] o.s.t.i.TransactionInterceptor           : Completing transaction for [org.springframework.data.jpa.repository.support.SimpleJpaRepository.save]
2024-07-19T05:27:01.222Z TRACE 1 --- [nio-8080-exec-3] o.s.t.i.TransactionInterceptor           : Completing transaction for [com.wooin.dailyone.service.DoneService.createDone]
2024-07-19T05:27:01.273Z DEBUG 1 --- [nio-8080-exec-3] m.m.a.RequestResponseBodyMethodProcessor : Using 'application/json', given [application/json, text/plain, */*] and supported [application/json, application/*+json]
2024-07-19T05:27:01.273Z DEBUG 1 --- [nio-8080-exec-3] m.m.a.RequestResponseBodyMethodProcessor : Writing [com.wooin.dailyone.controller.response.Response@9914cc6]
2024-07-19T05:27:01.274Z DEBUG 1 --- [nio-8080-exec-5] m.m.a.RequestResponseBodyMethodProcessor : Using 'application/json', given [application/json, text/plain, */*] and supported [application/json, application/*+json]
2024-07-19T05:27:01.274Z DEBUG 1 --- [nio-8080-exec-5] m.m.a.RequestResponseBodyMethodProcessor : Writing [com.wooin.dailyone.controller.response.Response@4cc96813]
2024-07-19T05:27:01.275Z DEBUG 1 --- [nio-8080-exec-5] o.s.web.servlet.DispatcherServlet        : Completed 200 OK
2024-07-19T05:27:01.276Z DEBUG 1 --- [nio-8080-exec-3] o.s.web.servlet.DispatcherServlet        : Completed 200 OK

[Wooin-dev]

두개가 리턴되서 오류가 남.

• [ ] 일시적 오류로 두개의 done이 등록이 되더라도 하나의 done만 불러오도록 하는것이 좋을지

2024-07-19T05:31:32.162Z TRACE 1 --- [nio-8080-exec-1] o.s.t.i.TransactionInterceptor           : Completing transaction for [com.wooin.dailyone.service.PromiseGoalService.selectMyPromiseGoalList] after exception: org.springframework.dao.IncorrectResultSizeDataAccessException: Query did not return a unique result: 2 results were returned
2024-07-19T05:31:32.165Z DEBUG 1 --- [nio-8080-exec-1] .m.m.a.ExceptionHandlerExceptionResolver : Using @ExceptionHandler com.wooin.dailyone.exception.GlobalControllerAdvice#applicationHandler(RuntimeException)
2024-07-19T05:31:32.166Z ERROR 1 --- [nio-8080-exec-1] c.w.d.exception.GlobalControllerAdvice   : Error occurs org.springframework.dao.IncorrectResultSizeDataAccessException: Query did not return a unique result: 2 results were returned
2024-07-19T05:31:32.166Z DEBUG 1 --- [nio-8080-exec-1] o.s.w.s.m.m.a.HttpEntityMethodProcessor  : Using 'application/json', given [application/json, text/plain, */*] and supported [application/json, application/*+json]
2024-07-19T05:31:32.167Z DEBUG 1 --- [nio-8080-exec-1] o.s.w.s.m.m.a.HttpEntityMethodProcessor  : Writing [com.wooin.dailyone.controller.response.Response@162a60ed]
2024-07-19T05:31:32.168Z DEBUG 1 --- [nio-8080-exec-1] .m.m.a.ExceptionHandlerExceptionResolver : Resolved [org.springframework.dao.IncorrectResultSizeDataAccessException: Query did not return a unique result: 2 results were returned]

[Wooin-dev]

일명 '따닥' 현상

중복적으로 들어온 요청에 대해 중복요청을 처리한 내용의 블로그를 몇몇 찾을 수 있었다.

• 레디스를 활용, 분산락 구현
• 분산환경속 타임아웃 설정을 통한 중복요청 해결
• AOP를 활용하여 중복요청 제거
• Redis분산락을 AOP를 통해 적용, 컬리 블로그

선택한 방향

• AOP를 통해 응답이 들어오면 uri 리스트를 set에 두고 응답이 완료됐을때 set에서 제거하는 방식.
• 응답이 완료되기전 또다시 요청이 들어온다면 많은 요청이 들어온것으로 간주 예외 발생.

[Wooin-dev]

AOP를 활용하여 중복요청 제거

해당방식의 한계점 발견하여 철회

• 동일한 결과보장 못함
• 모든 요청에 적용되면 비효율적인 방식과 병목현상 우려

[Wooin-dev]

Redis분산락을 AOP를 통해 적용, 컬리 블로그

위 링크의 방식을 통해 해결.

고민할 점

• 락을 획득하지 못 했을때, 일정시간 대기한 후 동작을 굳이 할 필요가 없는 비즈니스 로직도 필요해 보임.
• 현재는 대기시간 내에 락을 얻고자 대기하게 됨.
  • done 생성과 같은 경우는 락을 얻지 못할 경우 바로 예외처리로 로직을 종료시켜도 무방함.

해당 과정을 정리한 블로그