Trouble Shooting
Spring + Undertow 사용시 Exception 로깅 안됨
소농배
2024. 9. 30. 10:27
Spring MVC (Kotlin) + Undertow 를 사용한 운영 서버에서 아래와 같이 500 응답을 받았지만 서버에는 관련된 로그가 남아있지 않음.
{
"timestamp" : 1727658994786,
"status": 500,
"error": "Internal Server Error",
"message": "Internal Server Error",
"path": "/search"
}
예외가 발생한 부분은 Kotlin 에서 Non Null 로 정의된 필드에 DB 에서 불러온 데이터를 맵핑할때 null 값이 할당되어 MissingKotlinParameterException 이 발생한 것으로 추정됨.
해당 예외가 아닌 다른 예외들은 로컬에서 로그가 남고 있어서 어느 부분에서 차이가 생기는지 확인해보니, undertow 의 LoggingExceptionHandler 에서 로깅을 남기고 있었고 아래 로직 처럼 예외 종류의 따라서 어떤 Level 로 로깅을 남기지 정하고 있었다.
ExceptionLog log = t.getClass().getAnnotation(ExceptionLog.class);
if (details != null) {
Logger.Level level = details.level;
Logger.Level stackTraceLevel = details.stackTraceLevel;
String category = details.category;
handleCustomLog(exchange, t, level, stackTraceLevel, category);
} else if (log != null) {
Logger.Level level = log.value();
Logger.Level stackTraceLevel = log.stackTraceLevel();
String category = log.category();
handleCustomLog(exchange, t, level, stackTraceLevel, category);
} else if (t instanceof IOException) {
//we log IOExceptions at a lower level
//because they can be easily caused by malicious remote clients in at attempt to DOS the server by filling the logs
UndertowLogger.REQUEST_IO_LOGGER.debugf(t, "Exception handling request to %s", exchange.getRequestURI());
} else {
UndertowLogger.REQUEST_LOGGER.exceptionHandlingRequest(t, exchange.getRequestURI());
}
MissingKotlinParameterException 는 IOException 을 상속하여 UndertowLogger.REQUEST_IO_LOGGER.debugf() 구문을 타게 되었고 Debug 레벨로 로깅이 되어 운영/로컬 환경에서 logback 설정에 의해 로깅이 남지 않았던 것이다.
udertow github 의 해당 클래스에는 DOS 공격을 방지하고자 debug 레벨로 로깅은 남긴다는 주석이 남아있다. 하지만, MissingKotlinParameterException 말고도 SocketTimeOutException 과 같이 운영상에 탐지가 필요한 중요한 예외들의 로깅들도 모두 Debug 레벨로 남고 있어서 개선이 필요해 보인다.