Microsoft MVP성태의 닷넷 이야기
.NET Framework: 742. windbg로 확인하는 Finalizer를 가진 객체의 GC 과정 [링크 복사], [링크+제목 복사],
조회: 14912
글쓴 사람
정성태 (techsharer at outlook.com)
홈페이지
첨부 파일
[gc_dtor.zip]    
(연관된 글이 2개 있습니다.)

windbg로 확인하는 Finalizer를 가진 객체의 GC 과정

객체가 GC되었는지 확인하는 방법을 알아봤는데요.

windbg로 확인하는 객체의 GC 여부
; https://www.sysnet.pe.kr/2/0/11509

그럼, Finalizer를 가진 객체로도 테스트를 해보겠습니다. 이를 위해 지난 예제의 Program 클래스에 Finalizer를 추가한 후,

using System;

namespace ConsoleApp2
{
    class Program
    {
        static void Main(string[] args)
        {
            Instance();

            Console.ReadLine();    // .NET 4 + x64 + Release 모드로 실행 후,
                                   // 이 시점에 Dump를 뜨고,

            GC.Collect(2, GCCollectionMode.Forced);     // 엔터를 치면 GC가 수행되고,
                                                        // 이 시점에 다시 Dump를 뜸
            Console.ReadLine();
        }

        private static void Instance()
        {
            Program pg = new Program();
        }

        ~Program()
        {
            Console.WriteLine("GCed");
        }
    }
}

GC.Collect 수행 전/후에 따라 덤프를 뜹니다. 우선 GC.Collect를 수행하기 전의 덤프를 분석하면 지난 글에서 설명한 데로 Program 객체는 0 세대 힙에 놓인 것을 확인할 수 있습니다.

0:000> .loadby sos clr

0:000> !dumpheap -type ConsoleApp2.Program
         Address               MT     Size
0000018414812df0 00007ff8a7185a28       24     

Statistics:
              MT    Count    TotalSize Class Name
00007ff8a7185a28        1           24 ConsoleApp2.Program
Total 1 objects

0:000> !eeheap -gc
Number of GC Heaps: 1
generation 0 starts at 0x0000018414811030
generation 1 starts at 0x0000018414811018
generation 2 starts at 0x0000018414811000
ephemeral segment allocation context: none
         segment             begin         allocated              size
0000018414810000  0000018414811000  0000018414817fe8  0x6fe8(28648)
Large object heap starts at 0x0000018424811000
         segment             begin         allocated              size
0000018424810000  0000018424811000  00000184248199e8  0x89e8(35304)
Total Size:              Size: 0xf9d0 (63952) bytes.
------------------------------
GC Heap Size:            Size: 0xf9d0 (63952) bytes.

이 상태에서 finalizequeue 명령을 실행하면 다음과 같은 결과를 얻을 수 있습니다.

0:000> !finalizequeue
SyncBlocks to be cleaned up: 0
Free-Threaded Interfaces to be released: 0
MTA Interfaces to be released: 0
STA Interfaces to be released: 0
----------------------------------
generation 0 has 9 finalizable objects (0000018412b5a610->0000018412b5a658)
generation 1 has 0 finalizable objects (0000018412b5a610->0000018412b5a610)
generation 2 has 0 finalizable objects (0000018412b5a610->0000018412b5a610)
Ready for finalization 0 objects (0000018412b5a658->0000018412b5a658)
Statistics for all finalizable objects (including all objects ready for finalization):
              MT    Count    TotalSize Class Name
00007ff902a13f60        1           24 System.WeakReference
00007ff8a7185a28        1           24 ConsoleApp2.Program
00007ff902a31a38        1           32 Microsoft.Win32.SafeHandles.SafeFileMappingHandle
00007ff902a319a8        1           32 Microsoft.Win32.SafeHandles.SafeViewOfFileHandle
00007ff9029fc3e0        1           32 Microsoft.Win32.SafeHandles.SafePEFileHandle
00007ff9029fd680        1           64 System.Threading.ReaderWriterLock
00007ff9029fa3f0        2           64 Microsoft.Win32.SafeHandles.SafeFileHandle
00007ff9029f7f28        1           96 System.Threading.Thread
Total 9 objects

이 출력 결과에서 아래의 세 라인이 바로 소멸자 큐(Finalization queue)의 내용이고,

generation 0 has 9 finalizable objects (0000018412b5a610->0000018412b5a658)
generation 1 has 0 finalizable objects (0000018412b5a610->0000018412b5a610)
generation 2 has 0 finalizable objects (0000018412b5a610->0000018412b5a610)

그다음 라인의 내용이 FReachable Queue입니다.

Ready for finalization 0 objects (0000018412b5a658->0000018412b5a658)

즉, 현재 소멸자를 가진 클래스의 인스턴스가 9개 생성된 상태이고 해당 객체들은 모두 0 세대 힙에 있습니다.

참고로, dumpheap으로 구한 객체의 주소로 gcroot 명령어를 이용하면 Finalization queue에도 root 참조가 있는지 곧바로 확인할 수 있습니다.

0:000> !gcroot 0000018414812df0
Finalizer Queue:
    0000018414812df0
    -> 0000018414812df0 ConsoleApp2.Program




그다음 GC.Collect를 수행한 후의 덤프를 분석하면, 이번에는 Program 객체가 GC되지 않고 1 세대 힙에 놓인 것을 볼 수 있습니다.

0:000> !dumpheap -type ConsoleApp2.Program
         Address               MT     Size
0000018414812df0 00007ff8a7185a28       24     

Statistics:
              MT    Count    TotalSize Class Name
00007ff8a7185a28        1           24 ConsoleApp2.Program
Total 1 objects

0:000> !eeheap -gc
Number of GC Heaps: 1
generation 0 starts at 0x0000018414816c88
generation 1 starts at 0x0000018414811018
generation 2 starts at 0x0000018414811000
ephemeral segment allocation context: none
         segment             begin         allocated              size
0000018414810000  0000018414811000  0000018414818ca0  0x7ca0(31904)
Large object heap starts at 0x0000018424811000
         segment             begin         allocated              size
0000018424810000  0000018424811000  00000184248199e8  0x89e8(35304)
Total Size:              Size: 0x10688 (67208) bytes.
------------------------------
GC Heap Size:            Size: 0x10688 (67208) bytes.

즉, Finalizer를 구현한 객체는 소멸자 큐에 등록된 것으로 인해 여전히 root 참조가 살아 있으므로 GC.Collect 이후 곧바로 GC되지 않고 1 세대 힙으로 승격하게 됩니다. (물론 일반적인 객체였다면 이 과정에서 root 참조가 없기 때문에 정리가 됩니다.)

또한 1 세대 힙으로 승격함과 동시에 소멸자 큐의 root 참조가 없어지고 FReachable Queue로 이동하게 됩니다. 그래서 첫 번째 GC.Collect 이후에는 다음과 같이 소멸자 큐의 등록이 없어진 것을 확인할 수 있습니다.

0:000> !gcroot 0000018414812df0
Found 0 unique roots (run '!GCRoot -all' to see all roots).




소멸자의 동작과 관련해 "소멸자 큐(finalization queue)"와 "FReachable Queue"가 있습니다. 제 책에서도 설명했지만, GC.Collect 시에 소멸자 큐에서 나온 객체는 FReachable Queue로 이동하고 이 시점에 대기하고 있던 소멸자 스레드가 FReachable Queue에 있는 항목을 곧바로 꺼내 소멸자 메서드를 호출합니다.

그래서 FReachable Queue에 객체가 있는 경우를 확인하기가 (일반적인 응용 프로그램의 경우) 쉽지 않습니다.

물론 억지로 ^^ 재현하면 쉽게 확인할 수 있습니다. 가령, 다음과 같이 소멸자를 갖는 객체를 하나 더 추가하는 것입니다.

using System;
using System.Threading;

namespace ConsoleApp2
{
    class Program
    {
        static void Main(string[] args)
        {
            Instance();
            Console.ReadLine();

            GC.Collect(2, GCCollectionMode.Forced);
            Console.ReadLine();
        }

        private static void Instance()
        {
            Program pg = new Program();
            LongDtor ld = new LongDtor();
        }

        ~Program()
        {
            Thread.Sleep(1000 * 60);
            Console.WriteLine("Program.GCed");
        }
    }

    class LongDtor
    {
        ~LongDtor()
        {
            Thread.Sleep(1000 * 60);
            Console.WriteLine("LongDtor.GCed");
        }
    }
}

위와 같이 하면, GC.Collect 이후 2개의 객체(pg, ld)가 소멸자 큐에서 FReachable 큐로 이동할 것입니다. 이동하자마자 소멸자 스레드에 의해 꺼내져 dtor를 실행하게 될 텐데, 어느 쪽의 객체를 먼저 꺼내든 60초의 시간 동안 그다음 객체를 꺼낼 수 없으므로 적어도 1개의 객체가 FReachable 큐에 (60초 동안은) 머물게 됩니다.

따라서 첫 번째 GC.Collect 호출 후 덤프를 떠서 finalizequeue 명령으로 확인하면,

0:000> !finalizequeue
SyncBlocks to be cleaned up: 0
Free-Threaded Interfaces to be released: 0
MTA Interfaces to be released: 0
STA Interfaces to be released: 0
----------------------------------
generation 0 has 0 finalizable objects (000001f15f1bc4d0->000001f15f1bc4d0)
generation 1 has 8 finalizable objects (000001f15f1bc490->000001f15f1bc4d0)
generation 2 has 0 finalizable objects (000001f15f1bc490->000001f15f1bc490)
Ready for finalization 1 objects (000001f15f1bc4d0->000001f15f1bc4d8)
Statistics for all finalizable objects (including all objects ready for finalization):
              MT    Count    TotalSize Class Name
00007ff902a13f60        1           24 System.WeakReference
00007ff8a7175a30        1           24 ConsoleApp2.Program
00007ff902a31a38        1           32 Microsoft.Win32.SafeHandles.SafeFileMappingHandle
00007ff902a319a8        1           32 Microsoft.Win32.SafeHandles.SafeViewOfFileHandle
00007ff9029fc3e0        1           32 Microsoft.Win32.SafeHandles.SafePEFileHandle
00007ff9029fd680        1           64 System.Threading.ReaderWriterLock
00007ff9029fa3f0        2           64 Microsoft.Win32.SafeHandles.SafeFileHandle
00007ff9029f7f28        1           96 System.Threading.Thread
Total 9 objects

GC.Collect로 인해 0 세대 힙에 있던 소멸자를 가진 10개의 객체 중 8개가 소멸자 큐(Finalization queue)에 머물러 있고,

generation 0 has 0 finalizable objects (000001f15f1bc4d0->000001f15f1bc4d0)
generation 1 has 8 finalizable objects (000001f15f1bc490->000001f15f1bc4d0)
generation 2 has 0 finalizable objects (000001f15f1bc490->000001f15f1bc490)

2개의 객체는 Finalization queue에서 꺼내져 Freachable Queue에 들어갔습니다.

Ready for finalization 1 objects (000001f15f1bc4d0->000001f15f1bc4d8) 

만약 소멸자 스레드에 의해 꺼내지지 않았다면 위의 출력 결과는 "2 objects"로 나오겠지만, 거의 곧바로 실행되기 때문에 Freachable Queue에 들어간 2개의 객체 중 한 개는 꺼내져서 소멸자 스레드에 의해 dtor가 호출 중이며 나머지 한 개는 아직 Freachable Queue에 머물러 있는 것입니다.

실제로 Freachable Queue에서 남아 있는 1개의 객체를 다음과 같이 덤프할 수 있습니다.

0:000> dq 000001f15f1bc4d0 L1
000001f1`5f1bc4d0  00000184`14812df0

0:000> !do 00000184`14812df0
Name:        ConsoleApp2.Program
MethodTable: 00007ff8a7185a28
EEClass:     00007ff8a71824f8
Size:        24(0x18) bytes
File:        E:\ConsoleApp2\bin\Release\ConsoleApp2.exe
Fields:
None

따라서 현재 소멸자 스레드에 의해 꺼내져 실행되고 있는 객체는 ConsoleApp2.LongDtor 클래스의 인스턴스임을 예상할 수 있습니다.




이번 테스트를 통해 제가 그동안 잘못 알고 있던 것을 바로잡을 수 있게 되었습니다. 예전에는 다음과 같은 절차로 소멸자를 가진 객체가 없어진다고 알고 있었는데,

1. dtor를 가진 객체 생성
    1.1 GC Heap 0 세대에 객체가 등록됨
[객체가 scope을 벗어남]
2. 첫 번째 GC 수행 시 root 참조들이 없지만 dtor를 가지므로 GC heap에서 Finalization queue로 이동
3. 두 번째 GC 수행 시 Finalization queue에서 Freachable Queue로 이동하고, 그 순간 소멸자 스레드에 의해 실행

실제로 테스트해본 결과 다음과 같이 진행되고 있었습니다.

1. dtor를 가진 객체 생성
    1.1 GC Heap 0 세대에 객체가 등록됨
    1.2 소멸자 큐(Finalization queue)에도 객체가 등록됨
[객체가 scope을 벗어남]
2. 첫 번째 GC 수행 시
    2.1 소멸자 큐에 root 참조가 있으므로 1 세대로 승격
    2.2 소멸자 큐의 root 참조를 비우고 Freachable Queue로 이동
    2.3 Freachable Queue로 이동하자마자 소멸자 스레드가 꺼내 실행
[따라서 이 시점에는 GC Heap 1 세대에만 참조가 있음]
3. 두 번째 GC 수행 시 GC Heap 1 세대의 객체가 정리됨

음... 책 내용을 수정해야겠군요. ^^




그렇다면 WeakReference는 Finalizer를 가진 객체에 대해 언제 IsAlive 값이 False가 될까요? 얼핏 생각해 보면, 첫 번째 GC 수행 후에도 여전히 GC Heap 1 세대에 살아있으므로 그 시점까지는 IsAlive 값이 True로 유지될 듯싶었는데요. 테스트 결과 GC Heap 1 세대에 있음에도 불구하고 무조건 IsAlive = False로 되는 것을 확인할 수 있습니다.

이러한 시점 상의 문제로 WeakReference는 해당 객체가 실제로 GC되지 않아도 참조를 잃어버리게 됩니다. 예를 들어 (권장되지 않지만) 소멸자에서 해당 객체를 다시 부활(resurrection) 시키는 경우도 있을 텐데, WeakReference는 이런 상황을 고려하지 않습니다.

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




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

[연관 글]






[최초 등록일: ]
[최종 수정일: 4/30/2018]

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

비밀번호

댓글 작성자
 




... 46  47  48  49  50  51  52  [53]  54  55  56  57  58  59  60  ...
NoWriterDateCnt.TitleFile(s)
12308정성태9/2/202011335개발 환경 구성: 506. Windows - 단일 머신에서 단일 바이너리로 여러 개의 ElasticSearch 노드를 실행하는 방법
12307정성태9/2/202012113오류 유형: 643. curl - json_parse_exception / Invalid UTF-8 start byte
12306정성태9/1/202010298오류 유형: 642. SQL Server 시작 오류 - error code 10013
12305정성태9/1/202011154Windows: 172. "Administered port exclusions"이 아닌 포트 범위 항목을 삭제하는 방법
12304정성태8/31/202010123개발 환경 구성: 505. 윈도우 - (네트워크 어댑터의 우선순위로 인한) 열거되는 IP 주소 순서를 조정하는 방법
12303정성태8/30/202010291개발 환경 구성: 504. ETW - 닷넷 프레임워크 기반의 응용 프로그램을 위한 명령행 도구 etrace 소개
12302정성태8/30/202010213.NET Framework: 936. C# - ETW 관련 Win32 API 사용 예제 코드 (5) - Private Logger파일 다운로드1
12301정성태8/30/202010496오류 유형: 641. error MSB4044: The "Fody.WeavingTask" task was not given a value for the required parameter "IntermediateDir".
12300정성태8/29/20209919.NET Framework: 935. C# - ETW 관련 Win32 API 사용 예제 코드 (4) CLR ETW Consumer파일 다운로드1
12299정성태8/27/202010841.NET Framework: 934. C# - ETW 관련 Win32 API 사용 예제 코드 (3) ETW Consumer 구현파일 다운로드1
12298정성태8/27/202010579오류 유형: 640. livekd - Could not resolve symbols for ntoskrnl.exe: MmPfnDatabase
12297정성태8/25/20209779개발 환경 구성: 503. SHA256 테스트 인증서 생성 방법
12296정성태8/24/202010202.NET Framework: 933. C# - ETW 관련 Win32 API 사용 예제 코드 (2) NT Kernel Logger파일 다운로드1
12295정성태8/24/20209638오류 유형: 639. Bitvise - Address is already in use; bind() in ListeningSocket::StartListening() failed: Windows error 10013: An attempt was made to access a socket ,,,
12293정성태8/24/202010964Windows: 171. "Administered port exclusions" 설명
12292정성태8/20/202012229.NET Framework: 932. C# - ETW 관련 Win32 API 사용 예제 코드 (1)파일 다운로드2
12291정성태8/15/202011144오류 유형: 638. error 1297: Device driver does not install on any devices, use primitive driver if this is intended.
12290정성태8/11/202011838.NET Framework: 931. C# - IP 주소에 따른 국가별 위치 확인 [8]파일 다운로드1
12289정성태8/6/20209373개발 환경 구성: 502. Portainer에 윈도우 컨테이너를 등록하는 방법
12288정성태8/5/20209372오류 유형: 637. WCF - The protocol 'net.tcp' does not have an implementation of HostedTransportConfiguration type registered.
12287정성태8/5/20209834오류 유형: 636. C# - libdl.so를 DllImport로 연결 시 docker container 내에서 System.DllNotFoundException 예외 발생
12286정성태8/5/202010695개발 환경 구성: 501. .NET Core 용 container 이미지 만들 때 unzip이 필요한 경우
12285정성태8/4/202011095오류 유형: 635. 윈도우 10 업데이트 - 0xc1900209 [2]
12284정성태8/4/202010378디버깅 기술: 169. Hyper-V의 VM에 대한 메모리 덤프를 뜨는 방법
12283정성태8/3/202010877디버깅 기술: 168. windbg - 필터 드라이버 확인하는 확장 명령어(!fltkd) [2]
12282정성태8/2/20209630디버깅 기술: 167. windbg 디버깅 사례: AppDomain 간의 static 변수 사용으로 인한 crash (2)
... 46  47  48  49  50  51  52  [53]  54  55  56  57  58  59  60  ...