私は最近、いくつかの機能を改善するために、会社のために維持している既存のアプリケーションにいくつかの変更を加えました。しかし、問題が発生しました。すべての Google 検索で役立つ情報を見つけることができません。プラットフォームは次のとおりです。
PostgreSQL (v. 9.1.1) サーバーへの ODBC 経由の ADODB 接続を使用して、Windows 7 (64 ビット) で実行されている VB6 アプリケーション。
問題は、何らかの理由で、私が使用している SSPI 認証方法が PostgreSQL データベースのシーケンスから値を取得できないように見えることです。他の (VB.NET) アプリケーションは、SSPI 認証を使用して (Npgsql を使用して) 問題なく同じデータベース サーバーに接続します。
VB6 アプリケーションで ODBC 接続に使用される基本的な接続文字列は次のとおりです。
DRIVER={PostgreSQL ANSI};Server=<SERVERNAMEHERE>;Port=<####>;Database=<DATABASENAMEHERE>;Uid=<USERNAMEHERE>
データベースへの接続を試みた後に PostgreSQL サーバーのログを確認すると、次のエラーが見つかりました。
CDT FATAL: SSPI authentication failed for user "<USERNAMEHERE>"
CDT LOG: could not send data to client: No connection could be made because the target machine actively refused it.
PGAdmin III を介して別のマシン (資格情報でログイン) からこのユーザーとしてデータベースに接続しようとしましたが、問題なく接続できました。この 2 台目のマシン (これも Windows 7 64 ビット) で同じアプリケーションを実際に試してみましたが、接続にエラーは発生していないようです。
もちろん、WinXP VM で VB6 IDE を介してコードを実行すると (自分の資格情報で)、すべてが期待どおりに動作するように見えます。ユーザーの Active Directory アカウントがアクティブでロック解除されていること、および PostgreSQL データベースに正しいユーザーが正しいグループ ロール メンバーシップなどで作成されていることを確認しました。したがって、PostgreSQL 用にインストールされた ODBC ドライバーに何か問題があるに違いないというのが私の考えです。64 ビットの PostgreSQL ODBC ドライバーをインストールしましたが、(もちろん) 役に立ちませんでした。32 ビット ドライバーをアンインストールして再インストールしましたが (32 ビット アプリケーションで実行されているため)、変更はありません。
データベースへの接続を試みるために使用しているVB6コードは次のとおりです。
Private Function GetPGCertNumber() As Long
On Error GoTo PGSQLError
Dim PGDB As ADODB.Connection
Dim RS As ADODB.Recordset
Dim CertNum As Long
Dim SQLStr As String
Set PGDB = New ADODB.Connection
PGDB.ConnectionString = PGSQL_CONNECTION_STR
PGDB.CursorLocation = adUseServer
PGDB.Open
SQLStr = "SELECT nextval('certificatenumber_seq')"
Set RS = New ADODB.Recordset
RS.CursorLocation = adUseServer
RS.Open SQLStr, PGDB
If Not RS.EOF And Not RS.BOF Then
CertNum = RS!nextval
Else
CertNum = -1
End If
GetPGCertNumber = CertNum
RS.Close
Set RS = Nothing
PGDB.Close
Set PGDB = Nothing
Exit Function
PGSQLError:
Dim ErrorMsg As String
GetPGCertNumber = -1
ErrorMsg = "An error occurred retrieving the next certificate number to use." & vbCrLf & _
"Connection String: " & PGSQL_CONNECTION_STR & vbCrLf & _
"Command String: " & SQLStr & vbCrLf & _
"Database State: " & PGDB.State & vbCrLf & vbCrLf
MsgBox ErrorMsg, vbCritical + vbOKOnly, "POSTGRESQL DATABASE ERROR"
On Error Resume Next
If Not PGDB Is Nothing Then
If PGDB.State <> 0 Then
PGDB.Close
End If
Set PGDB = Nothing
End If
End Function
PostgreSQL データベースでシーケンスを確認しましたが、シーケンスがインクリメントされていません。表示されるエラー メッセージは、SQLStr変数がまだ設定されていないことを示しています。これは、Openメソッドが呼び出されているときに発生していることを示しています。
当面の間、「応急処置」の回避策を考え出しました。SSPI の代わりに MD5 ログイン (pg_hba.conf で指定) を使用する PostgreSQL サーバー上に、アクセスが制限された新しいユーザーを作成しました。これを接続文字列 ( ) にハードコーディングしましたPGSQL_CONNECTION_STR。これまでのところ、これは正しく機能しているように見えます。この問題は、この環境で PostgreSQL 用の ODBC コネクタで SSPI を使用することに特に関連しているとさらに確信しています。
この時点で、誰かが PostgreSQL ODBC ドライバーを使用して SSPI 経由で PostgreSQL データベースへの接続を認証する際の特定の問題を知っているのではないかと考えています。資格情報がアクセスが制限されたユーザーのものであっても、資格情報をアプリケーションにハードコーディングする必要はありません。知っていることはすべて調べてみましたが、おそらく上記で言及できなかったので、説明が必要な場合はお知らせください。よろしくお願いします。
編集:私がまだ試していない唯一のことは、64 ビット ODBC ドライバーをインストールし、代わりにそれを使用するように接続文字列を変更することです。私がこれを試していない理由は、まだ 64 ビット OS にアップグレードしていないユーザーがいるためです。おそらく、ユーザーが VB6 を介して 32 ビット OS と 64 ビット OS のどちらを使用しているかを判断する方法を見つけることができれば、これが実行可能な代替手段になる可能性があります (64 ビット ODBC ドライバーが実際に正しく動作すると仮定します)。
編集 - デバッグ ログの詳細 (編集済み):
[mylog_3380.log]
[3336-0.000]calling getDSNdefaults
[3336-0.015]CC_connect: entering...
[3336-0.015]sslmode=disable
[3336-0.015]original_CC_connect: entering...
[3336-0.015]Driver Version='09.03.0300,201405140001' linking 1600 dynamic Multithread library
[3336-0.031]original_CC_connect: DSN = '', server = '<SERVERNAMEHERE>', port = '####', database = '<DATABASENAMEHERE>', username = '<USERNAMEHERE>', password=''
[3336-0.031]connecting to the server socket...
[3336-0.047](0)(null) ERRNO=0
[3336-0.047]connection to the server socket succeeded.
[3336-0.047]!!! usrname=<USERNAMEHERE> server=<SERVERNAMEHERE>
[3336-0.047]sizeof startup packet = 80
[3336-0.047]sent the authentication block successfully.
[3336-0.047]gonna do authentication
[3336-0.047]read -1, global_socket_buffersize=4096
[3336-0.047]Lasterror=10035
[3336-0.062]read 9, global_socket_buffersize=4096
[3336-0.062]auth got 'R'
[3336-0.062]areq = 9 salt=0000000000
[3336-0.062]in AUTH_REQ_SSPI
[3336-47.767][[SQLAllocHandle]][3336-47.767]PGAPI_AllocConnect: entering...
[3336-47.767]**** PGAPI_AllocConnect: henv = 02B413B8, conn = 02B481C0
[3336-47.767]EN_add_connection: self = 02B413B8, conn = 02B481C0
[3336-47.767] added at i=1, conn->henv = 02B413B8, conns[i]->henv = 02B413B8
[3336-47.767][SQLGetInfo(30)][3336-47.767]PGAPI_GetInfo: entering...fInfoType=77
[3336-47.767]PGAPI_GetInfo: p='03.50', len=0, value=0, cbMax=12
[3336-47.767][[SQLSetConnectAttr]] 103
[3336-47.767]PGAPI_SetConnectAttr for 02B481C0: 103 0000000F
[3336-47.767]PGAPI_SetConnectOption: entering fOption = 103 vParam = 15
[3336-47.767][SQLDriverConnect][3336-47.767]PGAPI_DriverConnect: entering...
[3336-47.767]**** PGAPI_DriverConnect: fDriverCompletion=0, connStrIn='DRIVER={PostgreSQL ANSI};UID=<USERNAMEHERE>;Server=<SERVERNAMEHERE>;Port=####;Database=<DATABASENAMEHERE>;debug=1;commlog=1;'
[3336-47.767]CC_conninfo_init opt=2
[3336-47.767]copy_globals driver=PostgreSQL ANSI socket_buffersize=4096
[3336-47.767]our_connect_string = 'DRIVER={PostgreSQL ANSI};UID=<USERNAMEHERE>;Server=<SERVERNAMEHERE>;Port=####;Database=<DATABASENAMEHERE>;debug=1;commlog=1;'
[3336-47.767]attribute = 'DRIVER', value = '{PostgreSQL ANSI}'
[3336-47.783]copyAttributes: DSN='',server='',dbase='',user='',passwd='',port='',onlyread='',protocol='',conn_settings='(null)',disallow_premature=-1)
[3336-47.783]attribute = 'UID', value = '<USERNAMEHERE>'
[3336-47.783]copyAttributes: DSN='',server='',dbase='',user='<USERNAMEHERE>',passwd='',port='',onlyread='',protocol='',conn_settings='(null)',disallow_premature=-1)
[3336-47.783]attribute = 'Server', value = '<SERVERNAMEHERE>'
[3336-47.783]copyAttributes: DSN='',server='<SERVERNAMEHERE>',dbase='',user='<USERNAMEHERE>',passwd='',port='',onlyread='',protocol='',conn_settings='(null)',disallow_premature=-1)
[3336-47.783]attribute = 'Port', value = '####'
[3336-47.783]copyAttributes: DSN='',server='<SERVERNAMEHERE>',dbase='',user='<USERNAMEHERE>',passwd='',port='####',onlyread='',protocol='',conn_settings='(null)',disallow_premature=-1)
[3336-47.783]attribute = 'Database', value = '<DATABASENAMEHERE>'
[3336-47.783]copyAttributes: DSN='',server='<SERVERNAMEHERE>',dbase='<DATABASENAMEHERE>',user='<USERNAMEHERE>',passwd='',port='####',onlyread='',protocol='',conn_settings='(null)',disallow_premature=-1)
[3336-47.783]attribute = 'debug', value = '1'
[3336-47.783]copyAttributes: DSN='',server='<SERVERNAMEHERE>',dbase='<DATABASENAMEHERE>',user='<USERNAMEHERE>',passwd='',port='####',onlyread='',protocol='',conn_settings='(null)',disallow_premature=-1)
[3336-47.783]attribute = 'commlog', value = '1'
[3336-47.783]copyAttributes: DSN='',server='<SERVERNAMEHERE>',dbase='<DATABASENAMEHERE>',user='<USERNAMEHERE>',passwd='',port='####',onlyread='',protocol='',conn_settings='(null)',disallow_premature=-1)
[3336-47.783]getDSNinfo: DSN= overwrite=0
[3336-47.799]our_connect_string = 'DRIVER={PostgreSQL ANSI};UID=<USERNAMEHERE>;Server=<SERVERNAMEHERE>;Port=####;Database=<DATABASENAMEHERE>;debug=1;commlog=1;'
[3336-47.799]attribute = 'DRIVER', value = '{PostgreSQL ANSI}'
[3336-47.799]copyCommonAttributes: A7=100;A8=4096;A9=0;B0=255;B1=8190;B2=0;B3=0;B4=0;B5=1;B6=0;B7=1;B8=0;B9=1;C0=0;C1=0;C2=dd_;[3336-47.799]attribute = 'UID', value = '<USERNAMEHERE>'
[3336-47.799]copyCommonAttributes: A7=100;A8=4096;A9=0;B0=255;B1=8190;B2=0;B3=0;B4=0;B5=1;B6=0;B7=1;B8=0;B9=1;C0=0;C1=0;C2=dd_;[3336-47.799]attribute = 'Server', value = '<SERVERNAMEHERE>'
[3336-47.799]copyCommonAttributes: A7=100;A8=4096;A9=0;B0=255;B1=8190;B2=0;B3=0;B4=0;B5=1;B6=0;B7=1;B8=0;B9=1;C0=0;C1=0;C2=dd_;[3336-47.799]attribute = 'Port', value = '####'
[3336-47.799]copyCommonAttributes: A7=100;A8=4096;A9=0;B0=255;B1=8190;B2=0;B3=0;B4=0;B5=1;B6=0;B7=1;B8=0;B9=1;C0=0;C1=0;C2=dd_;[3336-47.799]attribute = 'Database', value = '<DATABASENAMEHERE>'
[3336-47.799]copyCommonAttributes: A7=100;A8=4096;A9=0;B0=255;B1=8190;B2=0;B3=0;B4=0;B5=1;B6=0;B7=1;B8=0;B9=1;C0=0;C1=0;C2=dd_;[3336-47.799]attribute = 'debug', value = '1'
[3336-47.799]copyCommonAttributes: A7=100;A8=4096;A9=0;B0=255;B1=8190;B2=1;B3=0;B4=0;B5=1;B6=0;B7=1;B8=0;B9=1;C0=0;C1=0;C2=dd_;[3336-47.799]attribute = 'commlog', value = '1'
[3336-47.799]copyCommonAttributes: A7=100;A8=4096;A9=0;B0=255;B1=8190;B2=1;B3=1;B4=0;B5=1;B6=0;B7=1;B8=0;B9=1;C0=0;C1=0;C2=dd_;[3336-47.799]calling getDSNdefaults
[3336-47.799]CC_connect: entering...
[3336-47.799]sslmode=disable
[3336-47.799]original_CC_connect: entering...
[3336-47.799]Driver Version='09.03.0300,201405140001' linking 1600 dynamic Multithread library
[3336-47.799]original_CC_connect: DSN = '', server = '<SERVERNAMEHERE>', port = '####', database = '<DATABASENAMEHERE>', username = '<USERNAMEHERE>', password=''
[3336-47.799]connecting to the server socket...
[3336-47.814](0)(null) ERRNO=0
[3336-47.814]connection to the server socket succeeded.
[3336-47.814]!!! usrname=<USERNAMEHERE> server=<SERVERNAMEHERE>
[3336-47.814]sizeof startup packet = 80
[3336-47.814]sent the authentication block successfully.
[3336-47.814]gonna do authentication
[3336-47.814]read -1, global_socket_buffersize=4096
[3336-47.814]Lasterror=10035
[3336-47.830]read 9, global_socket_buffersize=4096
[3336-47.830]auth got 'R'
[3336-47.830]areq = 9 salt=0000000000
[3336-47.830]in AUTH_REQ_SSPI
[psqlodbc_3380.log]
[0.015]Driver Version='09.03.0300,201405140001' linking 1600 dynamic Multithread library
[0.015]Global Options: fetch=100, socket=4096, unknown_sizes=0, max_varchar_size=255, max_longvarchar_size=8190
[0.015] disable_optimizer=0, ksqo=1, unique_index=1, use_declarefetch=0
[0.015] text_as_longvarchar=1, unknowns_as_longvarchar=0, bools_as_char=1 NAMEDATALEN=64
[0.031] extra_systable_prefixes='dd_;', conn_settings='(null)' conn_encoding=''
[47.767]conn=02B481C0, PGAPI_DriverConnect( in)='DRIVER={PostgreSQL ANSI};UID=<USERNAMEHERE>;Server=<SERVERNAMEHERE>;Port=####;Database=<DATABASENAMEHERE>;debug=1;commlog=1;', fDriverCompletion=0
[47.799]Driver Version='09.03.0300,201405140001' linking 1600 dynamic Multithread library
[47.799]Global Options: fetch=100, socket=4096, unknown_sizes=0, max_varchar_size=255, max_longvarchar_size=8190
[47.799] disable_optimizer=0, ksqo=1, unique_index=1, use_declarefetch=0
[47.799] text_as_longvarchar=1, unknowns_as_longvarchar=0, bools_as_char=1 NAMEDATALEN=64
[47.799] extra_systable_prefixes='dd_;', conn_settings='(null)' conn_encoding=''
編集 - サーバー ログ: これは、テスト時のログ エントリです。以前に投稿したものとほとんど同じですが、接続タイムアウトなどを考慮して数分進めました。ストアド プロシージャを呼び出している VB6 アプリケーションの別の関数からのものですが、SSPI 認証で同じエラー/問題が発生しています。
2014-06-30 16:57:17 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 16:57:17 CDT LOG: unexpected EOF on client connection
2014-06-30 16:57:30 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 16:57:30 CDT LOG: unexpected EOF on client connection
2014-06-30 16:57:31 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 16:57:31 CDT LOG: unexpected EOF on client connection
2014-06-30 16:58:38 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 16:58:38 CDT LOG: unexpected EOF on client connection
2014-06-30 16:59:02 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 16:59:02 CDT LOG: unexpected EOF on client connection
2014-06-30 16:59:22 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 16:59:22 CDT LOG: unexpected EOF on client connection
2014-06-30 17:00:23 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 17:00:23 CDT LOG: unexpected EOF on client connection
2014-06-30 17:00:44 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 17:00:44 CDT LOG: unexpected EOF on client connection
2014-06-30 17:00:46 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 17:00:46 CDT LOG: unexpected EOF on client connection
2014-06-30 17:00:52 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 17:00:52 CDT LOG: unexpected EOF on client connection
2014-06-30 17:01:17 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 17:01:17 CDT LOG: unexpected EOF on client connection
2014-06-30 17:01:43 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 17:01:43 CDT FATAL: SSPI authentication failed for user "<USERNAMEHERE>"
2014-06-30 17:01:43 CDT LOG: could not send data to client: No connection could be made because the target machine actively refused it.
2014-06-30 17:01:43 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 17:01:43 CDT FATAL: SSPI authentication failed for user "<USERNAMEHERE>"
2014-06-30 17:01:43 CDT LOG: could not send data to client: No connection could be made because the target machine actively refused it.
2014-06-30 17:03:56 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 17:03:56 CDT LOG: unexpected EOF on client connection
2014-06-30 17:04:02 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 17:04:02 CDT LOG: unexpected EOF on client connection
2014-06-30 17:04:10 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 17:04:10 CDT LOG: unexpected EOF on client connection
2014-06-30 17:05:30 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 17:05:30 CDT LOG: unexpected EOF on client connection
2014-06-30 17:05:39 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 17:05:39 CDT LOG: unexpected EOF on client connection
2014-06-30 17:06:33 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 17:06:33 CDT LOG: unexpected EOF on client connection
2014-06-30 17:11:05 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 17:11:05 CDT LOG: unexpected EOF on client connection
2014-06-30 17:11:50 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-06-30 17:11:50 CDT LOG: unexpected EOF on client connection
追加のデバッグを有効にすることはできますが、そこからデータを取得するのに少し時間がかかる場合があります。同じODBCコネクタがインストールされた32ビットのWinXPテスト環境でこれらの同じ機能が正しく動作することを除いて、問題がPostgreSQLのバージョンに関連している可能性は確かにあります(以前に示唆したように)。
編集 - log_min_messages = debug1:
2014-07-02 10:33:24 CDT DEBUG: autovacuum: processing database "<DATABASENAMEHERE>"
2014-07-02 10:33:25 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-07-02 10:33:25 CDT FATAL: SSPI authentication failed for user "<USERNAMEHERE>"
2014-07-02 10:33:25 CDT LOG: could not send data to client: No connection could be made because the target machine actively refused it.
2014-07-02 10:33:29 CDT DEBUG: autovacuum: processing database "<DATABASENAMEHERE>"
log_min_messages = debug5
2014-07-02 10:36:49 CDT DEBUG: StartTransaction
2014-07-02 10:36:49 CDT DEBUG: name: unnamed; blockState: DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children:
2014-07-02 10:36:49 CDT DEBUG: CommitTransaction
2014-07-02 10:36:49 CDT DEBUG: name: unnamed; blockState: STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children:
2014-07-02 10:36:49 CDT DEBUG: InitPostgres
2014-07-02 10:36:49 CDT DEBUG: my backend ID is 5
2014-07-02 10:36:49 CDT DEBUG: StartTransaction
2014-07-02 10:36:49 CDT DEBUG: name: unnamed; blockState: DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children:
2014-07-02 10:36:49 CDT DEBUG: CommitTransaction
2014-07-02 10:36:49 CDT DEBUG: name: unnamed; blockState: STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children:
2014-07-02 10:36:49 CDT DEBUG: autovacuum: processing database "<DATABASENAMEHERE>"
2014-07-02 10:36:49 CDT DEBUG: StartTransaction
2014-07-02 10:36:49 CDT DEBUG: name: unnamed; blockState: DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children:
2014-07-02 10:36:49 CDT DEBUG: pg_statistic: vac: 80 (threshold 124), anl: 560 (threshold 87)
2014-07-02 10:36:49 CDT DEBUG: pg_type: vac: 0 (threshold 112), anl: 0 (threshold 81)
2014-07-02 10:36:49 CDT DEBUG: pg_attribute: vac: 0 (threshold 651), anl: 0 (threshold 351)
2014-07-02 10:36:49 CDT DEBUG: pg_authid: vac: 19 (threshold 50), anl: 30 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: pg_proc: vac: 0 (threshold 518), anl: 0 (threshold 284)
2014-07-02 10:36:49 CDT DEBUG: pg_class: vac: 0 (threshold 106), anl: 0 (threshold 78)
2014-07-02 10:36:49 CDT DEBUG: pg_database: vac: 3 (threshold 50), anl: 7 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: pg_inherits: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: pg_index: vac: 0 (threshold 72), anl: 0 (threshold 61)
2014-07-02 10:36:49 CDT DEBUG: pg_operator: vac: 0 (threshold 191), anl: 0 (threshold 121)
2014-07-02 10:36:49 CDT DEBUG: pg_opfamily: vac: 0 (threshold 64), anl: 0 (threshold 57)
2014-07-02 10:36:49 CDT DEBUG: pg_opclass: vac: 0 (threshold 73), anl: 0 (threshold 61)
2014-07-02 10:36:49 CDT DEBUG: pg_amop: vac: 0 (threshold 122), anl: 0 (threshold 86)
2014-07-02 10:36:49 CDT DEBUG: pg_amproc: vac: 0 (threshold 100), anl: 0 (threshold 75)
2014-07-02 10:36:49 CDT DEBUG: pg_language: vac: 0 (threshold 51), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: pg_largeobject_metadata: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: pg_rewrite: vac: 0 (threshold 70), anl: 0 (threshold 60)
2014-07-02 10:36:49 CDT DEBUG: pg_description: vac: 0 (threshold 705), anl: 0 (threshold 378)
2014-07-02 10:36:49 CDT DEBUG: pg_cast: vac: 0 (threshold 89), anl: 0 (threshold 70)
2014-07-02 10:36:49 CDT DEBUG: pg_namespace: vac: 0 (threshold 51), anl: 0 (threshold 51)
2014-07-02 10:36:49 CDT DEBUG: pg_conversion: vac: 0 (threshold 76), anl: 0 (threshold 63)
2014-07-02 10:36:49 CDT DEBUG: pg_depend: vac: 0 (threshold 1219), anl: 0 (threshold 635)
2014-07-02 10:36:49 CDT DEBUG: pg_tablespace: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: pg_pltemplate: vac: 0 (threshold 52), anl: 0 (threshold 51)
2014-07-02 10:36:49 CDT DEBUG: pg_auth_members: vac: 9 (threshold 75), anl: 37 (threshold 62)
2014-07-02 10:36:49 CDT DEBUG: pg_shdepend: vac: 100 (threshold 943), anl: 394 (threshold 496)
2014-07-02 10:36:49 CDT DEBUG: pg_shdescription: vac: 36 (threshold 50), anl: 42 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: pg_ts_config: vac: 0 (threshold 53), anl: 0 (threshold 52)
2014-07-02 10:36:49 CDT DEBUG: pg_ts_dict: vac: 0 (threshold 53), anl: 0 (threshold 52)
2014-07-02 10:36:49 CDT DEBUG: pg_ts_parser: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: pg_ts_template: vac: 0 (threshold 51), anl: 0 (threshold 51)
2014-07-02 10:36:49 CDT DEBUG: pg_extension: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: pg_foreign_data_wrapper: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: pg_foreign_server: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: pg_default_acl: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: pg_seclabel: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: pg_collation: vac: 0 (threshold 51), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: pg_attrdef: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: pg_am: vac: 0 (threshold 51), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: pg_db_role_setting: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 104), anl: 0 (threshold 77)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 96), anl: 0 (threshold 73)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 83), anl: 0 (threshold 67)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 104), anl: 0 (threshold 77)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 134), anl: 0 (threshold 92)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 82), anl: 0 (threshold 66)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 71), anl: 0 (threshold 61)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 80), anl: 0 (threshold 65)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 50), anl: 0 (threshold 50)
2014-07-02 10:36:49 CDT DEBUG: <TABLENAMEHERE>: vac: 0 (threshold 826), anl: 0 (threshold 438)
2014-07-02 10:36:49 CDT DEBUG: CommitTransaction
2014-07-02 10:36:49 CDT DEBUG: name: unnamed; blockState: STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children:
2014-07-02 10:36:49 CDT DEBUG: shmem_exit(0): 8 callbacks to make
2014-07-02 10:36:49 CDT DEBUG: proc_exit(0): 2 callbacks to make
2014-07-02 10:36:49 CDT DEBUG: exit(0)
2014-07-02 10:36:49 CDT DEBUG: shmem_exit(-1): 0 callbacks to make
2014-07-02 10:36:49 CDT DEBUG: proc_exit(-1): 0 callbacks to make
2014-07-02 10:36:49 CDT DEBUG: reaping dead processes
2014-07-02 10:36:49 CDT DEBUG: server process (PID 5692) exited with exit code 0
2014-07-02 10:36:51 CDT LOG: could not receive data from client: No connection could be made because the target machine actively refused it.
2014-07-02 10:36:51 CDT FATAL: SSPI authentication failed for user "<USERNAMEHERE>"
2014-07-02 10:36:51 CDT LOG: could not send data to client: No connection could be made because the target machine actively refused it.
2014-07-02 10:36:51 CDT DEBUG: shmem_exit(1): 7 callbacks to make
2014-07-02 10:36:51 CDT DEBUG: proc_exit(1): 3 callbacks to make
2014-07-02 10:36:51 CDT DEBUG: exit(1)
2014-07-02 10:36:51 CDT DEBUG: shmem_exit(-1): 0 callbacks to make
2014-07-02 10:36:51 CDT DEBUG: proc_exit(-1): 0 callbacks to make
2014-07-02 10:36:51 CDT DEBUG: reaping dead processes
2014-07-02 10:36:51 CDT DEBUG: server process (PID 4300) exited with exit code 1