From: | "perry(at)processlinx(dot)com" <perry(at)processlinx(dot)com> |
---|---|
To: | pgsql-odbc(at)postgresql(dot)org |
Subject: | Abort! |
Date: | 2014-09-08 17:39:11 |
Message-ID: | 540DE9BF.3030705@processlinx.com |
Views: | Raw Message | Whole Thread | Download mbox | Resend email |
Thread: | |
Lists: | 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
From | Date | Subject | |
---|---|---|---|
Next Message | Inoue, Hiroshi | 2014-09-08 23:54:58 | Re: FW: [GENERAL] Re: [ADMIN] Cannot retrieve images inserted through VB and odbc, after a table reorganization. |
Previous Message | Alanoly Andrews | 2014-09-08 14:03:03 | FW: [GENERAL] Re: [ADMIN] Cannot retrieve images inserted through VB and odbc, after a table reorganization. |