DisPatcherType Log 분석

Question

공부하다 보니 순서가 약간 헷갈리는 부분이 있어서 로그를 찍어보고 한줄한줄 분석해봤습니다. 혹시 틀린부분이 있을까요? ----------------------------------------------------------- 2022-04-28 07:52:56.269 INFO 25708 --- [nio-8080-exec-2] hello.exception.filter.LogFilter : REQUEST [308ffe99-3ee7-4dc4-ae86-aa87237d9e6c][REQUEST][/error-404] ->사용자가 "/error-404" 로 HTTP 요청을 보냅니다. 그러면 LogFilter 를 거쳐서 서블릿->인터셉터->컨트롤러로 이동합니다. ->이때 필터의 try/catch/finally 문 내부에 있는 chain.doFilter를 통해 연속적으로 필터가 호출되어야 하는데, 호출될 필터가 더이상 없으므로 서블릿을 호출합니다. ->서블릿에서 인터셉터를 거쳐 컨트롤러를 호출하고 컨트롤러에서 예외가 발생합니다.(NOT_FOUND) 2022-04-28 07:52:56.269 INFO 25708 --- [nio-8080-exec-2] hello.exception.filter.LogFilter : RESPONSE [308ffe99-3ee7-4dc4-ae86-aa87237d9e6c][REQUEST][/error-404] ->컨트롤러에서 예외가 발생(NOT_FOUND)했으므로, 다시 컨트롤러에서 WAS로 역순으로 이동하며 예외가 전파됩니다. ->이때, 필터의 try 구문을 빠져나오면서 catch 부분에서 예외를 잡아 throw 하므로, WAS까지 전파됩니다. ->try/catch 구문을 빠져나오면서 finally 구문이 실행됩니다. 이때 까지는 예외가 컨트롤러에서 WAS까지 전파되는 도중이므로,DispatcherType 이 REQUEST 입니다. 2022-04-28 07:52:56.270 INFO 25708 --- [nio-8080-exec-2] hello.exception.filter.LogFilter : REQUEST [77781cad-5a56-4621-b79c-447896d76265][ERROR][/error-page/404] ->WAS까지 예외가 성공적으로 전파되었으며 WAS에서 예외정보를 확인합니다. 예외가 WebServerCustomizer 에서 등록되어 있으므로(errorPage404객체) WAS는 내부적으로 "error-page/404"로 요청을 보냅니다. ->이때 DisPatcherType은 ERROR 입니다. 2022-04-28 07:52:56.270 INFO 25708 --- [nio-8080-exec-2] h.exception.servlet.ErrorPageController : ERROR_EXCEPTION = null 2022-04-28 07:52:56.270 INFO 25708 --- [nio-8080-exec-2] h.exception.servlet.ErrorPageController : ERROR_EXCEPTION_TYPE = null 2022-04-28 07:52:56.270 INFO 25708 --- [nio-8080-exec-2] h.exception.servlet.ErrorPageController : ERROR_MESSAGE = 404 오류 발생! 2022-04-28 07:52:56.270 INFO 25708 --- [nio-8080-exec-2] h.exception.servlet.ErrorPageController : ERROR_REQUEST_URI = /error-404 2022-04-28 07:52:56.270 INFO 25708 --- [nio-8080-exec-2] h.exception.servlet.ErrorPageController : ERROR_SERVLET_NAME = dispatcherServlet 2022-04-28 07:52:56.270 INFO 25708 --- [nio-8080-exec-2] h.exception.servlet.ErrorPageController : ERROR_STATUS_CODE = 404 2022-04-28 07:52:56.270 INFO 25708 --- [nio-8080-exec-2] h.exception.servlet.ErrorPageController : dispatcherType = ERROR 2022-04-28 07:52:56.270 INFO 25708 --- [nio-8080-exec-2] h.exception.servlet.ErrorPageController : errorPage404 -> WAS에서 LogFilter를 거쳐 서블릿, 인터셉터를 지나 ErrorPageController 의 errorPage404 메소드가 정상 호출되었음을 알립니다. 2022-04-28 07:52:56.271 INFO 25708 --- [nio-8080-exec-2] hello.exception.filter.LogFilter : RESPONSE [77781cad-5a56-4621-b79c-447896d76265][ERROR][/error-page/404] -> ErrorPageController에서 다시 WAS로 역순으로 이동합니다. 마찬가지로 컨트롤러 -> 인터셉터 -> 서블릿 -> 필터를 지나 WAS로 올라가는 과정에서 finally 구문이 호출됩니다. 이때는 서버에서 내부적으로 에러페이지를 가져오기위한 과정이었으므로 DispatcherType이 ERROR 입니다. -----------------------------------------------------------

김영한 · Answer

안녕하세요. KimYongHwan님 생각하신 부분이 맞는 것 같습니다. 감사합니다.