Microsoft MVP성태의 닷넷 이야기
글쓴 사람
정성태 (techsharer at outlook.com)
홈페이지
첨부 파일

.NET Core/5+ - 에러 로깅을 위한 Middleware가 동작하지 않는 경우

실습을 해볼까요? ^^ .NET 6/기본 웹 애플리케이션 API 프로젝트를 만든 후, 코드에 예외를 발생하는 상황을 만들어둡니다.

// WeatherForecastController.cs
[HttpGet]
public IEnumerable<WeatherForecast> Get()
{
    if (HttpContext.Request.Query.TryGetValue("test", out _) == true)
    {
        throw new ApplicationException("test is not null");
    }

    return Enumerable.Range(1, 5).Select(index => new WeatherForecast
    {
        Date = DateTime.Now.AddDays(index),
        TemperatureC = Random.Shared.Next(-20, 55),
        Summary = Summaries[Random.Shared.Next(Summaries.Length)]
    })
    .ToArray();
}

당연히 이 상황에서는 "http://localhost:5202/weatherforecast?test=1" 요청을 전송하면 예외가 발생할 것입니다. 자, 그럼 이 예외를 전역적으로 한 곳에서 처리하기 위해 Middleware를 하나 만들어보겠습니다.

public class ErrorLoggingMiddleware
{
    private readonly RequestDelegate _next;

    public ErrorLoggingMiddleware(RequestDelegate next)
    {
        _next = next;
    }

    public async Task Invoke(HttpContext context)
    {
        try
        {
            await _next(context);
        }
        catch (Exception e)
        {
            System.Diagnostics.Debug.WriteLine($"The following error happened: {e.Message}");
        }
    }
}

그리고 이것을 .NET Core/5+ Pipeline에 등록해 주면,

// Program.cs

public static void Main(string[] args)
{
    var builder = WebApplication.CreateBuilder(args);

    // Add services to the container.

    builder.Services.AddControllers();

    var app = builder.Build();

    // Configure the HTTP request pipeline.
    app.UseMiddleware<ErrorLoggingMiddleware>();

    app.UseAuthorization();


    app.MapControllers();

    app.Run();
}

이후 "http://localhost:5202/weatherforecast?test=1" 요청에 대해 ErrorLoggingMiddleware.Invoke 내에서 try/catch에 걸려 System.Diagnostics.Debug.WriteLine 코드가 동작하는 것을 확인할 수 있습니다.




그런데, ErrorLoggingMiddleware가 동작하지 않을 수도 있습니다. 왜냐하면 Web API를 처리하는 또 다른 Middleware가 등록돼 중간에서 예외를 가로챌 수 있기 때문입니다. 그리고 그러한 가장 대표적인 예가 ASP.NET Core에서 제공하는 "DeveloperExceptionPageMiddleware"입니다. 그래서 이것을 우리가 만든 Middleware 다음에 등록하면,

// ...[생략]..

// Configure the HTTP request pipeline.
app.UseMiddleware<ErrorLoggingMiddleware>();
app.UseDeveloperExceptionPage();

// ...[생략]..

Web API에서 발생한 예외를 DeveloperExceptionPageMiddleware에서 먼저 catch하게 되고 이전에 등록된 Middleware에서는 예외 처리가 안 되는 것입니다. 따라서 이런 경우 우리가 만든 ErrorLoggingMiddleware에서 예외를 받고 싶다면 UseDeveloperExceptionPage 호출을 제거해야 합니다.

이런 이유로 인해, 사실 예외 로깅을 위한 Middleware는 예외를 먹을 것이 아니라, 다시 throw하는 것이 더 바람직합니다.

public class ErrorLoggingMiddleware
{
    // ...[생략]...

    public async Task Invoke(HttpContext context)
    {
        try
        {
            await _next(context);
        }
        catch (Exception e)
        {
            System.Diagnostics.Debug.WriteLine($"The following error happened: {e.Message}");
            throw;
        }
    }
}

저렇게 해주면, 우리가 만든 ErrorLoggingMiddleware는 UseDeveloperExceptionPage(또는, 예외 처리를 목적으로 하는 다른 Middleware)의 호출 위치에 상관없이 DeveloperExceptionPageMiddleware의 동작에는 영향을 주지 않습니다.




참고로, DeveloperExceptionPageMiddleware가 예외를 먹는 것이 잘못된 동작은 아닙니다. 왜냐하면 그 페이지는 예외 상황을 HTML로 구성해 내려주는 역할을 하기 때문에 거기서 다시 예외를 발생하게 되면 그러한 동작을 할 수 없게 됩니다.

더군다나, 이런 부분이 문제가 되지 않는 또 다른 이유는, 어차피 실 서비스에서는 DeveloperExceptionPageMiddleware를 사용하지 않기 때문에,

if (app.Environment.IsDevelopment())
{
    app.UseDeveloperExceptionPage();
}
else
{
    app.UseExceptionHandler("/Home/Error");
}

위에서처럼 UseExceptionHandler로 등록되는 ExceptionHandlerMiddleware는 우리가 만든 Middleware처럼 throw를 다시 하도록 동작합니다.

그래서 UseExceptionHandler인 경우, Middleware 순서에 상관없이 잘 동작합니다.

// 이렇게 해도,
app.UseExceptionHandler("/Home/Error");
app.UseMiddleware();

// 또는 이렇게 해도, ErrorLoggingMiddleware의 try/catch에 예외가 잡힙니다.
app.UseMiddleware();
app.UseExceptionHandler("/Home/Error");

(첨부 파일은 이 글의 예제 코드를 포함합니다.)




[이 글에 대해서 여러분들과 의견을 공유하고 싶습니다. 틀리거나 미흡한 부분 또는 의문 사항이 있으시면 언제든 댓글 남겨주십시오.]







[최초 등록일: ]
[최종 수정일: 9/29/2022]

Creative Commons License
이 저작물은 크리에이티브 커먼즈 코리아 저작자표시-비영리-변경금지 2.0 대한민국 라이센스에 따라 이용하실 수 있습니다.
by SeongTae Jeong, mailto:techsharer at outlook.com

비밀번호

댓글 작성자
 




... 121  122  123  124  125  126  127  128  129  [130]  131  132  133  134  135  ...
NoWriterDateCnt.TitleFile(s)
1840정성태1/8/201528920오류 유형: 267. Visual Studio - CodeLens 사용 시 CPU 100% 현상
1839정성태1/5/201521559디버깅 기술: 69. windbg 분석 사례 - cpu 100% 현상 (2)
1838정성태1/4/201541517기타: 49. 윈도우 내레이터(Narrator) 기능 끄는 방법(윈도우에 파란색의 굵은 테두리 선이 나타난다면?) [4]
1837정성태1/4/201527695디버깅 기술: 68. windbg 분석 사례 - 메모리 부족 [1]
1836정성태1/4/201527702디버깅 기술: 67. windbg - 덤프 파일과 handle 정보
1835정성태1/3/201528280개발 환경 구성: 254. SQL 서버 역시 SSL 3.0/TLS 1.0만을 지원하는 듯!
1834정성태1/3/201552909개발 환경 구성: 253. TLS 1.2를 적용한 IIS 웹 사이트 구성
1833정성태1/3/201529094.NET Framework: 490. System.Data.SqlClient는 SSL 3.0/TLS 1.0만 지원하는 듯! [3]
1832정성태1/2/201521700오류 유형: 266. Azure에 응용 프로그램 게시 중 로그인 오류
1831정성태1/1/201529824디버깅 기술: 66. windbg 분석 사례 - cpu 100% 현상 (1) [1]
1830정성태1/1/201529000오류 유형: 265. svchost.exe 프로세스(IP Helper: IPHLPSVC)의 CPU 100% 현상
1829정성태12/16/201432843VC++: 86. Windows Vista부터 바뀐 Credential Provider 예제 분석 (2) [2]파일 다운로드1
1828정성태12/15/201429295VC++: 85. Windows Vista부터 바뀐 Credential Provider 예제 분석 (1) [4]파일 다운로드1
1827정성태12/12/201425674VC++: 84. CredUIPromptForWindowsCredentials Win32 API 사용법 정리
1826정성태12/11/201429998.NET Framework: 489. Socket.Listen에 전달된 backlog 인자의 의미 [6]
1825정성태12/11/201477450.NET Framework: 488. TCP 소켓 연결의 해제를 알 수 있는 방법 [10]파일 다운로드1
1824정성태12/10/201427196.NET Framework: 487. Socket.Receive 메서드의 SocketFlags.Peek 동작을 이용해 소켓 연결 유무를 확인? [8]파일 다운로드1
1823정성태12/10/201424277.NET Framework: 486. Java의 ScheduledExecutorService에 대응하는 C#의 System.Threading.Timer [2]
1822정성태12/3/201426448개발 환경 구성: 252. Xamarin 라이선스 관리 [8]
1821정성태12/1/201433255VS.NET IDE: 96. Visual Studio에서 /* ~ */ 주석을 위한 단축키(매크로)
1820정성태11/23/201421532.NET Framework: 485. Mono Profiler에서 IL 코드 변경이 가능할까? - 두 번째 이야기파일 다운로드1
1819정성태11/22/201421345오류 유형: 264. MSBuild 에러 - warning MSB3052: The parameter to the compiler is invalid,
1818정성태11/22/201424285개발 환경 구성: 251. NUMA 노드 수에 따른 IIS Worker Process(w3wp.exe) 설정 [1]
1817정성태11/22/201427386VS.NET IDE: 95. Macros for Visual Studio 2013 [1]
1816정성태11/20/201422061.NET Framework: 484. Mono Profiler에서 IL 코드 변경이 가능할까?
1815정성태11/18/201420038.NET Framework: 483. 코드로 살펴 보는 ETW의 활성화 시점 [2]
... 121  122  123  124  125  126  127  128  129  [130]  131  132  133  134  135  ...