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

System.Data.SqlClient.SqlException (0x80131904): Connection Timeout Expired 예외 발생 시 "[Pre-Login] initialization=48; handshake=1944;" 값의 의미

"Connection Timeout Expired" 오류는 보통 Open 메서드 수행 시 발생합니다.

SqlConnection sqlCon = ...;
sqlCon.Open();

예외 메시지는 대략 이렇습니다.

System.Data.SqlClient.SqlException (0x80131904): Connection Timeout Expired. The timeout period elapsed while attempting to consume the pre-login handshake acknowledgement. This could be because the pre-login handshake failed or the server was unable to respond back in time. The duration spent while attempting to connect to this server was - [Pre-Login] initialization=48; handshake=1944; ---> System.ComponentModel.Win32Exception (0x80004005): The wait operation timed out at System.Data.SqlClient.SqlInternalConnectionTds..ctor(DbConnectionPoolIdentity identity, SqlConnectionString connectionOptions, SqlCredential credential, Object providerInfo, String newPassword, SecureString newSecurePassword, Boolean redirectedUserInstance, SqlConnectionString userConnectionOptions, SessionData reconnectSessionData, DbConnectionPool pool, String accessToken, Boolean applyTransientFaultHandling)
at System.Data.SqlClient.SqlConnectionFactory.CreateConnection(DbConnectionOptions options, DbConnectionPoolKey poolKey, Object poolGroupProviderInfo, DbConnectionPool pool, DbConnection owningConnection, DbConnectionOptions userOptions)
at System.Data.ProviderBase.DbConnectionFactory.CreatePooledConnection(DbConnectionPool pool, DbConnection owningObject, DbConnectionOptions options, DbConnectionPoolKey poolKey, DbConnectionOptions userOptions)
at System.Data.ProviderBase.DbConnectionPool.CreateObject(DbConnection owningObject, DbConnectionOptions userOptions, DbConnectionInternal oldConnection)
at System.Data.ProviderBase.DbConnectionPool.UserCreateRequest(DbConnection owningObject, DbConnectionOptions userOptions, DbConnectionInternal oldConnection)
at System.Data.ProviderBase.DbConnectionPool.TryGetConnection(DbConnection owningObject, UInt32 waitForMultipleObjectsTimeout, Boolean allowCreate, Boolean onlyOneCheckConnection, DbConnectionOptions userOptions, DbConnectionInternal& connection)
at System.Data.ProviderBase.DbConnectionPool.TryGetConnection(DbConnection owningObject, TaskCompletionSource`1 retry, DbConnectionOptions userOptions, DbConnectionInternal& connection)
at System.Data.ProviderBase.DbConnectionFactory.TryGetConnection(DbConnection owningConnection, TaskCompletionSource`1 retry, DbConnectionOptions userOptions, DbConnectionInternal oldConnection, DbConnectionInternal& connection)
at System.Data.ProviderBase.DbConnectionInternal.TryOpenConnectionInternal(DbConnection outerConnection, DbConnectionFactory connectionFactory, TaskCompletionSource`1 retry, DbConnectionOptions userOptions)
at System.Data.SqlClient.SqlConnection.TryOpenInner(TaskCompletionSource`1 retry)
at System.Data.SqlClient.SqlConnection.TryOpen(TaskCompletionSource`1 retry)
at System.Data.SqlClient.SqlConnection.Open()


연결 제한 시간이 만료되었습니다. 사전 로그인 핸드세이크 확인을 사용하려는 동안 제한 시간이 경과되었습니다. 이 문제는 사전 로그인 핸드세이크가 실패했거나 서버가 시간 내에 응답할 수 없기 때문일 수 있습니다. 이 서버에 연결하려고 시도할 때 걸린 시간은 [사전 로그인] 초기화=48, 핸드세이크=1944입니다. ---> System.ComponentModel.Win32Exception (0x80004005): 대기 작동이 시작 초과되었습니다. 

위의 메시지에서는 대략 2초의 시간 동안 응답이 없어 예외가 발생한 것인데 이런 경우 연결 문자열에 timeout을 2초로 설정했기 때문입니다.

Password=...; User ID=...; Initial Catalog=...; Server=...; CONNECTION TIMEOUT=2;

그런데, 오류 메시지에서 보여주는 시간을 언제나 믿을 수 있는 것은 아닙니다. 가령, 테스트를 위해 가짜 SQL 서버를 다음과 같이 만들어 주고,

using System;
using System.Net;
using System.Net.Sockets;

namespace ConsoleApp1
{
    class Program
    {
        static void Main(string[] args)
        {
            TcpListener tl = new TcpListener(IPAddress.Any, 2222);
            tl.Start(); // 접속 대기만 할 뿐 연결을 Accept하지 않음.

            while (true)
            {
                Console.ReadLine();
            }

            tl.Stop();
        }
    }
}

test.aspx 페이지를 만들어 다음과 같은 연결 문자열로 DB 연결을 시도하면,

Password=...; User ID=...; Initial Catalog=...; Server=tcp:localhost,2222; CONNECTION TIMEOUT=2;

"[Pre-Login] initialization=48; handshake=1944;" 같은 시간의 예외 상황을 재현할 수 있습니다. 재미있는 것은, test.aspx를 호출하고 2초 후 (오류 페이지와 함께) 응답이 있었을 때 다시 재빠르게 test.aspx를 호출하면 빠른 응답이 옵니다. 그리고 그때의 오류 메시지에는 여전히 "[Pre-Login] initialization=48; handshake=1944;"처럼 2초의 시간이 걸렸다고 합니다.

제 예상으로는, DB Connection Pool의 영향으로 이전 연결의 재사용으로 인해 initialization/handshake 정보가 초기화되지 않아 이런 문제가 발생하는 듯합니다. 만약 커넥션 풀을 없애면,

Pooling = false;Password=...; User ID=...; Initial Catalog=...; Server=tcp:localhost,2222; CONNECTION TIMEOUT=2;

test.aspx의 두 번째 호출에서조차도 initialization/handshake가 보여주는 정보만큼의 시간이 걸리는 것을 확인할 수 있습니다.




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







[최초 등록일: ]
[최종 수정일: 12/4/2017]

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

비밀번호

댓글 작성자
 




... 31  32  33  [34]  35  36  37  38  39  40  41  42  43  44  45  ...
NoWriterDateCnt.TitleFile(s)
12777정성태8/12/20217866오류 유형: 754. Visual Studio - Input or output cannot be redirected because the specified file is invalid.
12776정성태8/12/20217185오류 유형: 753. gunicorn과 uwsgi 함께 사용 시 ERR_CONNECTION_REFUSED
12775정성태8/12/202117591스크립트: 22. 파이썬 - 윈도우 환경에서 개발한 Django 앱을 WSL 환경의 gunicorn을 이용해 실행
12774정성태8/11/20218790.NET Framework: 1087. C# - Collection 개체의 다중 스레드 접근 시 "Operations that change non-concurrent collections must have exclusive access" 예외 발생
12773정성태8/11/20217957개발 환경 구성: 595. PyCharm - WSL과 연동해 Django App을 윈도우에서 리눅스 대상으로 개발
12772정성태8/11/20219469스크립트: 21. 파이썬 - 윈도우 환경에서 개발한 Django 앱을 WSL 환경의 uwsgi를 이용해 실행 [1]
12771정성태8/11/20217869Windows: 196. "Microsoft Windows Subsystem for Linux Background Host" / "Vmmem"을 종료하는 방법
12770정성태8/11/20218554.NET Framework: 1086. C# - Windows Forms 응용 프로그램의 자식 컨트롤 부하파일 다운로드1
12769정성태8/11/20216508오류 유형: 752. Python - ImportError: No module named pip._internal.cli.main 두 번째 이야기
12768정성태8/10/20217536.NET Framework: 1085. .NET 6에 포함된 신규 BCL API [1]파일 다운로드1
12767정성태8/10/20218637오류 유형: 752. Python - ImportError: No module named pip._internal.cli.main
12766정성태8/9/20217159Java: 32. closing inbound before receiving peer's close_notify
12765정성태8/9/20216485Java: 31. Cannot load JDBC driver class 'org.mysql.jdbc.Driver'
12764정성태8/9/202144926Java: 30. XML document from ServletContext resource [/WEB-INF/applicationContext.xml] is invalid
12763정성태8/9/20217933Java: 29. java.lang.NullPointerException - com.mysql.jdbc.ConnectionImpl.getServerCharset
12762정성태8/8/202111472Java: 28. IntelliJ - Unable to open debugger port 오류
12761정성태8/8/20218668Java: 27. IntelliJ - java: package javax.inject does not exist [2]
12760정성태8/8/20216065개발 환경 구성: 594. 전용 "Command Prompt for ..." 단축 아이콘 만들기
12759정성태8/8/20219207Java: 26. IntelliJ + Spring Framework + 새로운 Controller 추가 [2]파일 다운로드1
12758정성태8/7/20218544오류 유형: 751. Error assembling WAR: webxml attribute is required (or pre-existing WEB-INF/web.xml if executing in update mode)
12757정성태8/7/20219223Java: 25. IntelliJ + Spring Framework 프로젝트 생성
12756정성태8/6/20218037.NET Framework: 1084. C# - .NET Core Web API 단위 테스트 방법 [1]파일 다운로드1
12755정성태8/5/20217140개발 환경 구성: 593. MSTest - 단위 테스트에 static/instance 유형의 private 멤버 접근 방법파일 다운로드1
12754정성태8/5/20218066오류 유형: 750. manage.py - Your project may not work properly until you apply the migrations for app(s): admin, auth, contenttypes, sessions.
12753정성태8/5/20218348오류 유형: 749. PyCharm - Error: Django is not importable in this environment
12752정성태8/4/20216427개발 환경 구성: 592. JetBrains의 IDE(예를 들어, PyCharm)에서 Visual Studio 키보드 매핑 적용
... 31  32  33  [34]  35  36  37  38  39  40  41  42  43  44  45  ...