Abort! - Mailing list pgsql-odbc

From perry@processlinx.com
Subject Abort!
Date
Msg-id 540DE9BF.3030705@processlinx.com
Whole thread Raw
Responses Re: Abort!  ("Inoue, Hiroshi" <inoue@tpf.co.jp>)
List pgsql-odbc
Hello,

From time to time we get an abort message in th psqlodbc logs. We see no errors or warnings on the freebsd postgresql log. In the 'my' log below (highlighted in bold we see an Abort). I have also attached the corresponding psqlodbc log as it relates to the Abort in mylog.

Can you point me in the right direction here in order to determine the cause of this infrequent abort.

Setup configuration:

Windows 7 we have installed psqlodbc Driver Version 9.02.01.00 Unicode
Windows 7 client connects to a postgres sql server on freebsd 10.0 Postgresql 9.0.15


psqlodbc log
[184246.093]conn=04657F38, query='insert into "public"."raw_trans" ("_name", "_numericid", "_value", "_timestamp", "_quality") values (E'OMRONS.LINE34.TEMP_Z1_ACT', 0, E'100', '2014-09-03 18:38:47.054'::timestamp, 192) returning ctid'
[184246.156]    [ fetched 1 rows ]
[184246.156]conn=04657F38, query='SELECT * , "ctid", "id" FROM raw_trans where ctid = '(4705,80)' '
[184246.171]    [ fetched 1 rows ]
[184246.171]QR_REALLOC_error
[184246.171]conn=04657F38, query='ROLLBACK'
[184246.171]conn=04657F38, query='close "SQL_CUR04691F10"'


mylog log
[3284-184246.156]read 83, global_socket_buffersize=4096
[3284-184246.156]send_query: got id = 'C'
[3284-184246.156]send_query: ok - 'C' - BEGIN
[3284-184246.156]send_query: setting cmdbuffer = 'BEGIN'
[3284-184246.156]send_query: got id = 'T'
[3284-184246.156]QR_fetch_tuples: cursor = '', self->cursor=00000000
[3284-184246.156]num_fields = 1
[3284-184246.156]READING ATTTYPMOD
[3284-184246.156]CI_read_fields: fieldname='ctid', adtid=27, adtsize=6, atttypmod=-1 (rel,att)=(57800,65535)
[3284-184246.156]QR_fetch_tuples: past CI_read_fields: num_fields = 1
[3284-184246.156]MALLOC: tuple_size = 100, size = 800
[3284-184246.156]QR_next_tuple: inTuples = true, falling through: fcount = 0, fetch_number = 0
[3284-184246.156]qresult: len=9, buffer='(4705,80)'
[3284-184246.156]end of tuple list -- setting inUse to false: this = 046E9008 INSERT 0 1
[3284-184246.156]_QR_next_tuple: 'C' fetch_total = 1 & this_fetch = 1
[3284-184246.156]QR_next_tuple: backend_rows < CACHE_SIZE: brows = 0, cache_size = 0
[3284-184246.156]QR_next_tuple: reached eof now
[3284-184246.156]send_query: got id = 'Z'
[3284-184246.156]extend_column_bindings: entering ... self=050C29C8, bindings_allocated=0, num_columns=1
[3284-184246.156]exit extend_column_bindings=05455E50
[3284-184246.156]SC_set_Result(50c2940, 46e9008)[3284-184246.156]QResult: enter DESTRUCTOR
[3284-184246.156]retval=0
[3284-184246.156]PGAPI_ExecDirect: returned 0 from PGAPI_Execute
[3284-184246.156]pos_add_callback in ret=0
[3284-184246.156]positioned new ti=04691868
[3284-184246.156]selstr=SELECT * , "ctid", "id" FROM raw_trans where ctid = '(4705,80)'
[3284-184246.156]CC_send_query: conn=04657F38, query='SELECT * , "ctid", "id" FROM raw_trans where ctid = '(4705,80)' '
[3284-184246.156]send_query: done sending query 70bytes flushed
[3284-184246.156]in QR_Constructor
[3284-184246.156]exit QR_Constructor
[3284-184246.156]read 893, global_socket_buffersize=4096
[3284-184246.156]send_query: got id = 'T'
[3284-184246.156]QR_fetch_tuples: cursor = '', self->cursor=00000000
[3284-184246.156]num_fields = 23
[3284-184246.156]READING ATTTYPMOD
[3284-184246.156]CI_read_fields: fieldname='id', adtid=23, adtsize=4, atttypmod=-1 (rel,att)=(57800,1)
[3284-184246.156]READING ATTTYPMOD
[3284-184246.156]CI_read_fields: fieldname='_name', adtid=1043, adtsize=-1, atttypmod=64 (rel,att)=(57800,2)
[3284-184246.156]READING ATTTYPMOD
[3284-184246.156]CI_read_fields: fieldname='_numericid', adtid=23, adtsize=4, atttypmod=-1 (rel,att)=(57800,3)
[3284-184246.156]READING ATTTYPMOD
[3284-184246.156]CI_read_fields: fieldname='_value', adtid=1043, adtsize=-1, atttypmod=64 (rel,att)=(57800,4)
[3284-184246.156]READING ATTTYPMOD
[3284-184246.156]CI_read_fields: fieldname='_timestamp', adtid=1184, adtsize=8, atttypmod=-1 (rel,att)=(57800,5)
[3284-184246.156]READING ATTTYPMOD
[3284-184246.156]CI_read_fields: fieldname='_quality', adtid=23, adtsize=4, atttypmod=-1 (rel,att)=(57800,6)
[3284-184246.156]READING ATTTYPMOD
[3284-184246.156]CI_read_fields: fieldname='current_flag', adtid=16, adtsize=1, atttypmod=-1 (rel,att)=(57800,7)
[3284-184246.156]READING ATTTYPMOD
[3284-184246.156]CI_read_fields: fieldname='wc_id', adtid=23, adtsize=4, atttypmod=-1 (rel,att)=(57800,8)
[3284-184246.156]READING ATTTYPMOD
[3284-184246.156]CI_read_fields: fieldname='d_id', adtid=23, adtsize=4, atttypmod=-1 (rel,att)=(57800,9)
[3284-184246.156]READING ATTTYPMOD
[3284-184246.156]CI_read_fields: fieldname='s_id', adtid=23, adtsize=4, atttypmod=-1 (rel,att)=(57800,10)
[3284-184246.156]READING ATTTYPMOD
[3284-184246.156]CI_read_fields: fieldname='end_timestamp', adtid=1184, adtsize=8, atttypmod=-1 (rel,att)=(57800,11)
[3284-184246.156]READING ATTTYPMOD
[3284-184246.156]CI_read_fields: fieldname='shift_no', adtid=23, adtsize=4, atttypmod=-1 (rel,att)=(57800,12)
[3284-184246.156]READING ATTTYPMOD
[3284-184246.156]CI_read_fields: fieldname='bus_date', adtid=1082, adtsize=4, atttypmod=-1 (rel,att)=(57800,13)
[3284-184246.156]READING ATTTYPMOD
[3284-184246.156]CI_read_fields: fieldname='occurredon', adtid=1184, adtsize=8, atttypmod=-1 (rel,att)=(57800,14)
[3284-184246.156]READING ATTTYPMOD
[3284-184246.156]CI_read_fields: fieldname='production_piece', adtid=16, adtsize=1, atttypmod=-1 (rel,att)=(57800,15)
[3284-184246.156]READING ATTTYPMOD
[3284-184246.156]CI_read_fields: fieldname='work_order_id', adtid=23, adtsize=4, atttypmod=-1 (rel,att)=(57800,16)
[3284-184246.156]READING ATTTYPMOD
[3284-184246.156]CI_read_fields: fieldname='piece_length', adtid=1700, adtsize=-1, atttypmod=1179653 (rel,att)=(57800,17)
[3284-184246.171]READING ATTTYPMOD
[3284-184246.171]CI_read_fields: fieldname='elapsed_seconds', adtid=1700, adtsize=-1, atttypmod=1179653 (rel,att)=(57800,18)
[3284-184246.171]READING ATTTYPMOD
[3284-184246.171]CI_read_fields: fieldname='avg_ipm', adtid=1700, adtsize=-1, atttypmod=1179653 (rel,att)=(57800,19)
[3284-184246.171]READING ATTTYPMOD
[3284-184246.171]CI_read_fields: fieldname='ipm', adtid=1700, adtsize=-1, atttypmod=1179653 (rel,att)=(57800,20)
[3284-184246.171]READING ATTTYPMOD
[3284-184246.171]CI_read_fields: fieldname='added_piece_length', adtid=1700, adtsize=-1, atttypmod=262146 (rel,att)=(57800,21)
[3284-184246.171]READING ATTTYPMOD
[3284-184246.171]CI_read_fields: fieldname='ctid', adtid=27, adtsize=6, atttypmod=-1 (rel,att)=(57800,65535)
[3284-184246.171]READING ATTTYPMOD
[3284-184246.171]CI_read_fields: fieldname='id', adtid=23, adtsize=4, atttypmod=-1 (rel,att)=(57800,1)
[3284-184246.171]QR_fetch_tuples: past CI_read_fields: num_fields = 23
[3284-184246.171]MALLOC: tuple_size = 100, size = 18400
[3284-184246.171]QR_next_tuple: inTuples = true, falling through: fcount = 0, fetch_number = 0
[3284-184246.171]qresult: len=7, buffer='6394774'
[3284-184246.171]qresult: len=25, buffer='OMRONS.LINE34.TEMP_Z1_ACT'
[3284-184246.171]qresult: len=1, buffer='0'
[3284-184246.171]qresult: len=3, buffer='100'
[3284-184246.171]qresult: len=26, buffer='2014-09-03 18:38:47.054+00'
[3284-184246.171]qresult: len=3, buffer='192'
[3284-184246.171]qresult: len=1, buffer='t'
[3284-184246.171]qresult: len=1, buffer='6'
[3284-184246.171]qresult: len=1, buffer='5'
[3284-184246.171]qresult: len=2, buffer='68'
[3284-184246.171]qresult: len=1, buffer='1'
[3284-184246.171]qresult: len=10, buffer='2014-09-03'
[3284-184246.171]qresult: len=28, buffer='2014-09-03 18:38:48.21401+00'
[3284-184246.171]qresult: len=1, buffer='f'
[3284-184246.171]qresult: len=5, buffer='51107'
[3284-184246.171]qresult: len=4, buffer='0.00'
[3284-184246.171]qresult: len=9, buffer='(4705,80)'
[3284-184246.171]qresult: len=7, buffer='6394774'
[3284-184246.171]end of tuple list -- setting inUse to false: this = 046E90C0 SELECT 1
[3284-184246.171]_QR_next_tuple: 'C' fetch_total = 1 & this_fetch = 1
[3284-184246.171]QR_next_tuple: backend_rows < CACHE_SIZE: brows = 0, cache_size = 0
[3284-184246.171]QR_next_tuple: reached eof now
[3284-184246.171]send_query: got id = 'Z'
[3284-184246.171]QResult: free memory in, fcount=160
[3284-184246.171][[SQLEndTran]][3284-184246.171]entering PGAPI_Transact: hdbc=04657F38, henv=00000000
[3284-184246.171]PGAPI_Transact: sending on conn 04657F38 '1'
[3284-184246.171]CC_send_query: conn=04657F38, query='ROLLBACK'
[3284-184246.171]send_query: done sending query 14bytes flushed
[3284-184246.171]in QR_Constructor
[3284-184246.171]exit QR_Constructor
[3284-184246.171]read 20, global_socket_buffersize=4096
[3284-184246.171]send_query: got id = 'C'
[3284-184246.171]send_query: ok - 'C' - ROLLBACK
[3284-184246.171]send_query: setting cmdbuffer = 'ROLLBACK'
[3284-184246.171]send_query: returning res = 046E92E8
[3284-184246.171]send_query: got id = 'Z'
[3284-184246.171]CC_on_abort in
[3284-184246.171]CC_abort:  sending ABORT!
[3284-184246.171]QResult: enter DESTRUCTOR
[3284-184246.171]QResult: in QR_close_result
[3284-184246.171]QResult: free memory in, fcount=0
[3284-184246.171]QResult: free memory out
[3284-184246.171]QResult: exit close_result
[3284-184246.171]QResult: exit DESTRUCTOR
[3284-184246.171][SQLSetConnectAttrW][3284-184246.171]PGAPI_SetConnectAttr for 04657F38: 102 00000001
[3284-184246.171]PGAPI_SetConnectOption: entering fOption = 102 vParam = 1
[3284-184246.171]PGAPI_SetConnectOption: AUTOCOMMIT: transact_status=0, vparam=1
[3284-184246.171]CC_set_autocommit: 0->1
[3284-184246.171][[SQLFreeHandle]][3284-184246.171]PGAPI_FreeStmt: entering...hstmt=04691F10, fOption=1
[3284-184246.171]QResult: enter DESTRUCTOR
[3284-184246.171]QResult: in QR_close_result
[3284-184246.171]CC_send_query: conn=04657F38, query='close "SQL_CUR04691F10"'
[3284-184246.171]send_query: done sending query 29bytes flushed
[3284-184246.171]in QR_Constructor
[3284-184246.171]exit QR_Constructor
[3284-184246.171]read -1, global_socket_buffersize=4096
[3284-184246.171]Lasterror=10035

pgsql-odbc by date:

Previous
From: Alanoly Andrews
Date:
Subject: FW: [GENERAL] Re: [ADMIN] Cannot retrieve images inserted through VB and odbc, after a table reorganization.
Next
From: "Inoue, Hiroshi"
Date:
Subject: Re: FW: [GENERAL] Re: [ADMIN] Cannot retrieve images inserted through VB and odbc, after a table reorganization.