Microsoft MVP성태의 닷넷 이야기
글쓴 사람
정성태 (techsharer at outlook.com)
홈페이지
첨부 파일
(연관된 글이 1개 있습니다.)
(시리즈 글이 6개 있습니다.)
.NET Framework: 174. 작업자 프로세스(w3wp.exe)가 재시작되는 시점을 알 수 있는 방법
; https://www.sysnet.pe.kr/2/0/841

.NET Framework: 447. w3wp.exe AppPool 재생(recycle)하는 방법 정리
; https://www.sysnet.pe.kr/2/0/1704

개발 환경 구성: 246. IIS 작업자 프로세스의 20분 자동 재생(Recycle)을 끄는 방법
; https://www.sysnet.pe.kr/2/0/1774

.NET Framework: 643. 작업자 프로세스(w3wp.exe)가 재시작되는 시점을 알 수 있는 방법 - 두 번째 이야기
; https://www.sysnet.pe.kr/2/0/11145

개발 환경 구성: 702. IIS - AppPool의 "Disable Overlapped Recycle" 옵션
; https://www.sysnet.pe.kr/2/0/13514

닷넷: 2196. IIS - AppPool의 "Disable Overlapped Recycle" 옵션의 부작용
; https://www.sysnet.pe.kr/2/0/13516




작업자 프로세스(w3wp.exe)가 재시작되는 시점을 알 수 있는 방법 - 두 번째 이야기

예전 글에 이어,

작업자 프로세스(w3wp.exe)가 재시작되는 시점을 알 수 있는 방법
; https://www.sysnet.pe.kr/2/0/841

아래의 글은 Global.asax의 Application_End 이벤트 핸들러에서 Recycle의 원인을 알아내는 방법을 설명합니다.

Logging ASP.NET Application Shutdown Events
; https://weblogs.asp.net/scottgu/433194

정리하면, Application_End가 호출되는 시점에 HttpRuntime 객체에 저장된 _shutDownMessage와 _shutDownStack 필드의 값을 .NET Reflection을 이용해 읽어내는 것입니다.

protected void Application_End(object sender, EventArgs e)
{
    HttpRuntime runtime = (HttpRuntime)typeof(System.Web.HttpRuntime).InvokeMember("_theRuntime",
        BindingFlags.NonPublic | BindingFlags.Static | BindingFlags.GetField, null, null, null);

    if (runtime == null)
        return;

    string shutDownMessage = (string)runtime.GetType().InvokeMember("_shutDownMessage",
        BindingFlags.NonPublic | BindingFlags.Instance | BindingFlags.GetField, null, runtime, null);

    string shutDownStack = (string)runtime.GetType().InvokeMember("_shutDownStack",
        BindingFlags.NonPublic | BindingFlags.Instance | BindingFlags.GetField, null, runtime, null);

    System.Diagnostics.Trace.WriteLine(String.Format("\r\n\r\n_shutDownMessage={0}\r\n\r\n_shutDownStack={1}",
        shutDownMessage, shutDownStack));
}

위의 예제는 ASP.NET 2.0을 대상으로 하지만, .NET 4.6.1에서도 여전히 잘 동작합니다. 가령, web.config을 변경한 경우 .NET 2.0 기반에서는 다음과 같이 출력 값이 나오고,

_shutDownMessage=CONFIG change
HostingEnvironment initiated shutdown
CONFIG change
CONFIG change
HostingEnvironment caused shutdown

_shutDownStack=   at System.Environment.get_StackTrace()
   at System.Web.Hosting.HostingEnvironment.InitiateShutdownInternal()
   at System.Web.Hosting.HostingEnvironment.InitiateShutdown()
   at System.Web.HttpRuntime.ShutdownAppDomain(String stackTrace)
   at System.Web.Configuration.HttpConfigurationSystem.OnConfigurationChanged(Object sender, InternalConfigEventArgs e)
   at System.Configuration.BaseConfigurationRecord.OnStreamChanged(String streamname)

.NET 4.6.1에서는 이렇게 나옵니다.

_shutDownMessage=IIS configuration change
CONFIG change
HostingEnvironment initiated shutdown
CONFIG change
CONFIG change
HostingEnvironment caused shutdown

_shutDownStack=   at System.Environment.GetStackTrace(Exception e, Boolean needFileInfo)
   at System.Environment.get_StackTrace()
   at System.Web.Hosting.HostingEnvironment.InitiateShutdownInternal()
   at System.Web.Hosting.HostingEnvironment.InitiateShutdownWithoutDemand()
   at System.Web.Hosting.PipelineRuntime.StopProcessing()

그런데, Application_End는 Global.asax 이외의 클래스에서는 구독하는 것이 안됩니다. 왜냐하면, End 이벤트가 HttpApplication 객체에는 없기 때문입니다. 따라서 외부 DLL에서 참조하고 싶다면 다음과 같이 HttpContext를 이용해 Disposed 이벤트를 구독해야 합니다.

HttpContext.Current.ApplicationInstance.Disposed += ApplicationInstance_Disposed;

Application_End와 Disposed가 이벤트가 발생하는 시점을 잡아 각각의 Call stack을 확인하면 그 이유를 알 수 있습니다.

// Application_End 호출 시점의 Call stack

>    Test.dll!WebSiteTest.Global.Application_End(object sender, System.EventArgs e) Line 430 C#
    [Native to Managed Transition]  
    System.Web.dll!System.Web.HttpApplication.InvokeMethodWithAssert(System.Reflection.MethodInfo method, int paramCount, object eventSource, System.EventArgs eventArgs) + 0x7a bytes  
    System.Web.dll!System.Web.HttpApplication.ProcessSpecialRequest(System.Web.HttpContext context, System.Reflection.MethodInfo method, int paramCount, object eventSource, System.EventArgs eventArgs, System.Web.SessionState.HttpSessionState session) + 0x126 bytes    
    System.Web.dll!System.Web.HttpApplicationFactory.FireApplicationOnEnd() + 0x6b bytes    
    System.Web.dll!System.Web.HttpApplicationFactory.Dispose() + 0x80 bytes 
    System.Web.dll!System.Web.HttpRuntime.Dispose() + 0x158 bytes   
    System.Web.dll!System.Web.HttpRuntime.ReleaseResourcesAndUnloadAppDomain(object state) + 0x3d bytes 
    mscorlib.dll!System.Threading.ExecutionContext.RunInternal(System.Threading.ExecutionContext executionContext, System.Threading.ContextCallback callback, object state, bool preserveSyncCtx) + 0x15e bytes 
    mscorlib.dll!System.Threading.ExecutionContext.Run(System.Threading.ExecutionContext executionContext, System.Threading.ContextCallback callback, object state, bool preserveSyncCtx) + 0x17 bytes  
    mscorlib.dll!System.Threading.QueueUserWorkItemCallback.System.Threading.IThreadPoolWorkItem.ExecuteWorkItem() + 0x70 bytes 
    mscorlib.dll!System.Threading.ThreadPoolWorkQueue.Dispatch() + 0x160 bytes  
    [Native to Managed Transition]  
    [Appdomain Transition]  
    [Native to Managed Transition]  

// Global_Disposed 호출 시점의 Call stack

>    Test.dll!WebSiteTest.Global.Global_Disposed(object sender, System.EventArgs e) Line 425 C#
    System.Web.dll!System.Web.HttpApplication.Dispose() + 0x9f bytes    
    System.Web.dll!System.Web.HttpApplication.DisposeInternal() + 0x30 bytes    
    System.Web.dll!System.Web.HttpApplicationFactory.DisposeHttpApplicationInstances(System.Collections.Stack freeList, ref int numFreeInstances) + 0xf6 bytes  
    System.Web.dll!System.Web.HttpApplicationFactory.Dispose() + 0xd2 bytes 
    System.Web.dll!System.Web.HttpRuntime.Dispose() + 0x158 bytes   
    System.Web.dll!System.Web.HttpRuntime.ReleaseResourcesAndUnloadAppDomain(object state) + 0x3d bytes 
    mscorlib.dll!System.Threading.ExecutionContext.RunInternal(System.Threading.ExecutionContext executionContext, System.Threading.ContextCallback callback, object state, bool preserveSyncCtx) + 0x15e bytes 
    mscorlib.dll!System.Threading.ExecutionContext.Run(System.Threading.ExecutionContext executionContext, System.Threading.ContextCallback callback, object state, bool preserveSyncCtx) + 0x17 bytes  
    mscorlib.dll!System.Threading.QueueUserWorkItemCallback.System.Threading.IThreadPoolWorkItem.ExecuteWorkItem() + 0x70 bytes 
    mscorlib.dll!System.Threading.ThreadPoolWorkQueue.Dispatch() + 0x160 bytes  
    [Native to Managed Transition]  
    [Appdomain Transition]  
    [Native to Managed Transition]  

어차피 HttpRuntime.Dispose 메서드를 시작으로 Application_End가 호출된 후 Disposed 이벤트가 발생하기 때문에 HttpRuntime의 _shutDownMessage와 _shutDownStack 필드 값은 동일합니다.

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




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

[연관 글]






[최초 등록일: ]
[최종 수정일: 2/16/2017]

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

비밀번호

댓글 작성자
 



2017-02-16 10시00분
[ryujh] 안녕하세요.

본문 중 CONFIG change 와 같이 재시작의 원인이 나외있는데 그 밖에도 Recompile 의 회수(횟수?)가 초과도 원인입니다.

Recompile 이라면 가상경로에서 파일 수정으로 적용하여 발생할 수 있습니다. 쓰기 작업을 가상경로에서 하지 않고 다른 경로에 할 수 있다면 재시작이 적어지니 안정적으로 서비스가 가능할 것입니다.
[guest]
2017-02-22 02시29분
.NET 소스 코드에 Recycle에 대한 이유 몇 가지가 나옵니다.

ApplicationShutdownReason Enum
; https://referencesource.microsoft.com/#system.web/HttpRuntime.cs,4d404925e0f99eb1,references
정성태
2017-02-24 08시04분
[ryujh] 안녕하세요.

이유가 무려 15가지나 되는군요. 15가지 이유 중에 하나로 어플리케이션이 shutdown 될 수 있다는 것인데 안정적인 웹서비스가 어려운지 이제 알겠습니다.

그래서 요즘에는 웹에서 하는 로직을 일부 콘솔프로그램에서 담당하도록 작업 중 입니다.
[guest]
2017-02-25 02시27분
ryujh님, shutdown 될 수 있기는 한데 그래서 더 '안정적인' 경우가 많습니다. ^^ 그리고 recycle 과정 자체가 서비스를 중단 없이 하기 때문에 in-memory Session 같은 것 등을 쓰지 않는 한 서비스 장애로 이어지는 경우는 없습니다.
정성태

... 61  62  63  64  65  66  67  68  69  70  71  [72]  73  74  75  ...
NoWriterDateCnt.TitleFile(s)
11832정성태3/4/201910703오류 유형: 524. Visual Studio CMake - rsync: connection unexpectedly closed
11831정성태3/4/201910272오류 유형: 523. Visual Studio 2019 - 새 창으로 뜬 윈도우를 닫을 때 비정상 종료
11830정성태2/26/201910108오류 유형: 522. 이벤트 로그 - Error opening event log file State. Log will not be processed. Return code from OpenEventLog is 87.
11829정성태2/26/201911968개발 환경 구성: 430. 마이크로소프트의 CoreCLR 프로파일러 예제 빌드 방법 - 리눅스 환경 [1]
11828정성태2/26/201918341개발 환경 구성: 429. Component Services 관리자의 RuntimeBroker 설정이 2개 있는 경우 [8]
11827정성태2/26/201912266오류 유형: 521. Visual Studio - Could not start the 'rsync' command on the remote host, please install it using your system package manager.
11826정성태2/26/201912176오류 유형: 520. 우분투에 .NET Core SDK 설치 시 패키지 의존성 오류
11825정성태2/25/201917024개발 환경 구성: 428. Visual Studio 2019 - CMake를 이용한 리눅스 빌드 환경 설정 [1]
11824정성태2/25/201911811오류 유형: 519. The SNMP Service encountered an error while accessing the registry key SYSTEM\CurrentControlSet\Services\SNMP\Parameters\TrapConfiguration. [1]
11823정성태2/21/201913253오류 유형: 518. IIS 관리 콘솔이 뜨지 않는 문제
11822정성태2/20/201911426오류 유형: 517. docker에 설치한 MongoDB 서버로 연결이 안 되는 경우
11821정성태2/20/201911904오류 유형: 516. Visual Studio 2019 - This extension uses deprecated APIs and is at risk of not functioning in a future VS update. [1]
11820정성태2/20/201915009오류 유형: 515. 윈도우 10 1809 업데이트 후 "User Profiles Service" 1534 경고 발생
11819정성태2/20/201913699Windows: 158. 컴퓨터와 사용자의 SID(security identifier) 확인 방법
11818정성태2/20/201912623VS.NET IDE: 131. Visual Studio 2019 Preview의 닷넷 프로젝트 빌드가 20초 이상 걸리는 경우 [2]
11817정성태2/17/20199823오류 유형: 514. WinDbg Preview 실행 오류 - Error : DbgX.dll : WindowsDebugger.WindowsDebuggerException: Could not load dbgeng.dll
11816정성태2/17/201912284Windows: 157. 윈도우 스토어 앱(Microsoft Store App)을 명령행에서 직접 실행하는 방법
11815정성태2/14/201911217오류 유형: 513. Visual Studio 2019 - VSIX 설치 시 "The extension cannot be installed to this product due to prerequisites that cannot be resolved." 오류 발생
11814정성태2/12/20199979오류 유형: 512. VM(가상 머신)의 NT 서비스들이 자동 시작되지 않는 문제
11813정성태2/12/201911585.NET Framework: 809. C# - ("Save File Dialog" 등의) 대화 창에 확장 속성을 보이는 방법
11812정성태2/11/20199487오류 유형: 511. Windows Server 2003 VM 부팅 후 로그인 시점에 0xC0000005 BSOD 발생
11811정성태2/11/201913175오류 유형: 510. 서버 운영체제에 NVIDIA GeForce Experience 실행 시 wlanapi.dll 누락 문제
11810정성태2/11/201911247.NET Framework: 808. .NET Profiler - GAC 모듈에서 GAC 비-등록 모듈을 참조하는 경우의 문제
11809정성태2/11/201912719.NET Framework: 807. ClrMD를 이용해 메모리 덤프 파일로부터 특정 인스턴스를 참조하고 있는 소유자 확인
11808정성태2/8/201913840디버깅 기술: 123. windbg - 닷넷 응용 프로그램의 메모리 누수 분석
11807정성태1/29/201912195Windows: 156. 가상 디스크의 용량을 복구 파티션으로 인해 늘리지 못하는 경우 [4]
... 61  62  63  64  65  66  67  68  69  70  71  [72]  73  74  75  ...