Обсуждение: ODBC Driver crash with MS Access 2007 (from GENERAL)

Hi

I'm currently encountering an interesting issue with the PostgreSQL ODBC
driver on Windows. I'm unlucky enough to have to use MS Access 2007 for
a project at the moment, with PostgreSQL providing the storage through
ODBC. It all works as well as can be expected from Access, except that
MS Access crashes when it quits.

The crash only occurs when the PostgreSQL ODBC driver has been used. If
the Access database file is opened but only Access-internal tables are
operated on, there's no crash when Access quits.

The crash occurs whether a file, system, or user DSN is being used.
I can reproduce this on two different machines. It happens with or
without SSL in use. It affects any Access 2007 database with a
PostgreSQL ODBC connection in use, including a newly created blank
database with a freshly linked table.

Because Windows is full of stripped binaries and limited debugging tools
I'm not able to get anything as useful as a backtrace at the moment.
I've had a quick look and strangely the crash address doesn't seem to be
part of the address space mapped to any DLLs. Windows Crash Reporter
seems to agree, in that it indicates that the module name is "unknown".

I'm at a bit of a loss. I'm used to debugging problems on platforms with
 luxuries like symbol names in binaries, or at least my own code on
win32 where I can build it for debugging.

Anybody else seeing, or seen, similar issues?

--
Craig Ringer

Hi Craig,
Which version of psqlodbc driver are you using ?

Craig Ringer wrote:
> Hi
>
> I'm currently encountering an interesting issue with the PostgreSQL ODBC
> driver on Windows. I'm unlucky enough to have to use MS Access 2007 for
> a project at the moment, with PostgreSQL providing the storage through
> ODBC. It all works as well as can be expected from Access, except that
> MS Access crashes when it quits.
>
> The crash only occurs when the PostgreSQL ODBC driver has been used. If
> the Access database file is opened but only Access-internal tables are
> operated on, there's no crash when Access quits.
>
> The crash occurs whether a file, system, or user DSN is being used.
> I can reproduce this on two different machines.

Could you send me directly the Mylog output ?

regards,
Hiroshi Inoue

 > It happens with or
> without SSL in use. It affects any Access 2007 database with a
> PostgreSQL ODBC connection in use, including a newly created blank
> database with a freshly linked table.
>
> Because Windows is full of stripped binaries and limited debugging tools
> I'm not able to get anything as useful as a backtrace at the moment.
> I've had a quick look and strangely the crash address doesn't seem to be
> part of the address space mapped to any DLLs. Windows Crash Reporter
> seems to agree, in that it indicates that the module name is "unknown".
>
> I'm at a bit of a loss. I'm used to debugging problems on platforms with
>  luxuries like symbol names in binaries, or at least my own code on
> win32 where I can build it for debugging.
>
> Anybody else seeing, or seen, similar issues?
>
> --
> Craig Ringer

Hiroshi Inoue wrote:
> Hi Craig,
> Which version of psqlodbc driver are you using ?

That would've been clever to provide, yes. Especially given how I
grumble when people fail to provide such details.

The psqlODBC driver version is 8.3.3.0 (containing libpq 8.3.4.8263).

Both systems are XP SP3 hosts running fully patched Access 2007. Both
are connecting to a PostgreSQL 8.3.3 server running on a Linux host. One
is on real physical hardware that's otherwise been utterly reliable; the
other is a kvm virtual machine that's similarly solid.

Interestingly, I didn't observe this issue when connecting to a server
running locally on the Window dev machine that hosts Access during
earlier development. It was only once I switched to a DSN pointing to a
remote server running on a Linux machine that issues arose.

I'll send you the mylog output off-list shortly.

--
Craig Ringer

Hiroshi Inoue wrote:

> Craig Ringer wrote:
>> Hi
>>
>> I'm currently encountering an interesting issue with the PostgreSQL ODBC
>> driver on Windows. I'm unlucky enough to have to use MS Access 2007 for
>> a project at the moment, with PostgreSQL providing the storage through
>> ODBC. It all works as well as can be expected from Access, except that
>> MS Access crashes when it quits.
>>
>> The crash only occurs when the PostgreSQL ODBC driver has been used. If
>> the Access database file is opened but only Access-internal tables are
>> operated on, there's no crash when Access quits.
>>
>> The crash occurs whether a file, system, or user DSN is being used.
>> I can reproduce this on two different machines.
>
> Could you send me directly the Mylog output ?

Sorry it's taken so long to respond - phone system meltdowns and other
fun took priority. I've attached the mylog output, and it looks like it
might well be crashing during disconnect.

Ideas?

--
Craig Ringer
[1704-0.000]calling getDSNdefaults
[1704-0.000]dconn_DoDialog: ci = 00E23E08
[1704-0.016]checking libpq library
[1704-0.063]psqlodbc path based libpq loaded module=00E30000
[1704-0.063]libpq hmodule=00E30000
[1704-0.078]libpq_exist=1
[1704-7.235]CC_connect: entering...
[1704-7.235]sslmode=require
[1704-7.235]LIBPQ_CC_connect: entering...
[1704-7.235]Driver Version='08.03.0300,200809260001' linking 1400 static Multithread library
[1704-7.250]LIBPQ_CC_connect: DSN = '', server = 'mail2.postnewspapers.com.au', port = '5432', database =
'psnbookings',username = 'greg', password='xxxxx' 
[1704-7.250]connecting to the database  using mail2.postnewspapers.com.au as the server
[1704-7.250]sizeof connectdb option = 99
[1704-7.250]DliNotifyHook Notify=0 0007C7CC
[1704-7.266]DliNotifyHook Notify=1 0007C7CC
[1704-7.297]psqlodbc path based libpq loaded module=00E30000
[1704-8.235]libpq connection to the database succeeded.
[1704-8.235]procotol=7.4
[1704-8.235]Server version=8.3.3
[1704-8.235]LIBPQ_connect: retuning 1
[1704-8.235]CC_setenv: entering...
[1704-8.235]PGAPI_AllocStmt: entering...
[1704-8.235]**** PGAPI_AllocStmt: hdbc = 00E23D88, stmt = 00E2DD28
[1704-8.235]CC_add_statement: self=00E23D88, stmt=00E2DD28
[1704-8.235]PGAPI_ExecDirect: entering...0
[1704-8.235]SC_recycle_statement: self= 00E2DD28
[1704-8.235]**** PGAPI_ExecDirect: hstmt=00E2DD28, statement='set DateStyle to 'ISO''
[1704-8.235]PGAPI_ExecDirect: calling PGAPI_Execute...
[1704-8.235]PGAPI_Execute: entering...0
[1704-8.235]PGAPI_Execute: clear errors...
[1704-8.235]PGAPI_NumParams: entering...
[1704-8.235]SC_scanQueryAndCountParams: entering...
[1704-8.235]prepareParameters 0 end
[1704-8.235]SC_recycle_statement: self= 00E2DD28
[1704-8.235]Exec_with_parameters_resolved: copying statement params: trans_status=1, len=22, stmt='set DateStyle to
'ISO''
[1704-8.235]   stmt_with_params = 'set DateStyle to 'ISO''
[1704-8.235]about to begin SC_execute
[1704-8.235]      it's NOT a select statement: stmt=00E2DD28
[1704-8.235]CC_send_query: conn=00E23D88, query='set DateStyle to 'ISO''
[1704-8.235]send_query: done sending query 28bytes flushed
[1704-8.235]in QR_Constructor
[1704-8.235]exit QR_Constructor
[1704-8.235]read 39, global_socket_buffersize=4096
[1704-8.235]send_query: got id = 'S'
[1704-8.235]send_query: got id = 'C'
[1704-8.235]send_query: ok - 'C' - SET
[1704-8.235]send_query: setting cmdbuffer = 'SET'
[1704-8.250]send_query: returning res = 00E2EF60
[1704-8.250]send_query: got id = 'Z'
[1704-8.250]SC_set_Result(e2dd28, e2ef60)[1704-8.250]QResult: enter DESTRUCTOR
[1704-8.250]retval=0
[1704-8.250]PGAPI_ExecDirect: returned 0 from PGAPI_Execute
[1704-8.250]CC_setenv: result 0, status 1 from set DateStyle
[1704-8.250]PGAPI_ExecDirect: entering...0
[1704-8.250]SC_recycle_statement: self= 00E2DD28
[1704-8.250]QResult: enter DESTRUCTOR
[1704-8.250]QResult: in QR_close_result
[1704-8.250]QResult: free memory in, fcount=0
[1704-8.250]QResult: free memory out
[1704-8.250]QResult: enter DESTRUCTOR
[1704-8.250]QResult: exit close_result
[1704-8.250]QResult: exit DESTRUCTOR
[1704-8.250]SC_init_Result(e2dd28)[1704-8.250]PDATA_free_params:  ENTER, self=00E2DECC
[1704-8.250]**** PGAPI_ExecDirect: hstmt=00E2DD28, statement='set extra_float_digits to 2'
[1704-8.250]PGAPI_ExecDirect: calling PGAPI_Execute...
[1704-8.250]PGAPI_Execute: entering...0
[1704-8.250]PGAPI_Execute: clear errors...
[1704-8.250]PGAPI_NumParams: entering...
[1704-8.250]SC_scanQueryAndCountParams: entering...
[1704-8.250]prepareParameters 0 end
[1704-8.250]SC_recycle_statement: self= 00E2DD28
[1704-8.250]PDATA_free_params:  ENTER, self=00E2DECC
[1704-8.250]Exec_with_parameters_resolved: copying statement params: trans_status=1, len=27, stmt='set
extra_float_digitsto 2' 
[1704-8.250]   stmt_with_params = 'set extra_float_digits to 2'
[1704-8.250]about to begin SC_execute
[1704-8.250]      it's NOT a select statement: stmt=00E2DD28
[1704-8.250]CC_send_query: conn=00E23D88, query='set extra_float_digits to 2'
[1704-8.250]send_query: done sending query 33bytes flushed
[1704-8.250]in QR_Constructor
[1704-8.250]exit QR_Constructor
[1704-8.250]read 15, global_socket_buffersize=4096
[1704-8.250]send_query: got id = 'C'
[1704-8.250]send_query: ok - 'C' - SET
[1704-8.250]send_query: setting cmdbuffer = 'SET'
[1704-8.250]send_query: returning res = 00E2EF60
[1704-8.250]send_query: got id = 'Z'
[1704-8.250]SC_set_Result(e2dd28, e2ef60)[1704-8.266]QResult: enter DESTRUCTOR
[1704-8.266]retval=0
[1704-8.266]PGAPI_ExecDirect: returned 0 from PGAPI_Execute
[1704-8.266]CC_setenv: result 0, status 1 from set extra_float_digits
[1704-8.266]PGAPI_FreeStmt: entering...hstmt=00E2DD28, fOption=1
[1704-8.266]QResult: enter DESTRUCTOR
[1704-8.266]QResult: in QR_close_result
[1704-8.266]QResult: free memory in, fcount=0
[1704-8.266]QResult: free memory out
[1704-8.266]QResult: enter DESTRUCTOR
[1704-8.266]QResult: exit close_result
[1704-8.266]QResult: exit DESTRUCTOR
[1704-8.266]SC_init_Result(e2dd28)[1704-8.266]SC_Destructor: self=00E2DD28, self->result=00000000, self->hdbc=00E23D88
[1704-8.266]APD_free_params:  ENTER, self=00E2DE28
[1704-8.266]IPD_free_params:  ENTER, self=00E2DE68
[1704-8.266]PDATA_free_params:  ENTER, self=00E2DECC
[1704-8.266]SC_Destructor: EXIT
[1704-8.266]CC_send_settings: entering...
[1704-8.266]PGAPI_AllocStmt: entering...
[1704-8.266]**** PGAPI_AllocStmt: hdbc = 00E23D88, stmt = 00E2DD28
[1704-8.266]CC_add_statement: self=00E23D88, stmt=00E2DD28
[1704-8.266]PGAPI_FreeStmt: entering...hstmt=00E2DD28, fOption=1
[1704-8.266]QResult: enter DESTRUCTOR
[1704-8.266]SC_init_Result(e2dd28)[1704-8.266]SC_Destructor: self=00E2DD28, self->result=00000000, self->hdbc=00E23D88
[1704-8.266]APD_free_params:  ENTER, self=00E2DE28
[1704-8.266]IPD_free_params:  ENTER, self=00E2DE68
[1704-8.266]PDATA_free_params:  ENTER, self=00E2DECC
[1704-8.266]SC_Destructor: EXIT
[1704-8.266]CC_lookup_lo: entering...
[1704-8.266]CC_send_query: conn=00E23D88, query='select oid, typbasetype from pg_type where typname = 'lo''
[1704-8.266]send_query: done sending query 63bytes flushed
[1704-8.266]in QR_Constructor
[1704-8.266]exit QR_Constructor
[1704-8.266]read -1, global_socket_buffersize=4096
[1704-8.266]Lasterror=10035
[1704-8.266]read 77, global_socket_buffersize=4096
[1704-8.266]send_query: got id = 'T'
[1704-8.281]QR_fetch_tuples: cursor = '', self->cursor=00000000
[1704-8.281]num_fields = 2
[1704-8.281]READING ATTTYPMOD
[1704-8.281]CI_read_fields: fieldname='oid', adtid=26, adtsize=4, atttypmod=-1 (rel,att)=(1247,65534)
[1704-8.281]READING ATTTYPMOD
[1704-8.281]CI_read_fields: fieldname='typbasetype', adtid=26, adtsize=4, atttypmod=-1 (rel,att)=(1247,22)
[1704-8.281]QR_fetch_tuples: past CI_read_fields: num_fields = 2
[1704-8.281]MALLOC: tuple_size = 100, size = 1600
[1704-8.281]QR_next_tuple: inTuples = true, falling through: fcount = 0, fetch_number = 0
[1704-8.281]end of tuple list -- setting inUse to false: this = 00E2EF60 SELECT
[1704-8.281]_QR_next_tuple: 'C' fetch_total = 0 & this_fetch = 0
[1704-8.281]QR_next_tuple: backend_rows < CACHE_SIZE: brows = 0, cache_size = 0
[1704-8.281]QR_next_tuple: reached eof now
[1704-8.281]_QR_next_tuple: 'C': DONE (fcount == 0)
[1704-8.281]send_query: got id = 'Z'
[1704-8.281]QResult: enter DESTRUCTOR
[1704-8.281]QResult: in QR_close_result
[1704-8.281]QResult: free memory in, fcount=0
[1704-8.281]QResult: free memory out
[1704-8.281]QResult: enter DESTRUCTOR
[1704-8.281]QResult: exit close_result
[1704-8.281]QResult: exit DESTRUCTOR
[1704-8.281]Got the large object oid: -999
[1704-8.281]CC_lookup_characterset: entering...
[1704-8.281]CC_send_query: conn=00E23D88, query='select pg_client_encoding()'
[1704-8.281]send_query: done sending query 33bytes flushed
[1704-8.281]in QR_Constructor
[1704-8.281]exit QR_Constructor
[1704-8.281]read 77, global_socket_buffersize=4096
[1704-8.281]send_query: got id = 'T'
[1704-8.281]QR_fetch_tuples: cursor = '', self->cursor=00000000
[1704-8.281]num_fields = 1
[1704-8.281]READING ATTTYPMOD
[1704-8.281]CI_read_fields: fieldname='pg_client_encoding', adtid=19, adtsize=64, atttypmod=-1 (rel,att)=(0,0)
[1704-8.281]QR_fetch_tuples: past CI_read_fields: num_fields = 1
[1704-8.281]MALLOC: tuple_size = 100, size = 800
[1704-8.281]QR_next_tuple: inTuples = true, falling through: fcount = 0, fetch_number = 0
[1704-8.297]qresult: len=4, buffer='UTF8'
[1704-8.297]end of tuple list -- setting inUse to false: this = 00E2EF60 SELECT
[1704-8.297]_QR_next_tuple: 'C' fetch_total = 1 & this_fetch = 1
[1704-8.297]QR_next_tuple: backend_rows < CACHE_SIZE: brows = 0, cache_size = 0
[1704-8.297]QR_next_tuple: reached eof now
[1704-8.297]send_query: got id = 'Z'
[1704-8.297]QResult: enter DESTRUCTOR
[1704-8.297]QResult: in QR_close_result
[1704-8.297]QResult: free memory in, fcount=1
[1704-8.297]QResult: free memory out
[1704-8.297]QResult: enter DESTRUCTOR
[1704-8.297]QResult: exit close_result
[1704-8.297]QResult: exit DESTRUCTOR
[1704-8.297]conn->unicode=1
[1704-8.297]CC_connect: returning...1
[1704-8.297]szConnStrOut = 'DRIVER={PostgreSQL
Unicode};DATABASE=psnbookings;SERVER=mail2.postnewspapers.com.au;PORT=5432;UID=greg;PWD=;SSLmode=require;ReadOnly=0;Protocol=7.4-1;FakeOidIndex=0;ShowOidColumn=0;RowVersioning=1;ShowSystemTables=0;ConnSettings=;Fetch=100;Socket=4096;UnknownSizes=0;MaxVarcharSize=255;MaxLongVarcharSize=8190;Debug=1;CommLog=1;Optimizer=0;Ksqo=1;UseDeclareFetch=0;TextAsLongVarchar=1;UnknownsAsLongVarchar=0;BoolsAsChar=0;Parse=0;CancelAsFreeStmt=0;ExtraSysTablePrefixes=dd_;LFConversion=1;UpdatableCursors=0;DisallowPremature=0;TrueIsMinus1=1;BI=0;ByteaAsLongVarBinary=0;UseServerSidePrepare=0;LowerCaseIdentifier=0;XaOpt=1'
len=625,16383
[1704-8.297]PGAPI_DriverConnect: returning 0
[1704-8.297][SQLGetDiagRecW][1704-8.297]PGAPI_GetDiagRec entering type=2 rec=1
[1704-8.297]**** PGAPI_ConnectError: hdbc=00E23D88 <0>
[1704-8.297]enter CC_get_error
[1704-8.297]enter CC_create_errormsg
[1704-8.297]msg = ''
[1704-8.297]exit CC_create_errormsg
[1704-8.297]exit CC_get_error
[1704-8.297]CC_Get_error returned nothing.
[1704-8.297]PGAPI_GetDiagRec exiting 100
[1704-8.297][SQLGetFunctions][1704-8.297][SQLGetInfoW(30)][1704-8.297]PGAPI_GetInfo: entering...fInfoType=23
[1704-8.297]PGAPI_GetInfo: p='<NULL>', len=2, value=2, cbMax=2
[1704-8.297][SQLGetInfoW(30)][1704-8.297]PGAPI_GetInfo: entering...fInfoType=24
[1704-8.313]PGAPI_GetInfo: p='<NULL>', len=2, value=2, cbMax=2
[1704-8.313][SQLDisconnect for 00E23D88][1704-8.313]PGAPI_Disconnect: entering...
[1704-0.000]calling getDSNdefaults
[1704-0.000]dconn_DoDialog: ci = 010D3E08
[1704-0.000]checking libpq library
[1704-0.015]psqlodbc path based libpq loaded module=012A0000
[1704-0.015]libpq hmodule=012A0000
[1704-0.015]libpq_exist=1
[1704-10.312]CC_connect: entering...
[1704-10.312]sslmode=require
[1704-10.312]LIBPQ_CC_connect: entering...
[1704-10.312]Driver Version='08.03.0300,200809260001' linking 1400 static Multithread library
[1704-10.344]LIBPQ_CC_connect: DSN = '', server = 'mail2.postnewspapers.com.au', port = '5432', database =
'psnbookings',username = 'greg', password='xxxxx' 
[1704-10.344]connecting to the database  using mail2.postnewspapers.com.au as the server
[1704-10.344]sizeof connectdb option = 99
[1704-10.344]DliNotifyHook Notify=0 0007B3B4
[1704-10.344]DliNotifyHook Notify=1 0007B3B4
[1704-10.390]psqlodbc path based libpq loaded module=012A0000
[1704-10.469]libpq connection to the database succeeded.
[1704-10.469]procotol=7.4
[1704-10.469]Server version=8.3.3
[1704-10.469]LIBPQ_connect: retuning 1
[1704-10.469]CC_setenv: entering...
[1704-10.469]PGAPI_AllocStmt: entering...
[1704-10.469]**** PGAPI_AllocStmt: hdbc = 010D3D88, stmt = 010DDD28
[1704-10.469]CC_add_statement: self=010D3D88, stmt=010DDD28
[1704-10.469]PGAPI_ExecDirect: entering...0
[1704-10.469]SC_recycle_statement: self= 010DDD28
[1704-10.469]**** PGAPI_ExecDirect: hstmt=010DDD28, statement='set DateStyle to 'ISO''
[1704-10.469]PGAPI_ExecDirect: calling PGAPI_Execute...
[1704-10.469]PGAPI_Execute: entering...0
[1704-10.469]PGAPI_Execute: clear errors...
[1704-10.484]PGAPI_NumParams: entering...
[1704-10.484]SC_scanQueryAndCountParams: entering...
[1704-10.484]prepareParameters 0 end
[1704-10.484]SC_recycle_statement: self= 010DDD28
[1704-10.484]Exec_with_parameters_resolved: copying statement params: trans_status=1, len=22, stmt='set DateStyle to
'ISO''
[1704-10.484]   stmt_with_params = 'set DateStyle to 'ISO''
[1704-10.484]about to begin SC_execute
[1704-10.484]      it's NOT a select statement: stmt=010DDD28
[1704-10.484]CC_send_query: conn=010D3D88, query='set DateStyle to 'ISO''
[1704-10.500]send_query: done sending query 28bytes flushed
[1704-10.500]in QR_Constructor
[1704-10.500]exit QR_Constructor
[1704-10.500]read 39, global_socket_buffersize=4096
[1704-10.500]send_query: got id = 'S'
[1704-10.500]send_query: got id = 'C'
[1704-10.500]send_query: ok - 'C' - SET
[1704-10.500]send_query: setting cmdbuffer = 'SET'
[1704-10.500]send_query: returning res = 010DEF78
[1704-10.500]send_query: got id = 'Z'
[1704-10.500]SC_set_Result(10ddd28, 10def78)[1704-10.500]QResult: enter DESTRUCTOR
[1704-10.500]retval=0
[1704-10.500]PGAPI_ExecDirect: returned 0 from PGAPI_Execute
[1704-10.500]CC_setenv: result 0, status 1 from set DateStyle
[1704-10.515]PGAPI_ExecDirect: entering...0
[1704-10.515]SC_recycle_statement: self= 010DDD28
[1704-10.515]QResult: enter DESTRUCTOR
[1704-10.515]QResult: in QR_close_result
[1704-10.515]QResult: free memory in, fcount=0
[1704-10.515]QResult: free memory out
[1704-10.515]QResult: enter DESTRUCTOR
[1704-10.515]QResult: exit close_result
[1704-10.515]QResult: exit DESTRUCTOR
[1704-10.515]SC_init_Result(10ddd28)[1704-10.515]PDATA_free_params:  ENTER, self=010DDECC
[1704-10.515]**** PGAPI_ExecDirect: hstmt=010DDD28, statement='set extra_float_digits to 2'
[1704-10.515]PGAPI_ExecDirect: calling PGAPI_Execute...
[1704-10.531]PGAPI_Execute: entering...0
[1704-10.531]PGAPI_Execute: clear errors...
[1704-10.531]PGAPI_NumParams: entering...
[1704-10.531]SC_scanQueryAndCountParams: entering...
[1704-10.531]prepareParameters 0 end
[1704-10.547]SC_recycle_statement: self= 010DDD28
[1704-10.547]PDATA_free_params:  ENTER, self=010DDECC
[1704-10.547]Exec_with_parameters_resolved: copying statement params: trans_status=1, len=27, stmt='set
extra_float_digitsto 2' 
[1704-10.547]   stmt_with_params = 'set extra_float_digits to 2'
[1704-10.547]about to begin SC_execute
[1704-10.547]      it's NOT a select statement: stmt=010DDD28
[1704-10.562]CC_send_query: conn=010D3D88, query='set extra_float_digits to 2'
[1704-10.562]send_query: done sending query 33bytes flushed
[1704-10.562]in QR_Constructor
[1704-10.562]exit QR_Constructor
[1704-10.562]read 15, global_socket_buffersize=4096
[1704-10.562]send_query: got id = 'C'
[1704-10.562]send_query: ok - 'C' - SET
[1704-10.562]send_query: setting cmdbuffer = 'SET'
[1704-10.562]send_query: returning res = 010DEF78
[1704-10.562]send_query: got id = 'Z'
[1704-10.562]SC_set_Result(10ddd28, 10def78)[1704-10.578]QResult: enter DESTRUCTOR
[1704-10.578]retval=0
[1704-10.578]PGAPI_ExecDirect: returned 0 from PGAPI_Execute
[1704-10.578]CC_setenv: result 0, status 1 from set extra_float_digits
[1704-10.578]PGAPI_FreeStmt: entering...hstmt=010DDD28, fOption=1
[1704-10.578]QResult: enter DESTRUCTOR
[1704-10.578]QResult: in QR_close_result
[1704-10.578]QResult: free memory in, fcount=0
[1704-10.578]QResult: free memory out
[1704-10.578]QResult: enter DESTRUCTOR
[1704-10.578]QResult: exit close_result
[1704-10.578]QResult: exit DESTRUCTOR
[1704-10.578]SC_init_Result(10ddd28)[1704-10.578]SC_Destructor: self=010DDD28, self->result=00000000,
self->hdbc=010D3D88
[1704-10.594]APD_free_params:  ENTER, self=010DDE28
[1704-10.594]IPD_free_params:  ENTER, self=010DDE68
[1704-10.594]PDATA_free_params:  ENTER, self=010DDECC
[1704-10.594]SC_Destructor: EXIT
[1704-10.594]CC_send_settings: entering...
[1704-10.594]PGAPI_AllocStmt: entering...
[1704-10.594]**** PGAPI_AllocStmt: hdbc = 010D3D88, stmt = 010DDD28
[1704-10.594]CC_add_statement: self=010D3D88, stmt=010DDD28
[1704-10.594]PGAPI_FreeStmt: entering...hstmt=010DDD28, fOption=1
[1704-10.594]QResult: enter DESTRUCTOR
[1704-10.594]SC_init_Result(10ddd28)[1704-10.594]SC_Destructor: self=010DDD28, self->result=00000000,
self->hdbc=010D3D88
[1704-10.594]APD_free_params:  ENTER, self=010DDE28
[1704-10.609]IPD_free_params:  ENTER, self=010DDE68
[1704-10.609]PDATA_free_params:  ENTER, self=010DDECC
[1704-10.609]SC_Destructor: EXIT
[1704-10.609]CC_lookup_lo: entering...
[1704-10.609]CC_send_query: conn=010D3D88, query='select oid, typbasetype from pg_type where typname = 'lo''
[1704-10.609]send_query: done sending query 63bytes flushed
[1704-10.609]in QR_Constructor
[1704-10.609]exit QR_Constructor
[1704-10.609]read 77, global_socket_buffersize=4096
[1704-10.625]send_query: got id = 'T'
[1704-10.625]QR_fetch_tuples: cursor = '', self->cursor=00000000
[1704-10.625]num_fields = 2
[1704-10.625]READING ATTTYPMOD
[1704-10.625]CI_read_fields: fieldname='oid', adtid=26, adtsize=4, atttypmod=-1 (rel,att)=(1247,65534)
[1704-10.625]READING ATTTYPMOD
[1704-10.625]CI_read_fields: fieldname='typbasetype', adtid=26, adtsize=4, atttypmod=-1 (rel,att)=(1247,22)
[1704-10.625]QR_fetch_tuples: past CI_read_fields: num_fields = 2
[1704-10.625]MALLOC: tuple_size = 100, size = 1600
[1704-10.625]QR_next_tuple: inTuples = true, falling through: fcount = 0, fetch_number = 0
[1704-10.625]end of tuple list -- setting inUse to false: this = 010DEF78 SELECT
[1704-10.640]_QR_next_tuple: 'C' fetch_total = 0 & this_fetch = 0
[1704-10.640]QR_next_tuple: backend_rows < CACHE_SIZE: brows = 0, cache_size = 0
[1704-10.640]QR_next_tuple: reached eof now
[1704-10.640]_QR_next_tuple: 'C': DONE (fcount == 0)
[1704-10.640]send_query: got id = 'Z'
[1704-10.640]QResult: enter DESTRUCTOR
[1704-10.640]QResult: in QR_close_result
[1704-10.640]QResult: free memory in, fcount=0
[1704-10.640]QResult: free memory out
[1704-10.640]QResult: enter DESTRUCTOR
[1704-10.640]QResult: exit close_result
[1704-10.640]QResult: exit DESTRUCTOR
[1704-10.640]Got the large object oid: -999
[1704-10.640]CC_lookup_characterset: entering...
[1704-10.640]CC_send_query: conn=010D3D88, query='select pg_client_encoding()'
[1704-10.640]send_query: done sending query 33bytes flushed
[1704-10.640]in QR_Constructor
[1704-10.640]exit QR_Constructor
[1704-10.640]read 77, global_socket_buffersize=4096
[1704-10.640]send_query: got id = 'T'
[1704-10.640]QR_fetch_tuples: cursor = '', self->cursor=00000000
[1704-10.640]num_fields = 1
[1704-10.640]READING ATTTYPMOD
[1704-10.640]CI_read_fields: fieldname='pg_client_encoding', adtid=19, adtsize=64, atttypmod=-1 (rel,att)=(0,0)
[1704-10.640]QR_fetch_tuples: past CI_read_fields: num_fields = 1
[1704-10.640]MALLOC: tuple_size = 100, size = 800
[1704-10.640]QR_next_tuple: inTuples = true, falling through: fcount = 0, fetch_number = 0
[1704-10.640]qresult: len=4, buffer='UTF8'
[1704-10.656]end of tuple list -- setting inUse to false: this = 010DEF78 SELECT
[1704-10.656]_QR_next_tuple: 'C' fetch_total = 1 & this_fetch = 1
[1704-10.656]QR_next_tuple: backend_rows < CACHE_SIZE: brows = 0, cache_size = 0
[1704-10.656]QR_next_tuple: reached eof now
[1704-10.656]send_query: got id = 'Z'
[1704-10.656]QResult: enter DESTRUCTOR
[1704-10.656]QResult: in QR_close_result
[1704-10.656]QResult: free memory in, fcount=1
[1704-10.656]QResult: free memory out
[1704-10.656]QResult: enter DESTRUCTOR
[1704-10.656]QResult: exit close_result
[1704-10.656]QResult: exit DESTRUCTOR
[1704-10.656]conn->unicode=1
[1704-10.656]CC_connect: returning...1
[1704-10.656]szConnStrOut = 'DRIVER={PostgreSQL
Unicode};DATABASE=psnbookings;SERVER=mail2.postnewspapers.com.au;PORT=5432;UID=greg;PWD=;SSLmode=require;ReadOnly=0;Protocol=7.4-1;FakeOidIndex=0;ShowOidColumn=0;RowVersioning=1;ShowSystemTables=0;ConnSettings=;Fetch=100;Socket=4096;UnknownSizes=0;MaxVarcharSize=255;MaxLongVarcharSize=8190;Debug=1;CommLog=0;Optimizer=0;Ksqo=1;UseDeclareFetch=0;TextAsLongVarchar=1;UnknownsAsLongVarchar=0;BoolsAsChar=0;Parse=0;CancelAsFreeStmt=0;ExtraSysTablePrefixes=dd_;LFConversion=1;UpdatableCursors=0;DisallowPremature=0;TrueIsMinus1=1;BI=0;ByteaAsLongVarBinary=0;UseServerSidePrepare=0;LowerCaseIdentifier=0;XaOpt=1'
len=625,16383
[1704-10.672]PGAPI_DriverConnect: returning 0
[1704-10.672][SQLGetDiagRecW][1704-10.672]PGAPI_GetDiagRec entering type=2 rec=1
[1704-10.672]**** PGAPI_ConnectError: hdbc=010D3D88 <0>
[1704-10.672]enter CC_get_error
[1704-10.672]enter CC_create_errormsg
[1704-10.672]msg = ''
[1704-10.672]exit CC_create_errormsg
[1704-10.672]exit CC_get_error
[1704-10.672]CC_Get_error returned nothing.
[1704-10.672]PGAPI_GetDiagRec exiting 100
[1704-10.672][SQLGetFunctions][1704-10.672][SQLGetInfoW(30)][1704-10.672]PGAPI_GetInfo: entering...fInfoType=23
[1704-10.672]PGAPI_GetInfo: p='<NULL>', len=2, value=2, cbMax=2
[1704-10.672][SQLGetInfoW(30)][1704-10.672]PGAPI_GetInfo: entering...fInfoType=24
[1704-10.672]PGAPI_GetInfo: p='<NULL>', len=2, value=2, cbMax=2
[1704-10.687][SQLDisconnect for 010D3D88][1704-10.687]PGAPI_Disconnect: entering...

Craig Ringer wrote:
> Hiroshi Inoue wrote:

>> Could you send me directly the Mylog output ?

Whoops. Sorry, list, that was ... silly.

--
Craig Ringer