Microsoft MVP성태의 닷넷 이야기
.NET Framework: 225. 닷넷 네트워크 라이브러리의 트레이스 기능 [링크 복사], [링크+제목 복사],
조회: 26900
글쓴 사람
정성태 (techsharer at outlook.com)
홈페이지
첨부 파일
(연관된 글이 1개 있습니다.)

닷넷 네트워크 라이브러리의 트레이스 기능

아마도, .NET Reflector 등의 도구를 가지고 닷넷 소스 코드를 보신 분들이라면 네트워크 관련 코드 내부에 Logging 클래스가 있는 것을 기억할 것입니다. 일례로, 소켓의 경우에 Connect 메서드를 보면 다음과 같은 식으로 코드가 엮어져 있는데요.

public void Connect(IPAddress address, int port)
{
    if (s_LoggingEnabled)
    {
        Logging.Enter(Logging.Sockets, this, "Connect", address);
    }
    ...[생략]...
    this.Connect(remoteEP);
    if (s_LoggingEnabled)
    {
        Logging.Exit(Logging.Sockets, this, "Connect", (string) null);
    }
}

보시는 것처럼, Connect 기능의 앞뒤로 Logging.Enter/Exit 메서드가 호출됩니다. 좀 더 살펴보기 위해 Logging 클래스의 초기화 코드를 보면 더욱 흥미로운 것을 발견할 수 있는데요.

private static void InitializeLogging()
{
    lock (InternalSyncObject)
    {
        if (!s_LoggingInitialized)
        {
            bool flag = false;
            s_WebTraceSource = new NclTraceSource("System.Net");
            s_HttpListenerTraceSource = new NclTraceSource("System.Net.HttpListener");
            s_SocketsTraceSource = new NclTraceSource("System.Net.Sockets");
            s_CacheTraceSource = new NclTraceSource("System.Net.Cache");
            ...[생략]...
        }
    }
}

즉, 대부분의 통신 관련 코드에 대한 트레이스 기능이 활성화되어 있음을 알 수 있습니다. 그럼, BCL을 사용하는 개발자 입장에서 어떻게 Trace기능을 이용할 수 있을까요? 이에 관해서는 다음의 글에서 설명됩니다.

How to: Configure network tracing
; https://docs.microsoft.com/en-us/dotnet/framework/network-programming/how-to-configure-network-tracing

오호~~~ 그렇군요. 닷넷의 전형적인 TraceListener 기능이기 때문에 누구나 등록해서 네트워크 호출에 대한 모니터링이 가능하다는 이야기가 됩니다.

실습 삼아서, 간단한 확장을 해볼까요?

예를 들어서... 우리가 잘 알고 있는 HttpWebRequest 타입으로 시작해보겠습니다.

HttpWebRequest hwr = WebRequest.Create("http://blog.naver.com/techshare") as HttpWebRequest;
HttpWebResponse response = hwr.GetResponse() as HttpWebResponse;
response.Close();

잘 아시는 것처럼, HttpWebRequest 타입은 Connect라는 메서드가 명시적으로 제공되지 않습니다. 따라서 위와 같이 사용하는 경우, 실제 대상이 되는 웹 서버로의 'TCP 연결에 소요된 시간'을 계산하는 것이 불가능합니다. 꼭! 반드시! 'TCP 연결에 소요된 시간'을 알아내야 한다면, 기존의 지식으로는 이런 경우 어쩔 수 없이 HttpWebRequest에 대한 사용을 포기하고 TcpClient로 내려가서 HTTP 요청/응답에 대한 처리를 모두 구현해야 하는 불편함이 따르게 됩니다.

하지만 이제는 ^^ Logging이 내장되었다는 것을 알았으니, 사용자 정의 TraceListener로 간접적으로 알아낼 수 있습니다. 가령, 다음과 같이 별도의 TraceListener를 정의하고,

public class SocketTraceListener : TraceListener
{
    public override void Write(string message)
    {
    }

    public override void WriteLine(string message)
    {
    }

    public override void TraceEvent(TraceEventCache eventCache, string source, TraceEventType eventType, int id)
    {
        base.TraceEvent(eventCache, source, eventType, id);
    }

    public override void TraceEvent(TraceEventCache eventCache, string source, TraceEventType eventType, int id, string message)
    {
        base.TraceEvent(eventCache, source, eventType, id, message);
    }

    public override void TraceEvent(TraceEventCache eventCache, string source, TraceEventType eventType, int id, string format, params object[] args)
    {
        base.TraceEvent(eventCache, source, eventType, id, format, args);
    }
}

app.config에는 다음과 같이 설정을 추가해 주면 이제부터 System.Net.Sockets 영역의 네트워크 메서드에 대한 호출을 가로챌 수 있습니다.

<system.diagnostics>
    <trace autoflush="true" />
    <sources>
        <source name="System.Net.Sockets">
            <listeners>
                <add name="MyTrace"/>
            </listeners>
        </source>
    </sources>
    <sharedListeners>
        <add name="MyTrace" type="ConsoleApplication1.SocketTraceListener, ConsoleApplication1" />
    </sharedListeners>
    <switches>
        <add name="System.Net.Sockets" value="Verbose" />
    </switches>
</system.diagnostics>

Connect가 호출될 때의 메서드 수행을 감시해 보면 TraceEvent의 message 인자로 다음과 같이 넘어오는 것을 확인할 수 있습니다.

Logging.Enter - "[9940] Socket#49385318::Connect(23:80#397718426)"
Logging.Exit - "[9940] Exiting Socket#49385318::Connect() "

자, 그럼 실제적인 이야기는 끝난 것 같군요. 이제 위의 메시지를 인식하는 코드를 TraceEvent 메서드에 넣어두고 Connect 메서드가 수행된 시간만을 반환해주는 "ConnectionTime"이라는 속성을 제공해 주면 '연결에 걸린 시간'을 구해올 수 있습니다.

==== SocketTraceListener.cs ====
public override void TraceEvent(TraceEventCache eventCache, string source, TraceEventType eventType, int id, string message)
{
    ...[생략]...
    switch (source)
    {
        case "System.Net.Sockets":
            if (message.IndexOf("::Connect") != -1)
            {
                if (message.IndexOf("Exiting Socket") != -1)
                {
                    connectionTime = new TimeSpan(DateTime.Now.Ticks - startConnect);
                }
                else
                {
                    startConnect = DateTime.Now.Ticks;
                }
            }
                    
            break;
    }
    base.TraceEvent(eventCache, source, eventType, id, message);
}

==== Program.cs ====
static void Main(string[] args)
{
    SocketTraceListener.TraceThread = Thread.CurrentThread.ManagedThreadId;

    HttpWebRequest hwr = WebRequest.Create("http://blog.naver.com/techshare") as HttpWebRequest;
    HttpWebResponse response = hwr.GetResponse() as HttpWebResponse;
    response.Close();

    Console.WriteLine("blog.naver.com - ConnectionTime: " + SocketTraceListener.ConnectionTime.ToString());
}

==== 실행 결과 ====
D:\...[생략]...\ConsoleApplication1\bin\Debug>ConsoleApplication1.exe
blog.naver.com - ConnectionTime: 00:00:00.0140008

첨부된 파일은 위의 예제 코드를 담고 있습니다.




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

[연관 글]






[최초 등록일: ]
[최종 수정일: 7/10/2021]

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

비밀번호

댓글 작성자
 




... 166  167  168  169  170  171  172  173  174  175  176  [177]  178  179  180  ...
NoWriterDateCnt.TitleFile(s)
614정성태11/9/200833442.NET Framework: 110. WPF - 전역 예외 처리 [4]파일 다운로드1
613정성태11/8/200823003.NET Framework: 109. WPF - SystemColors 색상표파일 다운로드1
612정성태11/1/200828448.NET Framework: 108. WPF + WCF 환경에서는 DataContract를 권장 [1]
611정성태10/31/200822344오류 유형: 62. WPF - Visual Studio 2008 비정상 종료
610정성태10/24/200825090Team Foundation Server: 26. TFS 2008 SP1 + SQL Server 2008 설치
609정성태10/24/200829452.NET Framework: 107. WPF - RadioButton 데이터 바인딩 해제 현상파일 다운로드2
608정성태10/23/200823329오류 유형: 61. TFS 연결 오류: TF31003, TF30331 오류
607정성태10/18/200821477Windows: 32. 자동 실행 경로에 ".." 가 포함된 경우
606정성태10/18/200823442.NET Framework: 106. WCF - 다중 서비스 호스트파일 다운로드1
605정성태10/18/200826970.NET Framework: 105. WPF - 닫기 버튼을 없애려면.
604정성태10/18/200827430오류 유형: 60. System.Management.ManagementException - Generic failure [1]
602정성태10/15/200829485오류 유형: 59. WPF - XAML 로딩 시 Visual Studio 비정상 종료 [1]
600정성태10/9/200834264디버깅 기술: 18. TFS Team Build + Source Server = 소스 코드 디버깅 [3]
603정성태10/15/200826050    답변글 디버깅 기술: 18.1. 소스 서버 구성, 그 외의 이야기
599정성태10/5/200831674디버깅 기술: 17. TFS Team Build + Symbol Server [1]
598정성태10/3/200821798VS.NET IDE: 57. VS.NET 2008 - 다중 프로젝트에서 단일 SNK를 사용하는 방법
597정성태10/2/200820452Team Foundation Server: 25. VSTS 2008의 Build Explorer
596정성태10/2/200827243오류 유형: 58. WPF : 드롭다운 유형의 ComboBox가 펼쳐지지 않는 문제
595정성태10/1/200834919디버깅 기술: 16. Watson Bucket 정보를 이용한 CLR 응용 프로그램 예외 분석 [2]
594정성태9/22/200822832.NET Framework: 104. Win32Exception 클래스 소개
591정성태7/24/200819449오류 유형: 57. VS.NET 2008 TFC - 체크인 시에 비프 음과 함께 정지되는 현상
592정성태7/28/200819395    답변글 오류 유형: 57.1. VS.NET 2008 TFC - 체크인 시에 비프 음과 함께 정지되는 현상 [1]
590정성태7/20/200825362.NET Framework: 103. WPF - ControlTemplate을 코드에서 다뤄보기 [1]
589정성태6/17/200821945.NET Framework: 102. COM 개체의 이벤트를 구독하는 코드 제작 [1]
588정성태6/13/200824006VC++: 35. COM 이벤트에서 반환값을 가진 콜백 정의
587정성태6/10/200828678VS.NET IDE: 56. C#에서 아쉬운 __DATE__, __TIME__ 매크로 [2]
... 166  167  168  169  170  171  172  173  174  175  176  [177]  178  179  180  ...