public inbox for [email protected]help / color / mirror / Atom feed
Re: prepared statement "cu1" already exists (but it does not) 3+ messages / 2 participants [nested] [flat]
* Re: prepared statement "cu1" already exists (but it does not) @ 2024-04-08 16:25 Sebastien Flaesch <[email protected]> 2024-04-08 17:36 ` Re: prepared statement "cu1" already exists (but it does not) Tom Lane <[email protected]> 0 siblings, 1 reply; 3+ messages in thread From: Sebastien Flaesch @ 2024-04-08 16:25 UTC (permalink / raw) To: pgsql-general <[email protected]> Here a first PQtrace() file... assuming it can help. Seb ________________________________ From: Sebastien Flaesch <[email protected]> Sent: Monday, April 8, 2024 5:31 PM To: pgsql-general <[email protected]> Cc: Sebastien Flaesch <[email protected]> Subject: prepared statement "cu1" already exists (but it does not) Hello, In a specific case, I get the error prepared statement "cu1" already exists I understand when this can happen, but in fact I do de-allocate prepared statements when I should. I am investigating on this for several hours now, I thought I could share my problem to see if this ring a bell. I am using PostgreSQL 16.2 or 15.1 (I can try older versions if needed) Platform is Debian 11 I am using the libpq C API to execute SQL statements, mixing: * PQprepare * PQexecPrepared * PQexecParams * PQexec When a prepared statement handle is no longer needed, I do execute deallocate cu1 (seems there is no C API to de-allocate a prepared statement, right?) For result sets (SELECT), I do PQprepare / PQexecPrepared of "server cursors" with: declare cu1 cursor for ... When a server cursor is no longer needed, I do PQexec(conn, "close curs-name') The problem occurs when doing a first transaction, where an INSERT fails because of a table UNIQUE constraint. After the rollback, I restart a new TX with begin, several PQexec() of SELECT and UPDATE succeed, but on a subsequent PQprepare/PQexecPrepared using a "declare cu1 cursor for select ...", I the error "cu1 statement already exists"... and I don't see how cu1 can exist. Before doing the rollback, I try to deallocate the prepared statement with deallocate cu1, but this fails with error: current transaction is aborted, commands ignored until end of transaction block I understand that the whole TX is aborted with PostgreSQL, and probably the deallocate is useless since stmt was prepared inside the TX? I just want to make sure that doing a deallocate in this context does not confuse PostgreSQL. I have tried to skip the deallocate in case of SQL error, but on the subsequent PQprepare/PQexecPrepared, I still get the error that the cu1 statement already exists. Is it an issue if I use the same name for a prepared statement and the server cursor? I mean: PQprepare(pgConn, "cu1", "declare cu1 cursor for ... ", ... ) PQexecPrepared(pgConn, "cu1", ... ) My understanding is that a prepared stmt and server cursor are 2 distinct objects. Anyway: I tried to use distinct names but that did not help. Note that when the INSERT succeeds, I do not get the error prepared statement "cu1" already exists Any suggestion is welcome! Seb 2024-04-08 18:23:11.280594 F 33 Query "set intervalstyle='iso_8601'" 2024-04-08 18:23:11.280740 B 8 CommandComplete "SET" 2024-04-08 18:23:11.280743 B 27 ParameterStatus "IntervalStyle" "iso_8601" 2024-04-08 18:23:11.280745 B 5 ReadyForQuery I 2024-04-08 18:23:11.280781 F 67 Query "update pg_settings set setting=10000 where name='lock_timeout'" 2024-04-08 18:23:11.281610 B 35 RowDescription 1 "set_config" 0 0 25 65535 -1 0 2024-04-08 18:23:11.281620 B 13 DataRow 1 3 '10s' 2024-04-08 18:23:11.281622 B 13 CommandComplete "UPDATE 0" 2024-04-08 18:23:11.281623 B 5 ReadyForQuery I 2024-04-08 18:23:11.281698 F 10 Query "begin" 2024-04-08 18:23:11.281720 B 10 CommandComplete "BEGIN" 2024-04-08 18:23:11.281722 B 5 ReadyForQuery T 2024-04-08 18:23:11.281854 F 250 Parse "cu0" "declare srv_cu0 cursor for select udsi_table_name, udsi_last_mtime, udsi_temp_mtime, udsi_can_insert, udsi_can_update, udsi_can_delete, udsi_where_part, udsi_position from dbsync_udsinfo where udsi_user_id = $1 order by udsi_position" 1 1043 2024-04-08 18:23:11.281855 F 4 Sync 2024-04-08 18:23:11.282200 B 4 ParseComplete 2024-04-08 18:23:11.282206 B 5 ReadyForQuery T 2024-04-08 18:23:11.282210 F 27 Bind "" "cu0" 1 0 1 4 'mike' 1 0 2024-04-08 18:23:11.282211 F 6 Describe P "" 2024-04-08 18:23:11.282213 F 9 Execute "" 0 2024-04-08 18:23:11.282214 F 4 Sync 2024-04-08 18:23:11.282512 B 4 BindComplete 2024-04-08 18:23:11.282517 B 4 NoData 2024-04-08 18:23:11.282519 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 18:23:11.282520 B 5 ReadyForQuery T 2024-04-08 18:23:11.282523 F 34 Query "fetch absolute 0 from srv_cu0" 2024-04-08 18:23:11.282600 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 18:23:11.282604 B 12 CommandComplete "FETCH 0" 2024-04-08 18:23:11.282605 B 5 ReadyForQuery T 2024-04-08 18:23:11.282649 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 18:23:11.282741 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 18:23:11.282745 B 71 DataRow 8 6 'author' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '1' 2024-04-08 18:23:11.282747 B 69 DataRow 8 4 'book' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '2' 2024-04-08 18:23:11.282748 B 12 CommandComplete "FETCH 2" 2024-04-08 18:23:11.282749 B 5 ReadyForQuery T 2024-04-08 18:23:11.282850 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 18:23:11.282919 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 18:23:11.282922 B 12 CommandComplete "FETCH 0" 2024-04-08 18:23:11.282923 B 5 ReadyForQuery T 2024-04-08 18:23:11.282974 F 18 Query "close srv_cu0" 2024-04-08 18:23:11.283040 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 18:23:11.283042 B 5 ReadyForQuery T 2024-04-08 18:23:11.283109 F 104 Parse "" "update dbsync_udsinfo SET udsi_user_id = udsi_user_id WHERE udsi_table_name IN ('author','book')" 0 2024-04-08 18:23:11.283110 F 14 Bind "" "" 0 0 1 0 2024-04-08 18:23:11.283111 F 6 Describe P "" 2024-04-08 18:23:11.283112 F 9 Execute "" 0 2024-04-08 18:23:11.283113 F 4 Sync 2024-04-08 18:23:11.283325 B 4 ParseComplete 2024-04-08 18:23:11.283326 B 4 BindComplete 2024-04-08 18:23:11.283327 B 4 NoData 2024-04-08 18:23:11.283328 B 13 CommandComplete "UPDATE 4" 2024-04-08 18:23:11.283329 B 5 ReadyForQuery T 2024-04-08 18:23:11.283383 F 137 Parse "" "select udsi_last_mtime from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2 AND udsi_temp_mtime IS NULL" 2 1043 1043 2024-04-08 18:23:11.283385 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 18:23:11.283386 F 6 Describe P "" 2024-04-08 18:23:11.283387 F 9 Execute "" 0 2024-04-08 18:23:11.283388 F 4 Sync 2024-04-08 18:23:11.283454 B 4 ParseComplete 2024-04-08 18:23:11.283456 B 4 BindComplete 2024-04-08 18:23:11.283457 B 40 RowDescription 1 "udsi_last_mtime" 25071 8 1114 8 3 0 2024-04-08 18:23:11.283459 B 33 DataRow 1 23 '2024-04-08 12:59:40.765' 2024-04-08 18:23:11.283460 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.283461 B 5 ReadyForQuery T 2024-04-08 18:23:11.283520 F 106 Parse "" "select udsi_user_id from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 18:23:11.283521 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 18:23:11.283523 F 6 Describe P "" 2024-04-08 18:23:11.283524 F 9 Execute "" 0 2024-04-08 18:23:11.283525 F 4 Sync 2024-04-08 18:23:11.283573 B 4 ParseComplete 2024-04-08 18:23:11.283575 B 4 BindComplete 2024-04-08 18:23:11.283576 B 37 RowDescription 1 "udsi_user_id" 25071 1 1043 65535 24 0 2024-04-08 18:23:11.283577 B 14 DataRow 1 4 'mike' 2024-04-08 18:23:11.283578 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.283579 B 5 ReadyForQuery T 2024-04-08 18:23:11.283640 F 137 Parse "" "select udsi_last_mtime from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2 AND udsi_temp_mtime IS NULL" 2 1043 1043 2024-04-08 18:23:11.283642 F 34 Bind "" "" 2 0 0 2 4 'mike' 4 'book' 1 0 2024-04-08 18:23:11.283643 F 6 Describe P "" 2024-04-08 18:23:11.283644 F 9 Execute "" 0 2024-04-08 18:23:11.283645 F 4 Sync 2024-04-08 18:23:11.283691 B 4 ParseComplete 2024-04-08 18:23:11.283692 B 4 BindComplete 2024-04-08 18:23:11.283694 B 40 RowDescription 1 "udsi_last_mtime" 25071 8 1114 8 3 0 2024-04-08 18:23:11.283695 B 33 DataRow 1 23 '2024-04-08 12:59:40.765' 2024-04-08 18:23:11.283696 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.283697 B 5 ReadyForQuery T 2024-04-08 18:23:11.283751 F 106 Parse "" "select udsi_user_id from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 18:23:11.283753 F 34 Bind "" "" 2 0 0 2 4 'mike' 4 'book' 1 0 2024-04-08 18:23:11.283754 F 6 Describe P "" 2024-04-08 18:23:11.283755 F 9 Execute "" 0 2024-04-08 18:23:11.283756 F 4 Sync 2024-04-08 18:23:11.283799 B 4 ParseComplete 2024-04-08 18:23:11.283800 B 4 BindComplete 2024-04-08 18:23:11.283801 B 37 RowDescription 1 "udsi_user_id" 25071 1 1043 65535 24 0 2024-04-08 18:23:11.283803 B 14 DataRow 1 4 'mike' 2024-04-08 18:23:11.283804 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.283805 B 5 ReadyForQuery T 2024-04-08 18:23:11.283970 F 425 Query "select ns.nspname||'.'||substring(pg_get_expr(a.adbin,0) from 'nextval.''([^'']*)') seqname , c.attname from pg_class p join pg_attrdef a on (p.oid=a.adrelid) join pg_attribute c on (p.oid=c.attrelid and a.adnum=c.attnum) join pg_namespace ns on (p.relnamespace=ns.oid) where upper(p.relname)=upper('book') and pg_get_expr(a.adbin,0) like 'nextval%' and (ns.nspname=current_schema() or ns.oid=pg_my_temp_schema())" 2024-04-08 18:23:11.284943 B 58 RowDescription 2 "seqname" 0 0 25 65535 -1 0 "attname" 1249 2 19 64 -1 0 2024-04-08 18:23:11.284947 B 44 DataRow 2 23 'public.book_book_id_seq' 7 'book_id' 2024-04-08 18:23:11.284948 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.284949 B 5 ReadyForQuery T 2024-04-08 18:23:11.285120 F 370 Parse "cu1" "insert into book (b_title, b_author, b_isbn, b_pub_date, b_price, b_plot, boo_mtime, boo_muser, boo_mstat) VALUES ($1, $2, $3, $4, $5, $6, $7, $8, $9) returning book.book_id, (select case when book.book_id>(select last_value from public.book_book_id_seq) then setval('public.book_book_id_seq',book.book_id,true) else 0 end)" 9 1043 23 1043 1082 1700 1043 1114 1043 1042 2024-04-08 18:23:11.285122 F 4 Sync 2024-04-08 18:23:11.285263 B 4 ParseComplete 2024-04-08 18:23:11.285264 B 5 ReadyForQuery T 2024-04-08 18:23:11.285266 F 123 Bind "" "cu1" 9 0 0 0 0 0 0 0 0 0 9 3 'EEE' 3 '100' 2 '44' 10 '2024-04-08' 4 '0.00' -1 26 '2024-04-08 16:23:11.281000' 4 'mike' -1 1 0 2024-04-08 18:23:11.285268 F 6 Describe P "" 2024-04-08 18:23:11.285269 F 9 Execute "" 0 2024-04-08 18:23:11.285270 F 4 Sync 2024-04-08 18:23:11.285480 B 4 BindComplete 2024-04-08 18:23:11.285490 B 55 RowDescription 2 "book_id" 25034 1 23 4 -1 0 "case" 0 0 20 8 -1 0 2024-04-08 18:23:11.285515 B 194 ErrorResponse S "ERROR" V "ERROR" C "23505" M "duplicate key value violates unique constraint "book_b_isbn_key"" D "Key (b_isbn)=(44) already exists." s "public" t "book" n "book_b_isbn_key" F "nbtinsert.c" L "666" R "_bt_check_unique" \x00 2024-04-08 18:23:11.285520 B 5 ReadyForQuery E 2024-04-08 18:23:11.285608 F 19 Query "deallocate cu1" 2024-04-08 18:23:11.285641 B 144 ErrorResponse S "ERROR" V "ERROR" C "25P02" M "current transaction is aborted, commands ignored until end of transaction block" F "postgres.c" L "1136" R "exec_simple_query" \x00 2024-04-08 18:23:11.285646 B 5 ReadyForQuery E 2024-04-08 18:23:11.285695 F 19 Query "deallocate cu0" 2024-04-08 18:23:11.285717 B 144 ErrorResponse S "ERROR" V "ERROR" C "25P02" M "current transaction is aborted, commands ignored until end of transaction block" F "postgres.c" L "1136" R "exec_simple_query" \x00 2024-04-08 18:23:11.285722 B 5 ReadyForQuery E 2024-04-08 18:23:11.285731 F 13 Query "rollback" 2024-04-08 18:23:11.285751 B 13 CommandComplete "ROLLBACK" 2024-04-08 18:23:11.285752 B 5 ReadyForQuery I 2024-04-08 18:23:11.285789 F 10 Query "begin" 2024-04-08 18:23:11.285807 B 10 CommandComplete "BEGIN" 2024-04-08 18:23:11.285809 B 5 ReadyForQuery T 2024-04-08 18:23:11.285839 F 19 Query "deallocate cu0" 2024-04-08 18:23:11.285857 B 15 CommandComplete "DEALLOCATE" 2024-04-08 18:23:11.285859 B 5 ReadyForQuery T 2024-04-08 18:23:11.285927 F 250 Parse "cu0" "declare srv_cu0 cursor for select udsi_table_name, udsi_last_mtime, udsi_temp_mtime, udsi_can_insert, udsi_can_update, udsi_can_delete, udsi_where_part, udsi_position from dbsync_udsinfo where udsi_user_id = $1 order by udsi_position" 1 1043 2024-04-08 18:23:11.285928 F 4 Sync 2024-04-08 18:23:11.285967 B 4 ParseComplete 2024-04-08 18:23:11.285969 B 5 ReadyForQuery T 2024-04-08 18:23:11.285970 F 27 Bind "" "cu0" 1 0 1 4 'mike' 1 0 2024-04-08 18:23:11.285971 F 6 Describe P "" 2024-04-08 18:23:11.285972 F 9 Execute "" 0 2024-04-08 18:23:11.285974 F 4 Sync 2024-04-08 18:23:11.286041 B 4 BindComplete 2024-04-08 18:23:11.286042 B 4 NoData 2024-04-08 18:23:11.286043 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 18:23:11.286045 B 5 ReadyForQuery T 2024-04-08 18:23:11.286053 F 34 Query "fetch absolute 0 from srv_cu0" 2024-04-08 18:23:11.286078 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 18:23:11.286082 B 12 CommandComplete "FETCH 0" 2024-04-08 18:23:11.286083 B 5 ReadyForQuery T 2024-04-08 18:23:11.286112 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 18:23:11.286142 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 18:23:11.286146 B 71 DataRow 8 6 'author' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '1' 2024-04-08 18:23:11.286147 B 69 DataRow 8 4 'book' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '2' 2024-04-08 18:23:11.286149 B 12 CommandComplete "FETCH 2" 2024-04-08 18:23:11.286150 B 5 ReadyForQuery T 2024-04-08 18:23:11.286242 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 18:23:11.286264 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 18:23:11.286267 B 12 CommandComplete "FETCH 0" 2024-04-08 18:23:11.286269 B 5 ReadyForQuery T 2024-04-08 18:23:11.286318 F 18 Query "close srv_cu0" 2024-04-08 18:23:11.286337 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 18:23:11.286339 B 5 ReadyForQuery T 2024-04-08 18:23:11.286390 F 104 Parse "" "update dbsync_udsinfo SET udsi_user_id = udsi_user_id WHERE udsi_table_name IN ('author','book')" 0 2024-04-08 18:23:11.286391 F 14 Bind "" "" 0 0 1 0 2024-04-08 18:23:11.286392 F 6 Describe P "" 2024-04-08 18:23:11.286393 F 9 Execute "" 0 2024-04-08 18:23:11.286394 F 4 Sync 2024-04-08 18:23:11.286463 B 4 ParseComplete 2024-04-08 18:23:11.286464 B 4 BindComplete 2024-04-08 18:23:11.286465 B 4 NoData 2024-04-08 18:23:11.286466 B 13 CommandComplete "UPDATE 4" 2024-04-08 18:23:11.286468 B 5 ReadyForQuery T 2024-04-08 18:23:11.286512 F 106 Parse "" "select udsi_user_id from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 18:23:11.286513 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 18:23:11.286515 F 6 Describe P "" 2024-04-08 18:23:11.286516 F 9 Execute "" 0 2024-04-08 18:23:11.286517 F 4 Sync 2024-04-08 18:23:11.286569 B 4 ParseComplete 2024-04-08 18:23:11.286570 B 4 BindComplete 2024-04-08 18:23:11.286572 B 37 RowDescription 1 "udsi_user_id" 25071 1 1043 65535 24 0 2024-04-08 18:23:11.286573 B 14 DataRow 1 4 'mike' 2024-04-08 18:23:11.286574 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.286575 B 5 ReadyForQuery T 2024-04-08 18:23:11.286630 F 106 Parse "" "select udsi_user_id from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 18:23:11.286631 F 34 Bind "" "" 2 0 0 2 4 'mike' 4 'book' 1 0 2024-04-08 18:23:11.286632 F 6 Describe P "" 2024-04-08 18:23:11.286633 F 9 Execute "" 0 2024-04-08 18:23:11.286635 F 4 Sync 2024-04-08 18:23:11.286680 B 4 ParseComplete 2024-04-08 18:23:11.286681 B 4 BindComplete 2024-04-08 18:23:11.286683 B 37 RowDescription 1 "udsi_user_id" 25071 1 1043 65535 24 0 2024-04-08 18:23:11.286684 B 14 DataRow 1 4 'mike' 2024-04-08 18:23:11.286685 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.286686 B 5 ReadyForQuery T 2024-04-08 18:23:11.286732 F 19 Query "deallocate cu0" 2024-04-08 18:23:11.286752 B 15 CommandComplete "DEALLOCATE" 2024-04-08 18:23:11.286753 B 5 ReadyForQuery T 2024-04-08 18:23:11.286821 F 250 Parse "cu0" "declare srv_cu0 cursor for select udsi_table_name, udsi_last_mtime, udsi_temp_mtime, udsi_can_insert, udsi_can_update, udsi_can_delete, udsi_where_part, udsi_position from dbsync_udsinfo where udsi_user_id = $1 order by udsi_position" 1 1043 2024-04-08 18:23:11.286822 F 4 Sync 2024-04-08 18:23:11.286853 B 4 ParseComplete 2024-04-08 18:23:11.286854 B 5 ReadyForQuery T 2024-04-08 18:23:11.286856 F 27 Bind "" "cu0" 1 0 1 4 'mike' 1 0 2024-04-08 18:23:11.286857 F 6 Describe P "" 2024-04-08 18:23:11.286858 F 9 Execute "" 0 2024-04-08 18:23:11.286859 F 4 Sync 2024-04-08 18:23:11.286899 B 4 BindComplete 2024-04-08 18:23:11.286900 B 4 NoData 2024-04-08 18:23:11.286901 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 18:23:11.286902 B 5 ReadyForQuery T 2024-04-08 18:23:11.286904 F 34 Query "fetch absolute 0 from srv_cu0" 2024-04-08 18:23:11.286925 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 18:23:11.286928 B 12 CommandComplete "FETCH 0" 2024-04-08 18:23:11.286929 B 5 ReadyForQuery T 2024-04-08 18:23:11.286953 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 18:23:11.286982 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 18:23:11.286985 B 71 DataRow 8 6 'author' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '1' 2024-04-08 18:23:11.286987 B 69 DataRow 8 4 'book' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '2' 2024-04-08 18:23:11.286988 B 12 CommandComplete "FETCH 2" 2024-04-08 18:23:11.286989 B 5 ReadyForQuery T 2024-04-08 18:23:11.287084 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 18:23:11.287104 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 18:23:11.287107 B 12 CommandComplete "FETCH 0" 2024-04-08 18:23:11.287108 B 5 ReadyForQuery T 2024-04-08 18:23:11.287154 F 18 Query "close srv_cu0" 2024-04-08 18:23:11.287172 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 18:23:11.287174 B 5 ReadyForQuery T 2024-04-08 18:23:11.287250 F 109 Parse "" "select udsi_where_part from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 18:23:11.287252 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 18:23:11.287253 F 6 Describe P "" 2024-04-08 18:23:11.287254 F 9 Execute "" 0 2024-04-08 18:23:11.287255 F 4 Sync 2024-04-08 18:23:11.287307 B 4 ParseComplete 2024-04-08 18:23:11.287308 B 4 BindComplete 2024-04-08 18:23:11.287310 B 40 RowDescription 1 "udsi_where_part" 25071 7 1043 65535 2004 0 2024-04-08 18:23:11.287311 B 10 DataRow 1 -1 2024-04-08 18:23:11.287312 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.287313 B 5 ReadyForQuery T 2024-04-08 18:23:11.287395 F 109 Parse "" "select udsi_where_part from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 18:23:11.287396 F 34 Bind "" "" 2 0 0 2 4 'mike' 4 'book' 1 0 2024-04-08 18:23:11.287398 F 6 Describe P "" 2024-04-08 18:23:11.287399 F 9 Execute "" 0 2024-04-08 18:23:11.287400 F 4 Sync 2024-04-08 18:23:11.287468 B 4 ParseComplete 2024-04-08 18:23:11.287470 B 4 BindComplete 2024-04-08 18:23:11.287471 B 40 RowDescription 1 "udsi_where_part" 25071 7 1043 65535 2004 0 2024-04-08 18:23:11.287472 B 10 DataRow 1 -1 2024-04-08 18:23:11.287473 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.287475 B 5 ReadyForQuery T 2024-04-08 18:23:11.287536 F 109 Parse "" "select udsi_where_part from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 18:23:11.287538 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 18:23:11.287539 F 6 Describe P "" 2024-04-08 18:23:11.287540 F 9 Execute "" 0 2024-04-08 18:23:11.287541 F 4 Sync 2024-04-08 18:23:11.287583 B 4 ParseComplete 2024-04-08 18:23:11.287584 B 4 BindComplete 2024-04-08 18:23:11.287585 B 40 RowDescription 1 "udsi_where_part" 25071 7 1043 65535 2004 0 2024-04-08 18:23:11.287587 B 10 DataRow 1 -1 2024-04-08 18:23:11.287588 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.287589 B 5 ReadyForQuery T 2024-04-08 18:23:11.287684 F 61 Parse "cu1" "declare srv_cu1 cursor for select * from author " 0 2024-04-08 18:23:11.287686 F 4 Sync 2024-04-08 18:23:11.287747 B 107 ErrorResponse S "ERROR" V "ERROR" C "42P05" M "prepared statement "cu1" already exists" F "prepare.c" L "412" R "StorePreparedStatement" \x00 2024-04-08 18:23:11.287755 B 5 ReadyForQuery E 2024-04-08 18:23:11.287804 F 19 Query "deallocate cu0" 2024-04-08 18:23:11.287827 B 144 ErrorResponse S "ERROR" V "ERROR" C "25P02" M "current transaction is aborted, commands ignored until end of transaction block" F "postgres.c" L "1136" R "exec_simple_query" \x00 2024-04-08 18:23:11.287831 B 5 ReadyForQuery E 2024-04-08 18:23:11.287840 F 13 Query "rollback" 2024-04-08 18:23:11.287861 B 13 CommandComplete "ROLLBACK" 2024-04-08 18:23:11.287862 B 5 ReadyForQuery I 2024-04-08 18:23:11.287912 F 19 Query "deallocate cu0" 2024-04-08 18:23:11.287932 B 15 CommandComplete "DEALLOCATE" 2024-04-08 18:23:11.287933 B 5 ReadyForQuery I 2024-04-08 18:23:11.287937 F 4 Terminate Attachments: [text/plain] pgs_trace.txt (20.6K, 3-pgs_trace.txt) download | inline: 2024-04-08 18:23:11.280594 F 33 Query "set intervalstyle='iso_8601'" 2024-04-08 18:23:11.280740 B 8 CommandComplete "SET" 2024-04-08 18:23:11.280743 B 27 ParameterStatus "IntervalStyle" "iso_8601" 2024-04-08 18:23:11.280745 B 5 ReadyForQuery I 2024-04-08 18:23:11.280781 F 67 Query "update pg_settings set setting=10000 where name='lock_timeout'" 2024-04-08 18:23:11.281610 B 35 RowDescription 1 "set_config" 0 0 25 65535 -1 0 2024-04-08 18:23:11.281620 B 13 DataRow 1 3 '10s' 2024-04-08 18:23:11.281622 B 13 CommandComplete "UPDATE 0" 2024-04-08 18:23:11.281623 B 5 ReadyForQuery I 2024-04-08 18:23:11.281698 F 10 Query "begin" 2024-04-08 18:23:11.281720 B 10 CommandComplete "BEGIN" 2024-04-08 18:23:11.281722 B 5 ReadyForQuery T 2024-04-08 18:23:11.281854 F 250 Parse "cu0" "declare srv_cu0 cursor for select udsi_table_name, udsi_last_mtime, udsi_temp_mtime, udsi_can_insert, udsi_can_update, udsi_can_delete, udsi_where_part, udsi_position from dbsync_udsinfo where udsi_user_id = $1 order by udsi_position" 1 1043 2024-04-08 18:23:11.281855 F 4 Sync 2024-04-08 18:23:11.282200 B 4 ParseComplete 2024-04-08 18:23:11.282206 B 5 ReadyForQuery T 2024-04-08 18:23:11.282210 F 27 Bind "" "cu0" 1 0 1 4 'mike' 1 0 2024-04-08 18:23:11.282211 F 6 Describe P "" 2024-04-08 18:23:11.282213 F 9 Execute "" 0 2024-04-08 18:23:11.282214 F 4 Sync 2024-04-08 18:23:11.282512 B 4 BindComplete 2024-04-08 18:23:11.282517 B 4 NoData 2024-04-08 18:23:11.282519 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 18:23:11.282520 B 5 ReadyForQuery T 2024-04-08 18:23:11.282523 F 34 Query "fetch absolute 0 from srv_cu0" 2024-04-08 18:23:11.282600 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 18:23:11.282604 B 12 CommandComplete "FETCH 0" 2024-04-08 18:23:11.282605 B 5 ReadyForQuery T 2024-04-08 18:23:11.282649 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 18:23:11.282741 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 18:23:11.282745 B 71 DataRow 8 6 'author' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '1' 2024-04-08 18:23:11.282747 B 69 DataRow 8 4 'book' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '2' 2024-04-08 18:23:11.282748 B 12 CommandComplete "FETCH 2" 2024-04-08 18:23:11.282749 B 5 ReadyForQuery T 2024-04-08 18:23:11.282850 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 18:23:11.282919 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 18:23:11.282922 B 12 CommandComplete "FETCH 0" 2024-04-08 18:23:11.282923 B 5 ReadyForQuery T 2024-04-08 18:23:11.282974 F 18 Query "close srv_cu0" 2024-04-08 18:23:11.283040 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 18:23:11.283042 B 5 ReadyForQuery T 2024-04-08 18:23:11.283109 F 104 Parse "" "update dbsync_udsinfo SET udsi_user_id = udsi_user_id WHERE udsi_table_name IN ('author','book')" 0 2024-04-08 18:23:11.283110 F 14 Bind "" "" 0 0 1 0 2024-04-08 18:23:11.283111 F 6 Describe P "" 2024-04-08 18:23:11.283112 F 9 Execute "" 0 2024-04-08 18:23:11.283113 F 4 Sync 2024-04-08 18:23:11.283325 B 4 ParseComplete 2024-04-08 18:23:11.283326 B 4 BindComplete 2024-04-08 18:23:11.283327 B 4 NoData 2024-04-08 18:23:11.283328 B 13 CommandComplete "UPDATE 4" 2024-04-08 18:23:11.283329 B 5 ReadyForQuery T 2024-04-08 18:23:11.283383 F 137 Parse "" "select udsi_last_mtime from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2 AND udsi_temp_mtime IS NULL" 2 1043 1043 2024-04-08 18:23:11.283385 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 18:23:11.283386 F 6 Describe P "" 2024-04-08 18:23:11.283387 F 9 Execute "" 0 2024-04-08 18:23:11.283388 F 4 Sync 2024-04-08 18:23:11.283454 B 4 ParseComplete 2024-04-08 18:23:11.283456 B 4 BindComplete 2024-04-08 18:23:11.283457 B 40 RowDescription 1 "udsi_last_mtime" 25071 8 1114 8 3 0 2024-04-08 18:23:11.283459 B 33 DataRow 1 23 '2024-04-08 12:59:40.765' 2024-04-08 18:23:11.283460 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.283461 B 5 ReadyForQuery T 2024-04-08 18:23:11.283520 F 106 Parse "" "select udsi_user_id from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 18:23:11.283521 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 18:23:11.283523 F 6 Describe P "" 2024-04-08 18:23:11.283524 F 9 Execute "" 0 2024-04-08 18:23:11.283525 F 4 Sync 2024-04-08 18:23:11.283573 B 4 ParseComplete 2024-04-08 18:23:11.283575 B 4 BindComplete 2024-04-08 18:23:11.283576 B 37 RowDescription 1 "udsi_user_id" 25071 1 1043 65535 24 0 2024-04-08 18:23:11.283577 B 14 DataRow 1 4 'mike' 2024-04-08 18:23:11.283578 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.283579 B 5 ReadyForQuery T 2024-04-08 18:23:11.283640 F 137 Parse "" "select udsi_last_mtime from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2 AND udsi_temp_mtime IS NULL" 2 1043 1043 2024-04-08 18:23:11.283642 F 34 Bind "" "" 2 0 0 2 4 'mike' 4 'book' 1 0 2024-04-08 18:23:11.283643 F 6 Describe P "" 2024-04-08 18:23:11.283644 F 9 Execute "" 0 2024-04-08 18:23:11.283645 F 4 Sync 2024-04-08 18:23:11.283691 B 4 ParseComplete 2024-04-08 18:23:11.283692 B 4 BindComplete 2024-04-08 18:23:11.283694 B 40 RowDescription 1 "udsi_last_mtime" 25071 8 1114 8 3 0 2024-04-08 18:23:11.283695 B 33 DataRow 1 23 '2024-04-08 12:59:40.765' 2024-04-08 18:23:11.283696 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.283697 B 5 ReadyForQuery T 2024-04-08 18:23:11.283751 F 106 Parse "" "select udsi_user_id from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 18:23:11.283753 F 34 Bind "" "" 2 0 0 2 4 'mike' 4 'book' 1 0 2024-04-08 18:23:11.283754 F 6 Describe P "" 2024-04-08 18:23:11.283755 F 9 Execute "" 0 2024-04-08 18:23:11.283756 F 4 Sync 2024-04-08 18:23:11.283799 B 4 ParseComplete 2024-04-08 18:23:11.283800 B 4 BindComplete 2024-04-08 18:23:11.283801 B 37 RowDescription 1 "udsi_user_id" 25071 1 1043 65535 24 0 2024-04-08 18:23:11.283803 B 14 DataRow 1 4 'mike' 2024-04-08 18:23:11.283804 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.283805 B 5 ReadyForQuery T 2024-04-08 18:23:11.283970 F 425 Query "select ns.nspname||'.'||substring(pg_get_expr(a.adbin,0) from 'nextval.''([^'']*)') seqname , c.attname from pg_class p join pg_attrdef a on (p.oid=a.adrelid) join pg_attribute c on (p.oid=c.attrelid and a.adnum=c.attnum) join pg_namespace ns on (p.relnamespace=ns.oid) where upper(p.relname)=upper('book') and pg_get_expr(a.adbin,0) like 'nextval%' and (ns.nspname=current_schema() or ns.oid=pg_my_temp_schema())" 2024-04-08 18:23:11.284943 B 58 RowDescription 2 "seqname" 0 0 25 65535 -1 0 "attname" 1249 2 19 64 -1 0 2024-04-08 18:23:11.284947 B 44 DataRow 2 23 'public.book_book_id_seq' 7 'book_id' 2024-04-08 18:23:11.284948 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.284949 B 5 ReadyForQuery T 2024-04-08 18:23:11.285120 F 370 Parse "cu1" "insert into book (b_title, b_author, b_isbn, b_pub_date, b_price, b_plot, boo_mtime, boo_muser, boo_mstat) VALUES ($1, $2, $3, $4, $5, $6, $7, $8, $9) returning book.book_id, (select case when book.book_id>(select last_value from public.book_book_id_seq) then setval('public.book_book_id_seq',book.book_id,true) else 0 end)" 9 1043 23 1043 1082 1700 1043 1114 1043 1042 2024-04-08 18:23:11.285122 F 4 Sync 2024-04-08 18:23:11.285263 B 4 ParseComplete 2024-04-08 18:23:11.285264 B 5 ReadyForQuery T 2024-04-08 18:23:11.285266 F 123 Bind "" "cu1" 9 0 0 0 0 0 0 0 0 0 9 3 'EEE' 3 '100' 2 '44' 10 '2024-04-08' 4 '0.00' -1 26 '2024-04-08 16:23:11.281000' 4 'mike' -1 1 0 2024-04-08 18:23:11.285268 F 6 Describe P "" 2024-04-08 18:23:11.285269 F 9 Execute "" 0 2024-04-08 18:23:11.285270 F 4 Sync 2024-04-08 18:23:11.285480 B 4 BindComplete 2024-04-08 18:23:11.285490 B 55 RowDescription 2 "book_id" 25034 1 23 4 -1 0 "case" 0 0 20 8 -1 0 2024-04-08 18:23:11.285515 B 194 ErrorResponse S "ERROR" V "ERROR" C "23505" M "duplicate key value violates unique constraint "book_b_isbn_key"" D "Key (b_isbn)=(44) already exists." s "public" t "book" n "book_b_isbn_key" F "nbtinsert.c" L "666" R "_bt_check_unique" \x00 2024-04-08 18:23:11.285520 B 5 ReadyForQuery E 2024-04-08 18:23:11.285608 F 19 Query "deallocate cu1" 2024-04-08 18:23:11.285641 B 144 ErrorResponse S "ERROR" V "ERROR" C "25P02" M "current transaction is aborted, commands ignored until end of transaction block" F "postgres.c" L "1136" R "exec_simple_query" \x00 2024-04-08 18:23:11.285646 B 5 ReadyForQuery E 2024-04-08 18:23:11.285695 F 19 Query "deallocate cu0" 2024-04-08 18:23:11.285717 B 144 ErrorResponse S "ERROR" V "ERROR" C "25P02" M "current transaction is aborted, commands ignored until end of transaction block" F "postgres.c" L "1136" R "exec_simple_query" \x00 2024-04-08 18:23:11.285722 B 5 ReadyForQuery E 2024-04-08 18:23:11.285731 F 13 Query "rollback" 2024-04-08 18:23:11.285751 B 13 CommandComplete "ROLLBACK" 2024-04-08 18:23:11.285752 B 5 ReadyForQuery I 2024-04-08 18:23:11.285789 F 10 Query "begin" 2024-04-08 18:23:11.285807 B 10 CommandComplete "BEGIN" 2024-04-08 18:23:11.285809 B 5 ReadyForQuery T 2024-04-08 18:23:11.285839 F 19 Query "deallocate cu0" 2024-04-08 18:23:11.285857 B 15 CommandComplete "DEALLOCATE" 2024-04-08 18:23:11.285859 B 5 ReadyForQuery T 2024-04-08 18:23:11.285927 F 250 Parse "cu0" "declare srv_cu0 cursor for select udsi_table_name, udsi_last_mtime, udsi_temp_mtime, udsi_can_insert, udsi_can_update, udsi_can_delete, udsi_where_part, udsi_position from dbsync_udsinfo where udsi_user_id = $1 order by udsi_position" 1 1043 2024-04-08 18:23:11.285928 F 4 Sync 2024-04-08 18:23:11.285967 B 4 ParseComplete 2024-04-08 18:23:11.285969 B 5 ReadyForQuery T 2024-04-08 18:23:11.285970 F 27 Bind "" "cu0" 1 0 1 4 'mike' 1 0 2024-04-08 18:23:11.285971 F 6 Describe P "" 2024-04-08 18:23:11.285972 F 9 Execute "" 0 2024-04-08 18:23:11.285974 F 4 Sync 2024-04-08 18:23:11.286041 B 4 BindComplete 2024-04-08 18:23:11.286042 B 4 NoData 2024-04-08 18:23:11.286043 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 18:23:11.286045 B 5 ReadyForQuery T 2024-04-08 18:23:11.286053 F 34 Query "fetch absolute 0 from srv_cu0" 2024-04-08 18:23:11.286078 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 18:23:11.286082 B 12 CommandComplete "FETCH 0" 2024-04-08 18:23:11.286083 B 5 ReadyForQuery T 2024-04-08 18:23:11.286112 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 18:23:11.286142 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 18:23:11.286146 B 71 DataRow 8 6 'author' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '1' 2024-04-08 18:23:11.286147 B 69 DataRow 8 4 'book' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '2' 2024-04-08 18:23:11.286149 B 12 CommandComplete "FETCH 2" 2024-04-08 18:23:11.286150 B 5 ReadyForQuery T 2024-04-08 18:23:11.286242 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 18:23:11.286264 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 18:23:11.286267 B 12 CommandComplete "FETCH 0" 2024-04-08 18:23:11.286269 B 5 ReadyForQuery T 2024-04-08 18:23:11.286318 F 18 Query "close srv_cu0" 2024-04-08 18:23:11.286337 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 18:23:11.286339 B 5 ReadyForQuery T 2024-04-08 18:23:11.286390 F 104 Parse "" "update dbsync_udsinfo SET udsi_user_id = udsi_user_id WHERE udsi_table_name IN ('author','book')" 0 2024-04-08 18:23:11.286391 F 14 Bind "" "" 0 0 1 0 2024-04-08 18:23:11.286392 F 6 Describe P "" 2024-04-08 18:23:11.286393 F 9 Execute "" 0 2024-04-08 18:23:11.286394 F 4 Sync 2024-04-08 18:23:11.286463 B 4 ParseComplete 2024-04-08 18:23:11.286464 B 4 BindComplete 2024-04-08 18:23:11.286465 B 4 NoData 2024-04-08 18:23:11.286466 B 13 CommandComplete "UPDATE 4" 2024-04-08 18:23:11.286468 B 5 ReadyForQuery T 2024-04-08 18:23:11.286512 F 106 Parse "" "select udsi_user_id from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 18:23:11.286513 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 18:23:11.286515 F 6 Describe P "" 2024-04-08 18:23:11.286516 F 9 Execute "" 0 2024-04-08 18:23:11.286517 F 4 Sync 2024-04-08 18:23:11.286569 B 4 ParseComplete 2024-04-08 18:23:11.286570 B 4 BindComplete 2024-04-08 18:23:11.286572 B 37 RowDescription 1 "udsi_user_id" 25071 1 1043 65535 24 0 2024-04-08 18:23:11.286573 B 14 DataRow 1 4 'mike' 2024-04-08 18:23:11.286574 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.286575 B 5 ReadyForQuery T 2024-04-08 18:23:11.286630 F 106 Parse "" "select udsi_user_id from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 18:23:11.286631 F 34 Bind "" "" 2 0 0 2 4 'mike' 4 'book' 1 0 2024-04-08 18:23:11.286632 F 6 Describe P "" 2024-04-08 18:23:11.286633 F 9 Execute "" 0 2024-04-08 18:23:11.286635 F 4 Sync 2024-04-08 18:23:11.286680 B 4 ParseComplete 2024-04-08 18:23:11.286681 B 4 BindComplete 2024-04-08 18:23:11.286683 B 37 RowDescription 1 "udsi_user_id" 25071 1 1043 65535 24 0 2024-04-08 18:23:11.286684 B 14 DataRow 1 4 'mike' 2024-04-08 18:23:11.286685 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.286686 B 5 ReadyForQuery T 2024-04-08 18:23:11.286732 F 19 Query "deallocate cu0" 2024-04-08 18:23:11.286752 B 15 CommandComplete "DEALLOCATE" 2024-04-08 18:23:11.286753 B 5 ReadyForQuery T 2024-04-08 18:23:11.286821 F 250 Parse "cu0" "declare srv_cu0 cursor for select udsi_table_name, udsi_last_mtime, udsi_temp_mtime, udsi_can_insert, udsi_can_update, udsi_can_delete, udsi_where_part, udsi_position from dbsync_udsinfo where udsi_user_id = $1 order by udsi_position" 1 1043 2024-04-08 18:23:11.286822 F 4 Sync 2024-04-08 18:23:11.286853 B 4 ParseComplete 2024-04-08 18:23:11.286854 B 5 ReadyForQuery T 2024-04-08 18:23:11.286856 F 27 Bind "" "cu0" 1 0 1 4 'mike' 1 0 2024-04-08 18:23:11.286857 F 6 Describe P "" 2024-04-08 18:23:11.286858 F 9 Execute "" 0 2024-04-08 18:23:11.286859 F 4 Sync 2024-04-08 18:23:11.286899 B 4 BindComplete 2024-04-08 18:23:11.286900 B 4 NoData 2024-04-08 18:23:11.286901 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 18:23:11.286902 B 5 ReadyForQuery T 2024-04-08 18:23:11.286904 F 34 Query "fetch absolute 0 from srv_cu0" 2024-04-08 18:23:11.286925 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 18:23:11.286928 B 12 CommandComplete "FETCH 0" 2024-04-08 18:23:11.286929 B 5 ReadyForQuery T 2024-04-08 18:23:11.286953 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 18:23:11.286982 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 18:23:11.286985 B 71 DataRow 8 6 'author' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '1' 2024-04-08 18:23:11.286987 B 69 DataRow 8 4 'book' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '2' 2024-04-08 18:23:11.286988 B 12 CommandComplete "FETCH 2" 2024-04-08 18:23:11.286989 B 5 ReadyForQuery T 2024-04-08 18:23:11.287084 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 18:23:11.287104 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 18:23:11.287107 B 12 CommandComplete "FETCH 0" 2024-04-08 18:23:11.287108 B 5 ReadyForQuery T 2024-04-08 18:23:11.287154 F 18 Query "close srv_cu0" 2024-04-08 18:23:11.287172 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 18:23:11.287174 B 5 ReadyForQuery T 2024-04-08 18:23:11.287250 F 109 Parse "" "select udsi_where_part from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 18:23:11.287252 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 18:23:11.287253 F 6 Describe P "" 2024-04-08 18:23:11.287254 F 9 Execute "" 0 2024-04-08 18:23:11.287255 F 4 Sync 2024-04-08 18:23:11.287307 B 4 ParseComplete 2024-04-08 18:23:11.287308 B 4 BindComplete 2024-04-08 18:23:11.287310 B 40 RowDescription 1 "udsi_where_part" 25071 7 1043 65535 2004 0 2024-04-08 18:23:11.287311 B 10 DataRow 1 -1 2024-04-08 18:23:11.287312 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.287313 B 5 ReadyForQuery T 2024-04-08 18:23:11.287395 F 109 Parse "" "select udsi_where_part from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 18:23:11.287396 F 34 Bind "" "" 2 0 0 2 4 'mike' 4 'book' 1 0 2024-04-08 18:23:11.287398 F 6 Describe P "" 2024-04-08 18:23:11.287399 F 9 Execute "" 0 2024-04-08 18:23:11.287400 F 4 Sync 2024-04-08 18:23:11.287468 B 4 ParseComplete 2024-04-08 18:23:11.287470 B 4 BindComplete 2024-04-08 18:23:11.287471 B 40 RowDescription 1 "udsi_where_part" 25071 7 1043 65535 2004 0 2024-04-08 18:23:11.287472 B 10 DataRow 1 -1 2024-04-08 18:23:11.287473 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.287475 B 5 ReadyForQuery T 2024-04-08 18:23:11.287536 F 109 Parse "" "select udsi_where_part from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 18:23:11.287538 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 18:23:11.287539 F 6 Describe P "" 2024-04-08 18:23:11.287540 F 9 Execute "" 0 2024-04-08 18:23:11.287541 F 4 Sync 2024-04-08 18:23:11.287583 B 4 ParseComplete 2024-04-08 18:23:11.287584 B 4 BindComplete 2024-04-08 18:23:11.287585 B 40 RowDescription 1 "udsi_where_part" 25071 7 1043 65535 2004 0 2024-04-08 18:23:11.287587 B 10 DataRow 1 -1 2024-04-08 18:23:11.287588 B 13 CommandComplete "SELECT 1" 2024-04-08 18:23:11.287589 B 5 ReadyForQuery T 2024-04-08 18:23:11.287684 F 61 Parse "cu1" "declare srv_cu1 cursor for select * from author " 0 2024-04-08 18:23:11.287686 F 4 Sync 2024-04-08 18:23:11.287747 B 107 ErrorResponse S "ERROR" V "ERROR" C "42P05" M "prepared statement "cu1" already exists" F "prepare.c" L "412" R "StorePreparedStatement" \x00 2024-04-08 18:23:11.287755 B 5 ReadyForQuery E 2024-04-08 18:23:11.287804 F 19 Query "deallocate cu0" 2024-04-08 18:23:11.287827 B 144 ErrorResponse S "ERROR" V "ERROR" C "25P02" M "current transaction is aborted, commands ignored until end of transaction block" F "postgres.c" L "1136" R "exec_simple_query" \x00 2024-04-08 18:23:11.287831 B 5 ReadyForQuery E 2024-04-08 18:23:11.287840 F 13 Query "rollback" 2024-04-08 18:23:11.287861 B 13 CommandComplete "ROLLBACK" 2024-04-08 18:23:11.287862 B 5 ReadyForQuery I 2024-04-08 18:23:11.287912 F 19 Query "deallocate cu0" 2024-04-08 18:23:11.287932 B 15 CommandComplete "DEALLOCATE" 2024-04-08 18:23:11.287933 B 5 ReadyForQuery I 2024-04-08 18:23:11.287937 F 4 Terminate ^ permalink raw reply [nested|flat] 3+ messages in thread
* Re: prepared statement "cu1" already exists (but it does not) 2024-04-08 16:25 Re: prepared statement "cu1" already exists (but it does not) Sebastien Flaesch <[email protected]> @ 2024-04-08 17:36 ` Tom Lane <[email protected]> 2024-04-08 17:44 ` Re: prepared statement "cu1" already exists (but it does not) Sebastien Flaesch <[email protected]> 0 siblings, 1 reply; 3+ messages in thread From: Tom Lane @ 2024-04-08 17:36 UTC (permalink / raw) To: Sebastien Flaesch <[email protected]>; +Cc: pgsql-general <[email protected]> Sebastien Flaesch <[email protected]> writes: > I understand that the whole TX is aborted with PostgreSQL, and probably the deallocate is useless since stmt was prepared inside the TX? As you can quickly discover with some manual experimentation, both PREPARE and DEALLOCATE are nontransactional, in the sense that if they succeed then the prepared statement will exist (or not) even if the surrounding transaction block is later rolled back. This is pretty weird, and undocumented I think, in terms of their role as SQL statements. It makes a little more sense if you think about the equivalent wire-protocol-level operations, which are meant to be used by low-level client code that may not be aware of whether there is a transaction block in progress. > Is it an issue if I use the same name for a prepared statement and the server cursor? I mean: From memory, I think those share the same "portal" namespace. regards, tom lane ^ permalink raw reply [nested|flat] 3+ messages in thread
* Re: prepared statement "cu1" already exists (but it does not) 2024-04-08 16:25 Re: prepared statement "cu1" already exists (but it does not) Sebastien Flaesch <[email protected]> 2024-04-08 17:36 ` Re: prepared statement "cu1" already exists (but it does not) Tom Lane <[email protected]> @ 2024-04-08 17:44 ` Sebastien Flaesch <[email protected]> 0 siblings, 0 replies; 3+ messages in thread From: Sebastien Flaesch @ 2024-04-08 17:44 UTC (permalink / raw) To: Tom Lane <[email protected]>; +Cc: pgsql-general <[email protected]> Thanks all for your help. I have discovered another fact: When surrounding the execution of the failing INSERT with a savepoint + rollback to savepoint, the problem disappears: The DEALLOCATE commands do then succeed. See attached trace... Seb ________________________________ From: Tom Lane <[email protected]> Sent: Monday, April 8, 2024 7:36 PM To: Sebastien Flaesch <[email protected]> Cc: pgsql-general <[email protected]> Subject: Re: prepared statement "cu1" already exists (but it does not) EXTERNAL: Do not click links or open attachments if you do not recognize the sender. Sebastien Flaesch <[email protected]> writes: > I understand that the whole TX is aborted with PostgreSQL, and probably the deallocate is useless since stmt was prepared inside the TX? As you can quickly discover with some manual experimentation, both PREPARE and DEALLOCATE are nontransactional, in the sense that if they succeed then the prepared statement will exist (or not) even if the surrounding transaction block is later rolled back. This is pretty weird, and undocumented I think, in terms of their role as SQL statements. It makes a little more sense if you think about the equivalent wire-protocol-level operations, which are meant to be used by low-level client code that may not be aware of whether there is a transaction block in progress. > Is it an issue if I use the same name for a prepared statement and the server cursor? I mean: From memory, I think those share the same "portal" namespace. regards, tom lane 2024-04-08 19:39:22.679893 F 33 Query "set intervalstyle='iso_8601'" 2024-04-08 19:39:22.679989 B 8 CommandComplete "SET" 2024-04-08 19:39:22.679993 B 27 ParameterStatus "IntervalStyle" "iso_8601" 2024-04-08 19:39:22.679994 B 5 ReadyForQuery I 2024-04-08 19:39:22.680029 F 67 Query "update pg_settings set setting=10000 where name='lock_timeout'" 2024-04-08 19:39:22.680939 B 35 RowDescription 1 "set_config" 0 0 25 65535 -1 0 2024-04-08 19:39:22.680945 B 13 DataRow 1 3 '10s' 2024-04-08 19:39:22.680947 B 13 CommandComplete "UPDATE 0" 2024-04-08 19:39:22.680948 B 5 ReadyForQuery I 2024-04-08 19:39:22.681035 F 10 Query "begin" 2024-04-08 19:39:22.681150 B 10 CommandComplete "BEGIN" 2024-04-08 19:39:22.681155 B 5 ReadyForQuery T 2024-04-08 19:39:22.681306 F 250 Parse "cu0" "declare srv_cu0 cursor for select udsi_table_name, udsi_last_mtime, udsi_temp_mtime, udsi_can_insert, udsi_can_update, udsi_can_delete, udsi_where_part, udsi_position from dbsync_udsinfo where udsi_user_id = $1 order by udsi_position" 1 1043 2024-04-08 19:39:22.681308 F 4 Sync 2024-04-08 19:39:22.681739 B 4 ParseComplete 2024-04-08 19:39:22.681744 B 5 ReadyForQuery T 2024-04-08 19:39:22.681748 F 27 Bind "" "cu0" 1 0 1 4 'mike' 1 0 2024-04-08 19:39:22.681750 F 6 Describe P "" 2024-04-08 19:39:22.681751 F 9 Execute "" 0 2024-04-08 19:39:22.681752 F 4 Sync 2024-04-08 19:39:22.682027 B 4 BindComplete 2024-04-08 19:39:22.682033 B 4 NoData 2024-04-08 19:39:22.682034 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 19:39:22.682036 B 5 ReadyForQuery T 2024-04-08 19:39:22.682038 F 34 Query "fetch absolute 0 from srv_cu0" 2024-04-08 19:39:22.682126 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 19:39:22.682131 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.682132 B 5 ReadyForQuery T 2024-04-08 19:39:22.682175 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 19:39:22.682277 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 19:39:22.682280 B 71 DataRow 8 6 'author' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '1' 2024-04-08 19:39:22.682282 B 69 DataRow 8 4 'book' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '2' 2024-04-08 19:39:22.682284 B 12 CommandComplete "FETCH 2" 2024-04-08 19:39:22.682285 B 5 ReadyForQuery T 2024-04-08 19:39:22.682386 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 19:39:22.682411 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 19:39:22.682414 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.682415 B 5 ReadyForQuery T 2024-04-08 19:39:22.682467 F 18 Query "close srv_cu0" 2024-04-08 19:39:22.682488 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 19:39:22.682490 B 5 ReadyForQuery T 2024-04-08 19:39:22.682557 F 104 Parse "" "update dbsync_udsinfo SET udsi_user_id = udsi_user_id WHERE udsi_table_name IN ('author','book')" 0 2024-04-08 19:39:22.682559 F 14 Bind "" "" 0 0 1 0 2024-04-08 19:39:22.682560 F 6 Describe P "" 2024-04-08 19:39:22.682561 F 9 Execute "" 0 2024-04-08 19:39:22.682562 F 4 Sync 2024-04-08 19:39:22.682762 B 4 ParseComplete 2024-04-08 19:39:22.682763 B 4 BindComplete 2024-04-08 19:39:22.682764 B 4 NoData 2024-04-08 19:39:22.682765 B 13 CommandComplete "UPDATE 4" 2024-04-08 19:39:22.682766 B 5 ReadyForQuery T 2024-04-08 19:39:22.682821 F 137 Parse "" "select udsi_last_mtime from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2 AND udsi_temp_mtime IS NULL" 2 1043 1043 2024-04-08 19:39:22.682822 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 19:39:22.682824 F 6 Describe P "" 2024-04-08 19:39:22.682825 F 9 Execute "" 0 2024-04-08 19:39:22.682826 F 4 Sync 2024-04-08 19:39:22.682892 B 4 ParseComplete 2024-04-08 19:39:22.682893 B 4 BindComplete 2024-04-08 19:39:22.682895 B 40 RowDescription 1 "udsi_last_mtime" 25071 8 1114 8 3 0 2024-04-08 19:39:22.682896 B 33 DataRow 1 23 '2024-04-08 12:59:40.765' 2024-04-08 19:39:22.682897 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.682898 B 5 ReadyForQuery T 2024-04-08 19:39:22.682957 F 106 Parse "" "select udsi_user_id from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 19:39:22.682958 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 19:39:22.682960 F 6 Describe P "" 2024-04-08 19:39:22.682961 F 9 Execute "" 0 2024-04-08 19:39:22.682962 F 4 Sync 2024-04-08 19:39:22.683009 B 4 ParseComplete 2024-04-08 19:39:22.683011 B 4 BindComplete 2024-04-08 19:39:22.683012 B 37 RowDescription 1 "udsi_user_id" 25071 1 1043 65535 24 0 2024-04-08 19:39:22.683013 B 14 DataRow 1 4 'mike' 2024-04-08 19:39:22.683014 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.683015 B 5 ReadyForQuery T 2024-04-08 19:39:22.683077 F 137 Parse "" "select udsi_last_mtime from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2 AND udsi_temp_mtime IS NULL" 2 1043 1043 2024-04-08 19:39:22.683078 F 34 Bind "" "" 2 0 0 2 4 'mike' 4 'book' 1 0 2024-04-08 19:39:22.683080 F 6 Describe P "" 2024-04-08 19:39:22.683081 F 9 Execute "" 0 2024-04-08 19:39:22.683082 F 4 Sync 2024-04-08 19:39:22.683127 B 4 ParseComplete 2024-04-08 19:39:22.683128 B 4 BindComplete 2024-04-08 19:39:22.683129 B 40 RowDescription 1 "udsi_last_mtime" 25071 8 1114 8 3 0 2024-04-08 19:39:22.683131 B 33 DataRow 1 23 '2024-04-08 12:59:40.765' 2024-04-08 19:39:22.683132 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.683133 B 5 ReadyForQuery T 2024-04-08 19:39:22.683187 F 106 Parse "" "select udsi_user_id from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 19:39:22.683188 F 34 Bind "" "" 2 0 0 2 4 'mike' 4 'book' 1 0 2024-04-08 19:39:22.683190 F 6 Describe P "" 2024-04-08 19:39:22.683191 F 9 Execute "" 0 2024-04-08 19:39:22.683192 F 4 Sync 2024-04-08 19:39:22.683234 B 4 ParseComplete 2024-04-08 19:39:22.683235 B 4 BindComplete 2024-04-08 19:39:22.683237 B 37 RowDescription 1 "udsi_user_id" 25071 1 1043 65535 24 0 2024-04-08 19:39:22.683238 B 14 DataRow 1 4 'mike' 2024-04-08 19:39:22.683239 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.683240 B 5 ReadyForQuery T 2024-04-08 19:39:22.683328 F 18 Query "savepoint sp1" 2024-04-08 19:39:22.683349 B 14 CommandComplete "SAVEPOINT" 2024-04-08 19:39:22.683350 B 5 ReadyForQuery T 2024-04-08 19:39:22.683448 F 425 Query "select ns.nspname||'.'||substring(pg_get_expr(a.adbin,0) from 'nextval.''([^'']*)') seqname , c.attname from pg_class p join pg_attrdef a on (p.oid=a.adrelid) join pg_attribute c on (p.oid=c.attrelid and a.adnum=c.attnum) join pg_namespace ns on (p.relnamespace=ns.oid) where upper(p.relname)=upper('book') and pg_get_expr(a.adbin,0) like 'nextval%' and (ns.nspname=current_schema() or ns.oid=pg_my_temp_schema())" 2024-04-08 19:39:22.684440 B 58 RowDescription 2 "seqname" 0 0 25 65535 -1 0 "attname" 1249 2 19 64 -1 0 2024-04-08 19:39:22.684443 B 44 DataRow 2 23 'public.book_book_id_seq' 7 'book_id' 2024-04-08 19:39:22.684445 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.684446 B 5 ReadyForQuery T 2024-04-08 19:39:22.684622 F 370 Parse "cu1" "insert into book (b_title, b_author, b_isbn, b_pub_date, b_price, b_plot, boo_mtime, boo_muser, boo_mstat) VALUES ($1, $2, $3, $4, $5, $6, $7, $8, $9) returning book.book_id, (select case when book.book_id>(select last_value from public.book_book_id_seq) then setval('public.book_book_id_seq',book.book_id,true) else 0 end)" 9 1043 23 1043 1082 1700 1043 1114 1043 1042 2024-04-08 19:39:22.684623 F 4 Sync 2024-04-08 19:39:22.684763 B 4 ParseComplete 2024-04-08 19:39:22.684765 B 5 ReadyForQuery T 2024-04-08 19:39:22.684766 F 123 Bind "" "cu1" 9 0 0 0 0 0 0 0 0 0 9 3 'EEE' 3 '100' 2 '44' 10 '2024-04-08' 4 '0.00' -1 26 '2024-04-08 17:39:22.681000' 4 'mike' -1 1 0 2024-04-08 19:39:22.684769 F 6 Describe P "" 2024-04-08 19:39:22.684770 F 9 Execute "" 0 2024-04-08 19:39:22.684771 F 4 Sync 2024-04-08 19:39:22.684956 B 4 BindComplete 2024-04-08 19:39:22.684958 B 55 RowDescription 2 "book_id" 25034 1 23 4 -1 0 "case" 0 0 20 8 -1 0 2024-04-08 19:39:22.684962 B 194 ErrorResponse S "ERROR" V "ERROR" C "23505" M "duplicate key value violates unique constraint "book_b_isbn_key"" D "Key (b_isbn)=(44) already exists." s "public" t "book" n "book_b_isbn_key" F "nbtinsert.c" L "666" R "_bt_check_unique" \x00 2024-04-08 19:39:22.684974 B 5 ReadyForQuery E 2024-04-08 19:39:22.685061 F 30 Query "rollback to savepoint sp1" 2024-04-08 19:39:22.685085 B 13 CommandComplete "ROLLBACK" 2024-04-08 19:39:22.685086 B 5 ReadyForQuery T 2024-04-08 19:39:22.685099 F 19 Query "deallocate cu1" 2024-04-08 19:39:22.685118 B 15 CommandComplete "DEALLOCATE" 2024-04-08 19:39:22.685119 B 5 ReadyForQuery T 2024-04-08 19:39:22.685159 F 19 Query "deallocate cu0" 2024-04-08 19:39:22.685177 B 15 CommandComplete "DEALLOCATE" 2024-04-08 19:39:22.685178 B 5 ReadyForQuery T 2024-04-08 19:39:22.685182 F 13 Query "rollback" 2024-04-08 19:39:22.685214 B 13 CommandComplete "ROLLBACK" 2024-04-08 19:39:22.685215 B 5 ReadyForQuery I 2024-04-08 19:39:22.685262 F 10 Query "begin" 2024-04-08 19:39:22.685281 B 10 CommandComplete "BEGIN" 2024-04-08 19:39:22.685282 B 5 ReadyForQuery T 2024-04-08 19:39:22.685378 F 250 Parse "cu0" "declare srv_cu0 cursor for select udsi_table_name, udsi_last_mtime, udsi_temp_mtime, udsi_can_insert, udsi_can_update, udsi_can_delete, udsi_where_part, udsi_position from dbsync_udsinfo where udsi_user_id = $1 order by udsi_position" 1 1043 2024-04-08 19:39:22.685381 F 4 Sync 2024-04-08 19:39:22.685419 B 4 ParseComplete 2024-04-08 19:39:22.685420 B 5 ReadyForQuery T 2024-04-08 19:39:22.685422 F 27 Bind "" "cu0" 1 0 1 4 'mike' 1 0 2024-04-08 19:39:22.685423 F 6 Describe P "" 2024-04-08 19:39:22.685424 F 9 Execute "" 0 2024-04-08 19:39:22.685425 F 4 Sync 2024-04-08 19:39:22.685472 B 4 BindComplete 2024-04-08 19:39:22.685473 B 4 NoData 2024-04-08 19:39:22.685474 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 19:39:22.685475 B 5 ReadyForQuery T 2024-04-08 19:39:22.685477 F 34 Query "fetch absolute 0 from srv_cu0" 2024-04-08 19:39:22.685500 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 19:39:22.685503 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.685504 B 5 ReadyForQuery T 2024-04-08 19:39:22.685531 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 19:39:22.685560 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 19:39:22.685563 B 71 DataRow 8 6 'author' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '1' 2024-04-08 19:39:22.685565 B 69 DataRow 8 4 'book' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '2' 2024-04-08 19:39:22.685566 B 12 CommandComplete "FETCH 2" 2024-04-08 19:39:22.685567 B 5 ReadyForQuery T 2024-04-08 19:39:22.685658 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 19:39:22.685678 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 19:39:22.685681 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.685682 B 5 ReadyForQuery T 2024-04-08 19:39:22.685731 F 18 Query "close srv_cu0" 2024-04-08 19:39:22.685751 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 19:39:22.685752 B 5 ReadyForQuery T 2024-04-08 19:39:22.685803 F 104 Parse "" "update dbsync_udsinfo SET udsi_user_id = udsi_user_id WHERE udsi_table_name IN ('author','book')" 0 2024-04-08 19:39:22.685805 F 14 Bind "" "" 0 0 1 0 2024-04-08 19:39:22.685806 F 6 Describe P "" 2024-04-08 19:39:22.685807 F 9 Execute "" 0 2024-04-08 19:39:22.685808 F 4 Sync 2024-04-08 19:39:22.685873 B 4 ParseComplete 2024-04-08 19:39:22.685875 B 4 BindComplete 2024-04-08 19:39:22.685876 B 4 NoData 2024-04-08 19:39:22.685877 B 13 CommandComplete "UPDATE 4" 2024-04-08 19:39:22.685878 B 5 ReadyForQuery T 2024-04-08 19:39:22.685921 F 106 Parse "" "select udsi_user_id from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 19:39:22.685922 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 19:39:22.685924 F 6 Describe P "" 2024-04-08 19:39:22.685925 F 9 Execute "" 0 2024-04-08 19:39:22.685926 F 4 Sync 2024-04-08 19:39:22.685977 B 4 ParseComplete 2024-04-08 19:39:22.685978 B 4 BindComplete 2024-04-08 19:39:22.685979 B 37 RowDescription 1 "udsi_user_id" 25071 1 1043 65535 24 0 2024-04-08 19:39:22.685981 B 14 DataRow 1 4 'mike' 2024-04-08 19:39:22.685982 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.685983 B 5 ReadyForQuery T 2024-04-08 19:39:22.686037 F 106 Parse "" "select udsi_user_id from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 19:39:22.686039 F 34 Bind "" "" 2 0 0 2 4 'mike' 4 'book' 1 0 2024-04-08 19:39:22.686040 F 6 Describe P "" 2024-04-08 19:39:22.686041 F 9 Execute "" 0 2024-04-08 19:39:22.686042 F 4 Sync 2024-04-08 19:39:22.686087 B 4 ParseComplete 2024-04-08 19:39:22.686088 B 4 BindComplete 2024-04-08 19:39:22.686089 B 37 RowDescription 1 "udsi_user_id" 25071 1 1043 65535 24 0 2024-04-08 19:39:22.686091 B 14 DataRow 1 4 'mike' 2024-04-08 19:39:22.686092 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.686093 B 5 ReadyForQuery T 2024-04-08 19:39:22.686141 F 19 Query "deallocate cu0" 2024-04-08 19:39:22.686162 B 15 CommandComplete "DEALLOCATE" 2024-04-08 19:39:22.686163 B 5 ReadyForQuery T 2024-04-08 19:39:22.686227 F 250 Parse "cu0" "declare srv_cu0 cursor for select udsi_table_name, udsi_last_mtime, udsi_temp_mtime, udsi_can_insert, udsi_can_update, udsi_can_delete, udsi_where_part, udsi_position from dbsync_udsinfo where udsi_user_id = $1 order by udsi_position" 1 1043 2024-04-08 19:39:22.686228 F 4 Sync 2024-04-08 19:39:22.686256 B 4 ParseComplete 2024-04-08 19:39:22.686258 B 5 ReadyForQuery T 2024-04-08 19:39:22.686259 F 27 Bind "" "cu0" 1 0 1 4 'mike' 1 0 2024-04-08 19:39:22.686260 F 6 Describe P "" 2024-04-08 19:39:22.686261 F 9 Execute "" 0 2024-04-08 19:39:22.686262 F 4 Sync 2024-04-08 19:39:22.686300 B 4 BindComplete 2024-04-08 19:39:22.686301 B 4 NoData 2024-04-08 19:39:22.686302 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 19:39:22.686303 B 5 ReadyForQuery T 2024-04-08 19:39:22.686305 F 34 Query "fetch absolute 0 from srv_cu0" 2024-04-08 19:39:22.686325 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 19:39:22.686328 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.686329 B 5 ReadyForQuery T 2024-04-08 19:39:22.686353 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 19:39:22.686380 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 19:39:22.686383 B 71 DataRow 8 6 'author' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '1' 2024-04-08 19:39:22.686385 B 69 DataRow 8 4 'book' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '2' 2024-04-08 19:39:22.686386 B 12 CommandComplete "FETCH 2" 2024-04-08 19:39:22.686387 B 5 ReadyForQuery T 2024-04-08 19:39:22.686480 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 19:39:22.686499 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 19:39:22.686502 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.686503 B 5 ReadyForQuery T 2024-04-08 19:39:22.686548 F 18 Query "close srv_cu0" 2024-04-08 19:39:22.686566 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 19:39:22.686567 B 5 ReadyForQuery T 2024-04-08 19:39:22.686642 F 109 Parse "" "select udsi_where_part from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 19:39:22.686644 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 19:39:22.686645 F 6 Describe P "" 2024-04-08 19:39:22.686646 F 9 Execute "" 0 2024-04-08 19:39:22.686647 F 4 Sync 2024-04-08 19:39:22.686692 B 4 ParseComplete 2024-04-08 19:39:22.686693 B 4 BindComplete 2024-04-08 19:39:22.686695 B 40 RowDescription 1 "udsi_where_part" 25071 7 1043 65535 2004 0 2024-04-08 19:39:22.686696 B 10 DataRow 1 -1 2024-04-08 19:39:22.686697 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.686698 B 5 ReadyForQuery T 2024-04-08 19:39:22.686771 F 109 Parse "" "select udsi_where_part from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 19:39:22.686772 F 34 Bind "" "" 2 0 0 2 4 'mike' 4 'book' 1 0 2024-04-08 19:39:22.686774 F 6 Describe P "" 2024-04-08 19:39:22.686775 F 9 Execute "" 0 2024-04-08 19:39:22.686776 F 4 Sync 2024-04-08 19:39:22.686819 B 4 ParseComplete 2024-04-08 19:39:22.686820 B 4 BindComplete 2024-04-08 19:39:22.686822 B 40 RowDescription 1 "udsi_where_part" 25071 7 1043 65535 2004 0 2024-04-08 19:39:22.686823 B 10 DataRow 1 -1 2024-04-08 19:39:22.686824 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.686825 B 5 ReadyForQuery T 2024-04-08 19:39:22.686883 F 109 Parse "" "select udsi_where_part from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 19:39:22.686885 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 19:39:22.686886 F 6 Describe P "" 2024-04-08 19:39:22.686887 F 9 Execute "" 0 2024-04-08 19:39:22.686888 F 4 Sync 2024-04-08 19:39:22.686929 B 4 ParseComplete 2024-04-08 19:39:22.686931 B 4 BindComplete 2024-04-08 19:39:22.686932 B 40 RowDescription 1 "udsi_where_part" 25071 7 1043 65535 2004 0 2024-04-08 19:39:22.686933 B 10 DataRow 1 -1 2024-04-08 19:39:22.686934 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.686935 B 5 ReadyForQuery T 2024-04-08 19:39:22.687030 F 61 Parse "cu1" "declare srv_cu1 cursor for select * from author " 0 2024-04-08 19:39:22.687032 F 4 Sync 2024-04-08 19:39:22.687081 B 4 ParseComplete 2024-04-08 19:39:22.687082 B 5 ReadyForQuery T 2024-04-08 19:39:22.687083 F 17 Bind "" "cu1" 0 0 1 0 2024-04-08 19:39:22.687085 F 6 Describe P "" 2024-04-08 19:39:22.687086 F 9 Execute "" 0 2024-04-08 19:39:22.687087 F 4 Sync 2024-04-08 19:39:22.687148 B 4 BindComplete 2024-04-08 19:39:22.687150 B 4 NoData 2024-04-08 19:39:22.687151 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 19:39:22.687152 B 5 ReadyForQuery T 2024-04-08 19:39:22.687153 F 34 Query "fetch absolute 0 from srv_cu1" 2024-04-08 19:39:22.687177 B 141 RowDescription 5 "auth_id" 25027 1 23 4 -1 0 "a_name" 25027 2 1043 65535 54 0 "aut_muser" 25027 33 1043 65535 24 0 "aut_mtime" 25027 34 1114 8 3 0 "aut_mstat" 25027 35 1042 65535 5 0 2024-04-08 19:39:22.687179 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.687180 B 5 ReadyForQuery T 2024-04-08 19:39:22.687204 F 34 Query "fetch forward 50 from srv_cu1" 2024-04-08 19:39:22.687226 B 141 RowDescription 5 "auth_id" 25027 1 23 4 -1 0 "a_name" 25027 2 1043 65535 54 0 "aut_muser" 25027 33 1043 65535 24 0 "aut_mtime" 25027 34 1114 8 3 0 "aut_mstat" 25027 35 1042 65535 5 0 2024-04-08 19:39:22.687229 B 45 DataRow 5 3 '100' 16 '<unknown author>' -1 -1 -1 2024-04-08 19:39:22.687231 B 41 DataRow 5 3 '101' 12 'Stephen KING' -1 -1 -1 2024-04-08 19:39:22.687232 B 44 DataRow 5 3 '102' 15 'James Patterson' -1 -1 -1 2024-04-08 19:39:22.687233 B 38 DataRow 5 3 '103' 9 'Dan Brown' -1 -1 -1 2024-04-08 19:39:22.687234 B 12 CommandComplete "FETCH 4" 2024-04-08 19:39:22.687235 B 5 ReadyForQuery T 2024-04-08 19:39:22.687430 F 34 Query "fetch forward 50 from srv_cu1" 2024-04-08 19:39:22.687450 B 141 RowDescription 5 "auth_id" 25027 1 23 4 -1 0 "a_name" 25027 2 1043 65535 54 0 "aut_muser" 25027 33 1043 65535 24 0 "aut_mtime" 25027 34 1114 8 3 0 "aut_mstat" 25027 35 1042 65535 5 0 2024-04-08 19:39:22.687453 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.687454 B 5 ReadyForQuery T 2024-04-08 19:39:22.687492 F 18 Query "close srv_cu1" 2024-04-08 19:39:22.687509 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 19:39:22.687511 B 5 ReadyForQuery T 2024-04-08 19:39:22.687540 F 19 Query "deallocate cu1" 2024-04-08 19:39:22.687557 B 15 CommandComplete "DEALLOCATE" 2024-04-08 19:39:22.687559 B 5 ReadyForQuery T 2024-04-08 19:39:22.687611 F 59 Parse "cu1" "declare srv_cu1 cursor for select * from book " 0 2024-04-08 19:39:22.687612 F 4 Sync 2024-04-08 19:39:22.687637 B 4 ParseComplete 2024-04-08 19:39:22.687639 B 5 ReadyForQuery T 2024-04-08 19:39:22.687640 F 17 Bind "" "cu1" 0 0 1 0 2024-04-08 19:39:22.687641 F 6 Describe P "" 2024-04-08 19:39:22.687642 F 9 Execute "" 0 2024-04-08 19:39:22.687643 F 4 Sync 2024-04-08 19:39:22.687709 B 4 BindComplete 2024-04-08 19:39:22.687710 B 4 NoData 2024-04-08 19:39:22.687711 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 19:39:22.687712 B 5 ReadyForQuery T 2024-04-08 19:39:22.687714 F 34 Query "fetch absolute 0 from srv_cu1" 2024-04-08 19:39:22.687734 B 274 RowDescription 10 "book_id" 25034 1 23 4 -1 0 "b_title" 25034 2 1043 65535 104 0 "b_author" 25034 3 23 4 -1 0 "b_isbn" 25034 4 1043 65535 24 0 "b_pub_date" 25034 5 1082 4 -1 0 "b_price" 25034 6 1700 65535 655366 0 "b_plot" 25034 7 1043 65535 504 0 "boo_muser" 25034 29 1043 65535 24 0 "boo_mtime" 25034 30 1114 8 3 0 "boo_mstat" 25034 31 1042 65535 5 0 2024-04-08 19:39:22.687737 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.687738 B 5 ReadyForQuery T 2024-04-08 19:39:22.687760 F 34 Query "fetch forward 50 from srv_cu1" 2024-04-08 19:39:22.687798 B 274 RowDescription 10 "book_id" 25034 1 23 4 -1 0 "b_title" 25034 2 1043 65535 104 0 "b_author" 25034 3 23 4 -1 0 "b_isbn" 25034 4 1043 65535 24 0 "b_pub_date" 25034 5 1082 4 -1 0 "b_price" 25034 6 1700 65535 655366 0 "b_plot" 25034 7 1043 65535 504 0 "boo_muser" 25034 29 1043 65535 24 0 "boo_mtime" 25034 30 1114 8 3 0 "boo_mstat" 25034 31 1042 65535 5 0 2024-04-08 19:39:22.687801 B 295 DataRow 10 5 '10103' 13 'The Long Walk' 3 '101' 17 '978-0-451-08754-6' 10 '1979-07-11' 5 '14.30' 196 'In a dystopian America, a major source of entertainment is the Long Walk, in which one hundred teenage boys walk without rest along U.S. Route 1. Each Walker must stay above four miles per hour...' -1 -1 -1 2024-04-08 19:39:22.687803 B 352 DataRow 10 5 '10202' 14 'Kiss the Girls' 3 '102' 13 '0-316-69370-7' 10 '1995-01-11' 5 '12.40' 256 'As a teenage boy in 1975 Boca Raton, Florida, a future serial killer calling himself Casanova kills his first four victims. Elsewhere in 1981 Chapel Hill, North Carolina, another killer calling himself The Gentleman Caller kills a young couple on a lake...' -1 -1 -1 2024-04-08 19:39:22.687805 B 389 DataRow 10 5 '10301' 16 'Digital Fortress' 3 '103' 13 '0-312-18087-X' 10 '1998-01-01' 5 '10.20' 291 'The story is set in the year of 1996. When the United States National Security Agency's (NSA) code-breaking supercomputer TRANSLTR encounters a revolutionary new code, Digital Fortress, that it cannot break, Commander Trevor Strathmore calls in head cryptographer Susan Fletcher to crack it.' -1 -1 -1 2024-04-08 19:39:22.687807 B 562 DataRow 10 5 '10304' 15 'The Lost Symbol' 3 '103' 18 '978-0-385-50422-5 ' 10 '2009-09-15' 5 '11.40' 460 'Renowned Harvard symbologist Robert Langdon is invited to give a lecture at the United States Capitol, at the invitation apparently from his mentor, a 33rd degree Mason named Peter Solomon, who is the head of the Smithsonian Institution. Solomon has also asked him to bring a small, sealed package which he had entrusted to Langdon years earlier. When Langdon arrives at the Capitol, however, he learns that the invitation he received was not from Solomon, ...' -1 -1 -1 2024-04-08 19:39:22.687809 B 150 DataRow 10 5 '10201' 19 'Along Came a Spider' 3 '102' 13 '0-316-69364-2' 10 '1993-03-23' 6 '111.20' 21 'XXXXXXXXXXEEFFFFFFFFF' 4 'mike' 23 '2024-04-06 15:52:29.806' -1 2024-04-08 19:39:22.687811 B 541 DataRow 10 5 '10302' 15 'Angels & Demons' 3 '103' 14 '0-671-02735-2 ' 10 '2000-04-01' 5 '14.55' 417 'Leonardo Vetra, one of CERN's top physicists who have discovered how to create antimatter, is murdered, his chest branded with an ambigram of the word "Illuminati", an ancient anti-religious organization thought extinct. CERN director Maximilian Kohler calls Vetra's adopted daughter, Vittoria, and Robert Langdon, an expert on symbology and religious history, for help. After determining the ambigram is authentic...' 3 'ted' 23 '2024-04-06 15:52:51.803' -1 2024-04-08 19:39:22.687813 B 99 DataRow 10 5 '20057' 3 'EEE' 3 '100' 2 '44' 10 '2024-04-08' 4 '0.00' -1 3 'ted' 23 '2024-04-08 12:59:54.496' -1 2024-04-08 19:39:22.687815 B 397 DataRow 10 5 '10101' 12 'The Talisman' 3 '101' 17 '978-0-670-69199-9' 10 '1984-11-08' 5 '15.60' 274 'Jack Sawyer, twelve years old, sets out from Arcadia Beach, New Hampshire, in a bid to save his mother Lily, who is dying from cancer, by finding a crystal called "the Talisman". Jack's journey takes him simultaneously through the American heartland and "the Territories"...' 3 'ted' 22 '2024-04-03 10:56:54.38' -1 2024-04-08 19:39:22.687817 B 438 DataRow 10 5 '10303' 17 'The Da Vinci Code' 3 '103' 13 '0-385-50420-9' 10 '2003-03-18' 5 '11.00' 317 'Louvre curator and Priory of Sion grand master Jacques Sauni\xffffffc3\xffffffa8re is fatally shot one night at the museum by an albino Catholic monk named Silas, who is working on behalf of someone he knows only as the Teacher, who wishes to discover the location of the "keystone," an item crucial in the search for the Holy Grail...' 3 'ted' 19 '2024-04-03 09:52:01' -1 2024-04-08 19:39:22.687819 B 460 DataRow 10 5 '10104' 11 'Firestarter' 3 '101' 14 '978-0670315413' 10 '1980-09-29' 5 '13.50' 340 'XXXXXXXXXEEEEEEEEEEEEEEEEEEEEEEEWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWW\x0aWWWW\x0a\x0aXXXEEEEEEEEEEEEEEEEEEEEEEEWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWW\x0aWWWW\x0a\x0aWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWW\x0aWWWW\x0a\x0aXXXEEEEEEEEEEEEEEEEEEEEEEEWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWW\x0aWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWW\x0aWWWW\x0a\x0aXXXEEEEEEEEEEEEEEEEEEEEEEEWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWW\x0aWWWW' 3 'ted' 23 '2024-04-04 14:33:57.069' -1 2024-04-08 19:39:22.687826 B 358 DataRow 10 5 '10203' 16 'The Big Bad Wolf' 3 '102' 17 '978-0-316-60290-7' 10 '2003-11-17' 5 '12.50' 230 'Cross is in the middle of his training at the FBI when he is assigned to work on a kidnapping case. A federal judge's wife has been kidnapped, and Cross discovers that her kidnapping fits the pattern of other recent kidnappings...' 3 'ted' 23 '2024-04-05 13:51:37.577' -1 2024-04-08 19:39:22.687828 B 141 DataRow 10 5 '10102' 12 'Doctor Sleep' 3 '101' 17 '978-1-4767-2765-3' 10 '2013-09-24' 5 '12.00' 16 'weeeeeeeeeeeeeee' 4 'mike' 23 '2024-04-05 15:12:47.079' -1 2024-04-08 19:39:22.687830 B 13 CommandComplete "FETCH 12" 2024-04-08 19:39:22.687831 B 5 ReadyForQuery T 2024-04-08 19:39:22.689023 F 34 Query "fetch forward 50 from srv_cu1" 2024-04-08 19:39:22.689074 B 274 RowDescription 10 "book_id" 25034 1 23 4 -1 0 "b_title" 25034 2 1043 65535 104 0 "b_author" 25034 3 23 4 -1 0 "b_isbn" 25034 4 1043 65535 24 0 "b_pub_date" 25034 5 1082 4 -1 0 "b_price" 25034 6 1700 65535 655366 0 "b_plot" 25034 7 1043 65535 504 0 "boo_muser" 25034 29 1043 65535 24 0 "boo_mtime" 25034 30 1114 8 3 0 "boo_mstat" 25034 31 1042 65535 5 0 2024-04-08 19:39:22.689078 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.689079 B 5 ReadyForQuery T 2024-04-08 19:39:22.689134 F 18 Query "close srv_cu1" 2024-04-08 19:39:22.689152 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 19:39:22.689154 B 5 ReadyForQuery T 2024-04-08 19:39:22.689190 F 19 Query "deallocate cu1" 2024-04-08 19:39:22.689207 B 15 CommandComplete "DEALLOCATE" 2024-04-08 19:39:22.689209 B 5 ReadyForQuery T 2024-04-08 19:39:22.689265 F 64 Parse "cu1" "declare srv_cu1 cursor for select book_id from book" 0 2024-04-08 19:39:22.689266 F 4 Sync 2024-04-08 19:39:22.689290 B 4 ParseComplete 2024-04-08 19:39:22.689291 B 5 ReadyForQuery T 2024-04-08 19:39:22.689292 F 17 Bind "" "cu1" 0 0 1 0 2024-04-08 19:39:22.689294 F 6 Describe P "" 2024-04-08 19:39:22.689295 F 9 Execute "" 0 2024-04-08 19:39:22.689296 F 4 Sync 2024-04-08 19:39:22.689326 B 4 BindComplete 2024-04-08 19:39:22.689327 B 4 NoData 2024-04-08 19:39:22.689328 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 19:39:22.689329 B 5 ReadyForQuery T 2024-04-08 19:39:22.689330 F 34 Query "fetch absolute 0 from srv_cu1" 2024-04-08 19:39:22.689349 B 32 RowDescription 1 "book_id" 25034 1 23 4 -1 0 2024-04-08 19:39:22.689351 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.689352 B 5 ReadyForQuery T 2024-04-08 19:39:22.689370 F 34 Query "fetch forward 50 from srv_cu1" 2024-04-08 19:39:22.689392 B 32 RowDescription 1 "book_id" 25034 1 23 4 -1 0 2024-04-08 19:39:22.689394 B 15 DataRow 1 5 '10103' 2024-04-08 19:39:22.689395 B 15 DataRow 1 5 '10202' 2024-04-08 19:39:22.689396 B 15 DataRow 1 5 '10301' 2024-04-08 19:39:22.689397 B 15 DataRow 1 5 '10304' 2024-04-08 19:39:22.689398 B 15 DataRow 1 5 '10201' 2024-04-08 19:39:22.689399 B 15 DataRow 1 5 '10302' 2024-04-08 19:39:22.689400 B 15 DataRow 1 5 '20057' 2024-04-08 19:39:22.689401 B 15 DataRow 1 5 '10101' 2024-04-08 19:39:22.689402 B 15 DataRow 1 5 '10303' 2024-04-08 19:39:22.689403 B 15 DataRow 1 5 '10104' 2024-04-08 19:39:22.689404 B 15 DataRow 1 5 '10203' 2024-04-08 19:39:22.689405 B 15 DataRow 1 5 '10102' 2024-04-08 19:39:22.689406 B 13 CommandComplete "FETCH 12" 2024-04-08 19:39:22.689407 B 5 ReadyForQuery T 2024-04-08 19:39:22.689643 F 34 Query "fetch forward 50 from srv_cu1" 2024-04-08 19:39:22.689661 B 32 RowDescription 1 "book_id" 25034 1 23 4 -1 0 2024-04-08 19:39:22.689663 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.689664 B 5 ReadyForQuery T 2024-04-08 19:39:22.689688 F 18 Query "close srv_cu1" 2024-04-08 19:39:22.689727 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 19:39:22.689729 B 5 ReadyForQuery T 2024-04-08 19:39:22.689769 F 19 Query "deallocate cu1" 2024-04-08 19:39:22.689786 B 15 CommandComplete "DEALLOCATE" 2024-04-08 19:39:22.689787 B 5 ReadyForQuery T 2024-04-08 19:39:22.689841 F 66 Parse "cu1" "declare srv_cu1 cursor for select auth_id from author" 0 2024-04-08 19:39:22.689842 F 4 Sync 2024-04-08 19:39:22.689864 B 4 ParseComplete 2024-04-08 19:39:22.689866 B 5 ReadyForQuery T 2024-04-08 19:39:22.689867 F 17 Bind "" "cu1" 0 0 1 0 2024-04-08 19:39:22.689868 F 6 Describe P "" 2024-04-08 19:39:22.689869 F 9 Execute "" 0 2024-04-08 19:39:22.689870 F 4 Sync 2024-04-08 19:39:22.689898 B 4 BindComplete 2024-04-08 19:39:22.689899 B 4 NoData 2024-04-08 19:39:22.689900 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 19:39:22.689901 B 5 ReadyForQuery T 2024-04-08 19:39:22.689903 F 34 Query "fetch absolute 0 from srv_cu1" 2024-04-08 19:39:22.689924 B 32 RowDescription 1 "auth_id" 25027 1 23 4 -1 0 2024-04-08 19:39:22.689926 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.689927 B 5 ReadyForQuery T 2024-04-08 19:39:22.689946 F 34 Query "fetch forward 50 from srv_cu1" 2024-04-08 19:39:22.689965 B 32 RowDescription 1 "auth_id" 25027 1 23 4 -1 0 2024-04-08 19:39:22.689967 B 13 DataRow 1 3 '100' 2024-04-08 19:39:22.689968 B 13 DataRow 1 3 '101' 2024-04-08 19:39:22.689969 B 13 DataRow 1 3 '102' 2024-04-08 19:39:22.689970 B 13 DataRow 1 3 '103' 2024-04-08 19:39:22.689971 B 12 CommandComplete "FETCH 4" 2024-04-08 19:39:22.689972 B 5 ReadyForQuery T 2024-04-08 19:39:22.690054 F 34 Query "fetch forward 50 from srv_cu1" 2024-04-08 19:39:22.690072 B 32 RowDescription 1 "auth_id" 25027 1 23 4 -1 0 2024-04-08 19:39:22.690073 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.690074 B 5 ReadyForQuery T 2024-04-08 19:39:22.690099 F 18 Query "close srv_cu1" 2024-04-08 19:39:22.690115 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 19:39:22.690116 B 5 ReadyForQuery T 2024-04-08 19:39:22.690139 F 19 Query "deallocate cu1" 2024-04-08 19:39:22.690158 B 15 CommandComplete "DEALLOCATE" 2024-04-08 19:39:22.690160 B 5 ReadyForQuery T 2024-04-08 19:39:22.690199 F 115 Parse "" "update dbsync_udsinfo SET udsi_temp_mtime = $1 WHERE udsi_user_id = $2 AND udsi_table_name = $3" 3 1114 1043 1043 2024-04-08 19:39:22.690201 F 68 Bind "" "" 3 0 0 0 3 26 '2024-04-08 17:39:22.685000' 4 'mike' 6 'author' 1 0 2024-04-08 19:39:22.690203 F 6 Describe P "" 2024-04-08 19:39:22.690204 F 9 Execute "" 0 2024-04-08 19:39:22.690205 F 4 Sync 2024-04-08 19:39:22.690371 B 4 ParseComplete 2024-04-08 19:39:22.690372 B 4 BindComplete 2024-04-08 19:39:22.690373 B 4 NoData 2024-04-08 19:39:22.690374 B 13 CommandComplete "UPDATE 1" 2024-04-08 19:39:22.690375 B 5 ReadyForQuery T 2024-04-08 19:39:22.690429 F 115 Parse "" "update dbsync_udsinfo SET udsi_temp_mtime = $1 WHERE udsi_user_id = $2 AND udsi_table_name = $3" 3 1114 1043 1043 2024-04-08 19:39:22.690431 F 66 Bind "" "" 3 0 0 0 3 26 '2024-04-08 17:39:22.685000' 4 'mike' 4 'book' 1 0 2024-04-08 19:39:22.690432 F 6 Describe P "" 2024-04-08 19:39:22.690433 F 9 Execute "" 0 2024-04-08 19:39:22.690434 F 4 Sync 2024-04-08 19:39:22.690517 B 4 ParseComplete 2024-04-08 19:39:22.690518 B 4 BindComplete 2024-04-08 19:39:22.690519 B 4 NoData 2024-04-08 19:39:22.690520 B 13 CommandComplete "UPDATE 1" 2024-04-08 19:39:22.690521 B 5 ReadyForQuery T 2024-04-08 19:39:22.690548 F 19 Query "deallocate cu0" 2024-04-08 19:39:22.690568 B 15 CommandComplete "DEALLOCATE" 2024-04-08 19:39:22.690570 B 5 ReadyForQuery T 2024-04-08 19:39:22.690574 F 11 Query "commit" 2024-04-08 19:39:22.692828 B 11 CommandComplete "COMMIT" 2024-04-08 19:39:22.692839 B 5 ReadyForQuery I 2024-04-08 19:39:22.692895 F 4 Terminate Attachments: [text/plain] pgs_trace_savepoint.txt (34.9K, 3-pgs_trace_savepoint.txt) download | inline: 2024-04-08 19:39:22.679893 F 33 Query "set intervalstyle='iso_8601'" 2024-04-08 19:39:22.679989 B 8 CommandComplete "SET" 2024-04-08 19:39:22.679993 B 27 ParameterStatus "IntervalStyle" "iso_8601" 2024-04-08 19:39:22.679994 B 5 ReadyForQuery I 2024-04-08 19:39:22.680029 F 67 Query "update pg_settings set setting=10000 where name='lock_timeout'" 2024-04-08 19:39:22.680939 B 35 RowDescription 1 "set_config" 0 0 25 65535 -1 0 2024-04-08 19:39:22.680945 B 13 DataRow 1 3 '10s' 2024-04-08 19:39:22.680947 B 13 CommandComplete "UPDATE 0" 2024-04-08 19:39:22.680948 B 5 ReadyForQuery I 2024-04-08 19:39:22.681035 F 10 Query "begin" 2024-04-08 19:39:22.681150 B 10 CommandComplete "BEGIN" 2024-04-08 19:39:22.681155 B 5 ReadyForQuery T 2024-04-08 19:39:22.681306 F 250 Parse "cu0" "declare srv_cu0 cursor for select udsi_table_name, udsi_last_mtime, udsi_temp_mtime, udsi_can_insert, udsi_can_update, udsi_can_delete, udsi_where_part, udsi_position from dbsync_udsinfo where udsi_user_id = $1 order by udsi_position" 1 1043 2024-04-08 19:39:22.681308 F 4 Sync 2024-04-08 19:39:22.681739 B 4 ParseComplete 2024-04-08 19:39:22.681744 B 5 ReadyForQuery T 2024-04-08 19:39:22.681748 F 27 Bind "" "cu0" 1 0 1 4 'mike' 1 0 2024-04-08 19:39:22.681750 F 6 Describe P "" 2024-04-08 19:39:22.681751 F 9 Execute "" 0 2024-04-08 19:39:22.681752 F 4 Sync 2024-04-08 19:39:22.682027 B 4 BindComplete 2024-04-08 19:39:22.682033 B 4 NoData 2024-04-08 19:39:22.682034 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 19:39:22.682036 B 5 ReadyForQuery T 2024-04-08 19:39:22.682038 F 34 Query "fetch absolute 0 from srv_cu0" 2024-04-08 19:39:22.682126 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 19:39:22.682131 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.682132 B 5 ReadyForQuery T 2024-04-08 19:39:22.682175 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 19:39:22.682277 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 19:39:22.682280 B 71 DataRow 8 6 'author' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '1' 2024-04-08 19:39:22.682282 B 69 DataRow 8 4 'book' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '2' 2024-04-08 19:39:22.682284 B 12 CommandComplete "FETCH 2" 2024-04-08 19:39:22.682285 B 5 ReadyForQuery T 2024-04-08 19:39:22.682386 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 19:39:22.682411 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 19:39:22.682414 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.682415 B 5 ReadyForQuery T 2024-04-08 19:39:22.682467 F 18 Query "close srv_cu0" 2024-04-08 19:39:22.682488 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 19:39:22.682490 B 5 ReadyForQuery T 2024-04-08 19:39:22.682557 F 104 Parse "" "update dbsync_udsinfo SET udsi_user_id = udsi_user_id WHERE udsi_table_name IN ('author','book')" 0 2024-04-08 19:39:22.682559 F 14 Bind "" "" 0 0 1 0 2024-04-08 19:39:22.682560 F 6 Describe P "" 2024-04-08 19:39:22.682561 F 9 Execute "" 0 2024-04-08 19:39:22.682562 F 4 Sync 2024-04-08 19:39:22.682762 B 4 ParseComplete 2024-04-08 19:39:22.682763 B 4 BindComplete 2024-04-08 19:39:22.682764 B 4 NoData 2024-04-08 19:39:22.682765 B 13 CommandComplete "UPDATE 4" 2024-04-08 19:39:22.682766 B 5 ReadyForQuery T 2024-04-08 19:39:22.682821 F 137 Parse "" "select udsi_last_mtime from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2 AND udsi_temp_mtime IS NULL" 2 1043 1043 2024-04-08 19:39:22.682822 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 19:39:22.682824 F 6 Describe P "" 2024-04-08 19:39:22.682825 F 9 Execute "" 0 2024-04-08 19:39:22.682826 F 4 Sync 2024-04-08 19:39:22.682892 B 4 ParseComplete 2024-04-08 19:39:22.682893 B 4 BindComplete 2024-04-08 19:39:22.682895 B 40 RowDescription 1 "udsi_last_mtime" 25071 8 1114 8 3 0 2024-04-08 19:39:22.682896 B 33 DataRow 1 23 '2024-04-08 12:59:40.765' 2024-04-08 19:39:22.682897 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.682898 B 5 ReadyForQuery T 2024-04-08 19:39:22.682957 F 106 Parse "" "select udsi_user_id from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 19:39:22.682958 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 19:39:22.682960 F 6 Describe P "" 2024-04-08 19:39:22.682961 F 9 Execute "" 0 2024-04-08 19:39:22.682962 F 4 Sync 2024-04-08 19:39:22.683009 B 4 ParseComplete 2024-04-08 19:39:22.683011 B 4 BindComplete 2024-04-08 19:39:22.683012 B 37 RowDescription 1 "udsi_user_id" 25071 1 1043 65535 24 0 2024-04-08 19:39:22.683013 B 14 DataRow 1 4 'mike' 2024-04-08 19:39:22.683014 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.683015 B 5 ReadyForQuery T 2024-04-08 19:39:22.683077 F 137 Parse "" "select udsi_last_mtime from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2 AND udsi_temp_mtime IS NULL" 2 1043 1043 2024-04-08 19:39:22.683078 F 34 Bind "" "" 2 0 0 2 4 'mike' 4 'book' 1 0 2024-04-08 19:39:22.683080 F 6 Describe P "" 2024-04-08 19:39:22.683081 F 9 Execute "" 0 2024-04-08 19:39:22.683082 F 4 Sync 2024-04-08 19:39:22.683127 B 4 ParseComplete 2024-04-08 19:39:22.683128 B 4 BindComplete 2024-04-08 19:39:22.683129 B 40 RowDescription 1 "udsi_last_mtime" 25071 8 1114 8 3 0 2024-04-08 19:39:22.683131 B 33 DataRow 1 23 '2024-04-08 12:59:40.765' 2024-04-08 19:39:22.683132 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.683133 B 5 ReadyForQuery T 2024-04-08 19:39:22.683187 F 106 Parse "" "select udsi_user_id from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 19:39:22.683188 F 34 Bind "" "" 2 0 0 2 4 'mike' 4 'book' 1 0 2024-04-08 19:39:22.683190 F 6 Describe P "" 2024-04-08 19:39:22.683191 F 9 Execute "" 0 2024-04-08 19:39:22.683192 F 4 Sync 2024-04-08 19:39:22.683234 B 4 ParseComplete 2024-04-08 19:39:22.683235 B 4 BindComplete 2024-04-08 19:39:22.683237 B 37 RowDescription 1 "udsi_user_id" 25071 1 1043 65535 24 0 2024-04-08 19:39:22.683238 B 14 DataRow 1 4 'mike' 2024-04-08 19:39:22.683239 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.683240 B 5 ReadyForQuery T 2024-04-08 19:39:22.683328 F 18 Query "savepoint sp1" 2024-04-08 19:39:22.683349 B 14 CommandComplete "SAVEPOINT" 2024-04-08 19:39:22.683350 B 5 ReadyForQuery T 2024-04-08 19:39:22.683448 F 425 Query "select ns.nspname||'.'||substring(pg_get_expr(a.adbin,0) from 'nextval.''([^'']*)') seqname , c.attname from pg_class p join pg_attrdef a on (p.oid=a.adrelid) join pg_attribute c on (p.oid=c.attrelid and a.adnum=c.attnum) join pg_namespace ns on (p.relnamespace=ns.oid) where upper(p.relname)=upper('book') and pg_get_expr(a.adbin,0) like 'nextval%' and (ns.nspname=current_schema() or ns.oid=pg_my_temp_schema())" 2024-04-08 19:39:22.684440 B 58 RowDescription 2 "seqname" 0 0 25 65535 -1 0 "attname" 1249 2 19 64 -1 0 2024-04-08 19:39:22.684443 B 44 DataRow 2 23 'public.book_book_id_seq' 7 'book_id' 2024-04-08 19:39:22.684445 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.684446 B 5 ReadyForQuery T 2024-04-08 19:39:22.684622 F 370 Parse "cu1" "insert into book (b_title, b_author, b_isbn, b_pub_date, b_price, b_plot, boo_mtime, boo_muser, boo_mstat) VALUES ($1, $2, $3, $4, $5, $6, $7, $8, $9) returning book.book_id, (select case when book.book_id>(select last_value from public.book_book_id_seq) then setval('public.book_book_id_seq',book.book_id,true) else 0 end)" 9 1043 23 1043 1082 1700 1043 1114 1043 1042 2024-04-08 19:39:22.684623 F 4 Sync 2024-04-08 19:39:22.684763 B 4 ParseComplete 2024-04-08 19:39:22.684765 B 5 ReadyForQuery T 2024-04-08 19:39:22.684766 F 123 Bind "" "cu1" 9 0 0 0 0 0 0 0 0 0 9 3 'EEE' 3 '100' 2 '44' 10 '2024-04-08' 4 '0.00' -1 26 '2024-04-08 17:39:22.681000' 4 'mike' -1 1 0 2024-04-08 19:39:22.684769 F 6 Describe P "" 2024-04-08 19:39:22.684770 F 9 Execute "" 0 2024-04-08 19:39:22.684771 F 4 Sync 2024-04-08 19:39:22.684956 B 4 BindComplete 2024-04-08 19:39:22.684958 B 55 RowDescription 2 "book_id" 25034 1 23 4 -1 0 "case" 0 0 20 8 -1 0 2024-04-08 19:39:22.684962 B 194 ErrorResponse S "ERROR" V "ERROR" C "23505" M "duplicate key value violates unique constraint "book_b_isbn_key"" D "Key (b_isbn)=(44) already exists." s "public" t "book" n "book_b_isbn_key" F "nbtinsert.c" L "666" R "_bt_check_unique" \x00 2024-04-08 19:39:22.684974 B 5 ReadyForQuery E 2024-04-08 19:39:22.685061 F 30 Query "rollback to savepoint sp1" 2024-04-08 19:39:22.685085 B 13 CommandComplete "ROLLBACK" 2024-04-08 19:39:22.685086 B 5 ReadyForQuery T 2024-04-08 19:39:22.685099 F 19 Query "deallocate cu1" 2024-04-08 19:39:22.685118 B 15 CommandComplete "DEALLOCATE" 2024-04-08 19:39:22.685119 B 5 ReadyForQuery T 2024-04-08 19:39:22.685159 F 19 Query "deallocate cu0" 2024-04-08 19:39:22.685177 B 15 CommandComplete "DEALLOCATE" 2024-04-08 19:39:22.685178 B 5 ReadyForQuery T 2024-04-08 19:39:22.685182 F 13 Query "rollback" 2024-04-08 19:39:22.685214 B 13 CommandComplete "ROLLBACK" 2024-04-08 19:39:22.685215 B 5 ReadyForQuery I 2024-04-08 19:39:22.685262 F 10 Query "begin" 2024-04-08 19:39:22.685281 B 10 CommandComplete "BEGIN" 2024-04-08 19:39:22.685282 B 5 ReadyForQuery T 2024-04-08 19:39:22.685378 F 250 Parse "cu0" "declare srv_cu0 cursor for select udsi_table_name, udsi_last_mtime, udsi_temp_mtime, udsi_can_insert, udsi_can_update, udsi_can_delete, udsi_where_part, udsi_position from dbsync_udsinfo where udsi_user_id = $1 order by udsi_position" 1 1043 2024-04-08 19:39:22.685381 F 4 Sync 2024-04-08 19:39:22.685419 B 4 ParseComplete 2024-04-08 19:39:22.685420 B 5 ReadyForQuery T 2024-04-08 19:39:22.685422 F 27 Bind "" "cu0" 1 0 1 4 'mike' 1 0 2024-04-08 19:39:22.685423 F 6 Describe P "" 2024-04-08 19:39:22.685424 F 9 Execute "" 0 2024-04-08 19:39:22.685425 F 4 Sync 2024-04-08 19:39:22.685472 B 4 BindComplete 2024-04-08 19:39:22.685473 B 4 NoData 2024-04-08 19:39:22.685474 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 19:39:22.685475 B 5 ReadyForQuery T 2024-04-08 19:39:22.685477 F 34 Query "fetch absolute 0 from srv_cu0" 2024-04-08 19:39:22.685500 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 19:39:22.685503 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.685504 B 5 ReadyForQuery T 2024-04-08 19:39:22.685531 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 19:39:22.685560 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 19:39:22.685563 B 71 DataRow 8 6 'author' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '1' 2024-04-08 19:39:22.685565 B 69 DataRow 8 4 'book' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '2' 2024-04-08 19:39:22.685566 B 12 CommandComplete "FETCH 2" 2024-04-08 19:39:22.685567 B 5 ReadyForQuery T 2024-04-08 19:39:22.685658 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 19:39:22.685678 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 19:39:22.685681 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.685682 B 5 ReadyForQuery T 2024-04-08 19:39:22.685731 F 18 Query "close srv_cu0" 2024-04-08 19:39:22.685751 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 19:39:22.685752 B 5 ReadyForQuery T 2024-04-08 19:39:22.685803 F 104 Parse "" "update dbsync_udsinfo SET udsi_user_id = udsi_user_id WHERE udsi_table_name IN ('author','book')" 0 2024-04-08 19:39:22.685805 F 14 Bind "" "" 0 0 1 0 2024-04-08 19:39:22.685806 F 6 Describe P "" 2024-04-08 19:39:22.685807 F 9 Execute "" 0 2024-04-08 19:39:22.685808 F 4 Sync 2024-04-08 19:39:22.685873 B 4 ParseComplete 2024-04-08 19:39:22.685875 B 4 BindComplete 2024-04-08 19:39:22.685876 B 4 NoData 2024-04-08 19:39:22.685877 B 13 CommandComplete "UPDATE 4" 2024-04-08 19:39:22.685878 B 5 ReadyForQuery T 2024-04-08 19:39:22.685921 F 106 Parse "" "select udsi_user_id from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 19:39:22.685922 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 19:39:22.685924 F 6 Describe P "" 2024-04-08 19:39:22.685925 F 9 Execute "" 0 2024-04-08 19:39:22.685926 F 4 Sync 2024-04-08 19:39:22.685977 B 4 ParseComplete 2024-04-08 19:39:22.685978 B 4 BindComplete 2024-04-08 19:39:22.685979 B 37 RowDescription 1 "udsi_user_id" 25071 1 1043 65535 24 0 2024-04-08 19:39:22.685981 B 14 DataRow 1 4 'mike' 2024-04-08 19:39:22.685982 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.685983 B 5 ReadyForQuery T 2024-04-08 19:39:22.686037 F 106 Parse "" "select udsi_user_id from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 19:39:22.686039 F 34 Bind "" "" 2 0 0 2 4 'mike' 4 'book' 1 0 2024-04-08 19:39:22.686040 F 6 Describe P "" 2024-04-08 19:39:22.686041 F 9 Execute "" 0 2024-04-08 19:39:22.686042 F 4 Sync 2024-04-08 19:39:22.686087 B 4 ParseComplete 2024-04-08 19:39:22.686088 B 4 BindComplete 2024-04-08 19:39:22.686089 B 37 RowDescription 1 "udsi_user_id" 25071 1 1043 65535 24 0 2024-04-08 19:39:22.686091 B 14 DataRow 1 4 'mike' 2024-04-08 19:39:22.686092 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.686093 B 5 ReadyForQuery T 2024-04-08 19:39:22.686141 F 19 Query "deallocate cu0" 2024-04-08 19:39:22.686162 B 15 CommandComplete "DEALLOCATE" 2024-04-08 19:39:22.686163 B 5 ReadyForQuery T 2024-04-08 19:39:22.686227 F 250 Parse "cu0" "declare srv_cu0 cursor for select udsi_table_name, udsi_last_mtime, udsi_temp_mtime, udsi_can_insert, udsi_can_update, udsi_can_delete, udsi_where_part, udsi_position from dbsync_udsinfo where udsi_user_id = $1 order by udsi_position" 1 1043 2024-04-08 19:39:22.686228 F 4 Sync 2024-04-08 19:39:22.686256 B 4 ParseComplete 2024-04-08 19:39:22.686258 B 5 ReadyForQuery T 2024-04-08 19:39:22.686259 F 27 Bind "" "cu0" 1 0 1 4 'mike' 1 0 2024-04-08 19:39:22.686260 F 6 Describe P "" 2024-04-08 19:39:22.686261 F 9 Execute "" 0 2024-04-08 19:39:22.686262 F 4 Sync 2024-04-08 19:39:22.686300 B 4 BindComplete 2024-04-08 19:39:22.686301 B 4 NoData 2024-04-08 19:39:22.686302 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 19:39:22.686303 B 5 ReadyForQuery T 2024-04-08 19:39:22.686305 F 34 Query "fetch absolute 0 from srv_cu0" 2024-04-08 19:39:22.686325 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 19:39:22.686328 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.686329 B 5 ReadyForQuery T 2024-04-08 19:39:22.686353 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 19:39:22.686380 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 19:39:22.686383 B 71 DataRow 8 6 'author' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '1' 2024-04-08 19:39:22.686385 B 69 DataRow 8 4 'book' 23 '2024-04-08 12:59:40.765' -1 1 'Y' 1 'Y' 1 'Y' -1 1 '2' 2024-04-08 19:39:22.686386 B 12 CommandComplete "FETCH 2" 2024-04-08 19:39:22.686387 B 5 ReadyForQuery T 2024-04-08 19:39:22.686480 F 34 Query "fetch forward 50 from srv_cu0" 2024-04-08 19:39:22.686499 B 276 RowDescription 8 "udsi_table_name" 25071 2 1043 65535 54 0 "udsi_last_mtime" 25071 8 1114 8 3 0 "udsi_temp_mtime" 25071 9 1114 8 3 0 "udsi_can_insert" 25071 4 1042 65535 5 0 "udsi_can_update" 25071 5 1042 65535 5 0 "udsi_can_delete" 25071 6 1042 65535 5 0 "udsi_where_part" 25071 7 1043 65535 2004 0 "udsi_position" 25071 3 23 4 -1 0 2024-04-08 19:39:22.686502 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.686503 B 5 ReadyForQuery T 2024-04-08 19:39:22.686548 F 18 Query "close srv_cu0" 2024-04-08 19:39:22.686566 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 19:39:22.686567 B 5 ReadyForQuery T 2024-04-08 19:39:22.686642 F 109 Parse "" "select udsi_where_part from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 19:39:22.686644 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 19:39:22.686645 F 6 Describe P "" 2024-04-08 19:39:22.686646 F 9 Execute "" 0 2024-04-08 19:39:22.686647 F 4 Sync 2024-04-08 19:39:22.686692 B 4 ParseComplete 2024-04-08 19:39:22.686693 B 4 BindComplete 2024-04-08 19:39:22.686695 B 40 RowDescription 1 "udsi_where_part" 25071 7 1043 65535 2004 0 2024-04-08 19:39:22.686696 B 10 DataRow 1 -1 2024-04-08 19:39:22.686697 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.686698 B 5 ReadyForQuery T 2024-04-08 19:39:22.686771 F 109 Parse "" "select udsi_where_part from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 19:39:22.686772 F 34 Bind "" "" 2 0 0 2 4 'mike' 4 'book' 1 0 2024-04-08 19:39:22.686774 F 6 Describe P "" 2024-04-08 19:39:22.686775 F 9 Execute "" 0 2024-04-08 19:39:22.686776 F 4 Sync 2024-04-08 19:39:22.686819 B 4 ParseComplete 2024-04-08 19:39:22.686820 B 4 BindComplete 2024-04-08 19:39:22.686822 B 40 RowDescription 1 "udsi_where_part" 25071 7 1043 65535 2004 0 2024-04-08 19:39:22.686823 B 10 DataRow 1 -1 2024-04-08 19:39:22.686824 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.686825 B 5 ReadyForQuery T 2024-04-08 19:39:22.686883 F 109 Parse "" "select udsi_where_part from dbsync_udsinfo where udsi_user_id = $1 AND udsi_table_name = $2" 2 1043 1043 2024-04-08 19:39:22.686885 F 36 Bind "" "" 2 0 0 2 4 'mike' 6 'author' 1 0 2024-04-08 19:39:22.686886 F 6 Describe P "" 2024-04-08 19:39:22.686887 F 9 Execute "" 0 2024-04-08 19:39:22.686888 F 4 Sync 2024-04-08 19:39:22.686929 B 4 ParseComplete 2024-04-08 19:39:22.686931 B 4 BindComplete 2024-04-08 19:39:22.686932 B 40 RowDescription 1 "udsi_where_part" 25071 7 1043 65535 2004 0 2024-04-08 19:39:22.686933 B 10 DataRow 1 -1 2024-04-08 19:39:22.686934 B 13 CommandComplete "SELECT 1" 2024-04-08 19:39:22.686935 B 5 ReadyForQuery T 2024-04-08 19:39:22.687030 F 61 Parse "cu1" "declare srv_cu1 cursor for select * from author " 0 2024-04-08 19:39:22.687032 F 4 Sync 2024-04-08 19:39:22.687081 B 4 ParseComplete 2024-04-08 19:39:22.687082 B 5 ReadyForQuery T 2024-04-08 19:39:22.687083 F 17 Bind "" "cu1" 0 0 1 0 2024-04-08 19:39:22.687085 F 6 Describe P "" 2024-04-08 19:39:22.687086 F 9 Execute "" 0 2024-04-08 19:39:22.687087 F 4 Sync 2024-04-08 19:39:22.687148 B 4 BindComplete 2024-04-08 19:39:22.687150 B 4 NoData 2024-04-08 19:39:22.687151 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 19:39:22.687152 B 5 ReadyForQuery T 2024-04-08 19:39:22.687153 F 34 Query "fetch absolute 0 from srv_cu1" 2024-04-08 19:39:22.687177 B 141 RowDescription 5 "auth_id" 25027 1 23 4 -1 0 "a_name" 25027 2 1043 65535 54 0 "aut_muser" 25027 33 1043 65535 24 0 "aut_mtime" 25027 34 1114 8 3 0 "aut_mstat" 25027 35 1042 65535 5 0 2024-04-08 19:39:22.687179 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.687180 B 5 ReadyForQuery T 2024-04-08 19:39:22.687204 F 34 Query "fetch forward 50 from srv_cu1" 2024-04-08 19:39:22.687226 B 141 RowDescription 5 "auth_id" 25027 1 23 4 -1 0 "a_name" 25027 2 1043 65535 54 0 "aut_muser" 25027 33 1043 65535 24 0 "aut_mtime" 25027 34 1114 8 3 0 "aut_mstat" 25027 35 1042 65535 5 0 2024-04-08 19:39:22.687229 B 45 DataRow 5 3 '100' 16 '<unknown author>' -1 -1 -1 2024-04-08 19:39:22.687231 B 41 DataRow 5 3 '101' 12 'Stephen KING' -1 -1 -1 2024-04-08 19:39:22.687232 B 44 DataRow 5 3 '102' 15 'James Patterson' -1 -1 -1 2024-04-08 19:39:22.687233 B 38 DataRow 5 3 '103' 9 'Dan Brown' -1 -1 -1 2024-04-08 19:39:22.687234 B 12 CommandComplete "FETCH 4" 2024-04-08 19:39:22.687235 B 5 ReadyForQuery T 2024-04-08 19:39:22.687430 F 34 Query "fetch forward 50 from srv_cu1" 2024-04-08 19:39:22.687450 B 141 RowDescription 5 "auth_id" 25027 1 23 4 -1 0 "a_name" 25027 2 1043 65535 54 0 "aut_muser" 25027 33 1043 65535 24 0 "aut_mtime" 25027 34 1114 8 3 0 "aut_mstat" 25027 35 1042 65535 5 0 2024-04-08 19:39:22.687453 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.687454 B 5 ReadyForQuery T 2024-04-08 19:39:22.687492 F 18 Query "close srv_cu1" 2024-04-08 19:39:22.687509 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 19:39:22.687511 B 5 ReadyForQuery T 2024-04-08 19:39:22.687540 F 19 Query "deallocate cu1" 2024-04-08 19:39:22.687557 B 15 CommandComplete "DEALLOCATE" 2024-04-08 19:39:22.687559 B 5 ReadyForQuery T 2024-04-08 19:39:22.687611 F 59 Parse "cu1" "declare srv_cu1 cursor for select * from book " 0 2024-04-08 19:39:22.687612 F 4 Sync 2024-04-08 19:39:22.687637 B 4 ParseComplete 2024-04-08 19:39:22.687639 B 5 ReadyForQuery T 2024-04-08 19:39:22.687640 F 17 Bind "" "cu1" 0 0 1 0 2024-04-08 19:39:22.687641 F 6 Describe P "" 2024-04-08 19:39:22.687642 F 9 Execute "" 0 2024-04-08 19:39:22.687643 F 4 Sync 2024-04-08 19:39:22.687709 B 4 BindComplete 2024-04-08 19:39:22.687710 B 4 NoData 2024-04-08 19:39:22.687711 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 19:39:22.687712 B 5 ReadyForQuery T 2024-04-08 19:39:22.687714 F 34 Query "fetch absolute 0 from srv_cu1" 2024-04-08 19:39:22.687734 B 274 RowDescription 10 "book_id" 25034 1 23 4 -1 0 "b_title" 25034 2 1043 65535 104 0 "b_author" 25034 3 23 4 -1 0 "b_isbn" 25034 4 1043 65535 24 0 "b_pub_date" 25034 5 1082 4 -1 0 "b_price" 25034 6 1700 65535 655366 0 "b_plot" 25034 7 1043 65535 504 0 "boo_muser" 25034 29 1043 65535 24 0 "boo_mtime" 25034 30 1114 8 3 0 "boo_mstat" 25034 31 1042 65535 5 0 2024-04-08 19:39:22.687737 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.687738 B 5 ReadyForQuery T 2024-04-08 19:39:22.687760 F 34 Query "fetch forward 50 from srv_cu1" 2024-04-08 19:39:22.687798 B 274 RowDescription 10 "book_id" 25034 1 23 4 -1 0 "b_title" 25034 2 1043 65535 104 0 "b_author" 25034 3 23 4 -1 0 "b_isbn" 25034 4 1043 65535 24 0 "b_pub_date" 25034 5 1082 4 -1 0 "b_price" 25034 6 1700 65535 655366 0 "b_plot" 25034 7 1043 65535 504 0 "boo_muser" 25034 29 1043 65535 24 0 "boo_mtime" 25034 30 1114 8 3 0 "boo_mstat" 25034 31 1042 65535 5 0 2024-04-08 19:39:22.687801 B 295 DataRow 10 5 '10103' 13 'The Long Walk' 3 '101' 17 '978-0-451-08754-6' 10 '1979-07-11' 5 '14.30' 196 'In a dystopian America, a major source of entertainment is the Long Walk, in which one hundred teenage boys walk without rest along U.S. Route 1. Each Walker must stay above four miles per hour...' -1 -1 -1 2024-04-08 19:39:22.687803 B 352 DataRow 10 5 '10202' 14 'Kiss the Girls' 3 '102' 13 '0-316-69370-7' 10 '1995-01-11' 5 '12.40' 256 'As a teenage boy in 1975 Boca Raton, Florida, a future serial killer calling himself Casanova kills his first four victims. Elsewhere in 1981 Chapel Hill, North Carolina, another killer calling himself The Gentleman Caller kills a young couple on a lake...' -1 -1 -1 2024-04-08 19:39:22.687805 B 389 DataRow 10 5 '10301' 16 'Digital Fortress' 3 '103' 13 '0-312-18087-X' 10 '1998-01-01' 5 '10.20' 291 'The story is set in the year of 1996. When the United States National Security Agency's (NSA) code-breaking supercomputer TRANSLTR encounters a revolutionary new code, Digital Fortress, that it cannot break, Commander Trevor Strathmore calls in head cryptographer Susan Fletcher to crack it.' -1 -1 -1 2024-04-08 19:39:22.687807 B 562 DataRow 10 5 '10304' 15 'The Lost Symbol' 3 '103' 18 '978-0-385-50422-5 ' 10 '2009-09-15' 5 '11.40' 460 'Renowned Harvard symbologist Robert Langdon is invited to give a lecture at the United States Capitol, at the invitation apparently from his mentor, a 33rd degree Mason named Peter Solomon, who is the head of the Smithsonian Institution. Solomon has also asked him to bring a small, sealed package which he had entrusted to Langdon years earlier. When Langdon arrives at the Capitol, however, he learns that the invitation he received was not from Solomon, ...' -1 -1 -1 2024-04-08 19:39:22.687809 B 150 DataRow 10 5 '10201' 19 'Along Came a Spider' 3 '102' 13 '0-316-69364-2' 10 '1993-03-23' 6 '111.20' 21 'XXXXXXXXXXEEFFFFFFFFF' 4 'mike' 23 '2024-04-06 15:52:29.806' -1 2024-04-08 19:39:22.687811 B 541 DataRow 10 5 '10302' 15 'Angels & Demons' 3 '103' 14 '0-671-02735-2 ' 10 '2000-04-01' 5 '14.55' 417 'Leonardo Vetra, one of CERN's top physicists who have discovered how to create antimatter, is murdered, his chest branded with an ambigram of the word "Illuminati", an ancient anti-religious organization thought extinct. CERN director Maximilian Kohler calls Vetra's adopted daughter, Vittoria, and Robert Langdon, an expert on symbology and religious history, for help. After determining the ambigram is authentic...' 3 'ted' 23 '2024-04-06 15:52:51.803' -1 2024-04-08 19:39:22.687813 B 99 DataRow 10 5 '20057' 3 'EEE' 3 '100' 2 '44' 10 '2024-04-08' 4 '0.00' -1 3 'ted' 23 '2024-04-08 12:59:54.496' -1 2024-04-08 19:39:22.687815 B 397 DataRow 10 5 '10101' 12 'The Talisman' 3 '101' 17 '978-0-670-69199-9' 10 '1984-11-08' 5 '15.60' 274 'Jack Sawyer, twelve years old, sets out from Arcadia Beach, New Hampshire, in a bid to save his mother Lily, who is dying from cancer, by finding a crystal called "the Talisman". Jack's journey takes him simultaneously through the American heartland and "the Territories"...' 3 'ted' 22 '2024-04-03 10:56:54.38' -1 2024-04-08 19:39:22.687817 B 438 DataRow 10 5 '10303' 17 'The Da Vinci Code' 3 '103' 13 '0-385-50420-9' 10 '2003-03-18' 5 '11.00' 317 'Louvre curator and Priory of Sion grand master Jacques Sauni\xffffffc3\xffffffa8re is fatally shot one night at the museum by an albino Catholic monk named Silas, who is working on behalf of someone he knows only as the Teacher, who wishes to discover the location of the "keystone," an item crucial in the search for the Holy Grail...' 3 'ted' 19 '2024-04-03 09:52:01' -1 2024-04-08 19:39:22.687819 B 460 DataRow 10 5 '10104' 11 'Firestarter' 3 '101' 14 '978-0670315413' 10 '1980-09-29' 5 '13.50' 340 'XXXXXXXXXEEEEEEEEEEEEEEEEEEEEEEEWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWW\x0aWWWW\x0a\x0aXXXEEEEEEEEEEEEEEEEEEEEEEEWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWW\x0aWWWW\x0a\x0aWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWW\x0aWWWW\x0a\x0aXXXEEEEEEEEEEEEEEEEEEEEEEEWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWW\x0aWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWW\x0aWWWW\x0a\x0aXXXEEEEEEEEEEEEEEEEEEEEEEEWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWWW\x0aWWWW' 3 'ted' 23 '2024-04-04 14:33:57.069' -1 2024-04-08 19:39:22.687826 B 358 DataRow 10 5 '10203' 16 'The Big Bad Wolf' 3 '102' 17 '978-0-316-60290-7' 10 '2003-11-17' 5 '12.50' 230 'Cross is in the middle of his training at the FBI when he is assigned to work on a kidnapping case. A federal judge's wife has been kidnapped, and Cross discovers that her kidnapping fits the pattern of other recent kidnappings...' 3 'ted' 23 '2024-04-05 13:51:37.577' -1 2024-04-08 19:39:22.687828 B 141 DataRow 10 5 '10102' 12 'Doctor Sleep' 3 '101' 17 '978-1-4767-2765-3' 10 '2013-09-24' 5 '12.00' 16 'weeeeeeeeeeeeeee' 4 'mike' 23 '2024-04-05 15:12:47.079' -1 2024-04-08 19:39:22.687830 B 13 CommandComplete "FETCH 12" 2024-04-08 19:39:22.687831 B 5 ReadyForQuery T 2024-04-08 19:39:22.689023 F 34 Query "fetch forward 50 from srv_cu1" 2024-04-08 19:39:22.689074 B 274 RowDescription 10 "book_id" 25034 1 23 4 -1 0 "b_title" 25034 2 1043 65535 104 0 "b_author" 25034 3 23 4 -1 0 "b_isbn" 25034 4 1043 65535 24 0 "b_pub_date" 25034 5 1082 4 -1 0 "b_price" 25034 6 1700 65535 655366 0 "b_plot" 25034 7 1043 65535 504 0 "boo_muser" 25034 29 1043 65535 24 0 "boo_mtime" 25034 30 1114 8 3 0 "boo_mstat" 25034 31 1042 65535 5 0 2024-04-08 19:39:22.689078 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.689079 B 5 ReadyForQuery T 2024-04-08 19:39:22.689134 F 18 Query "close srv_cu1" 2024-04-08 19:39:22.689152 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 19:39:22.689154 B 5 ReadyForQuery T 2024-04-08 19:39:22.689190 F 19 Query "deallocate cu1" 2024-04-08 19:39:22.689207 B 15 CommandComplete "DEALLOCATE" 2024-04-08 19:39:22.689209 B 5 ReadyForQuery T 2024-04-08 19:39:22.689265 F 64 Parse "cu1" "declare srv_cu1 cursor for select book_id from book" 0 2024-04-08 19:39:22.689266 F 4 Sync 2024-04-08 19:39:22.689290 B 4 ParseComplete 2024-04-08 19:39:22.689291 B 5 ReadyForQuery T 2024-04-08 19:39:22.689292 F 17 Bind "" "cu1" 0 0 1 0 2024-04-08 19:39:22.689294 F 6 Describe P "" 2024-04-08 19:39:22.689295 F 9 Execute "" 0 2024-04-08 19:39:22.689296 F 4 Sync 2024-04-08 19:39:22.689326 B 4 BindComplete 2024-04-08 19:39:22.689327 B 4 NoData 2024-04-08 19:39:22.689328 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 19:39:22.689329 B 5 ReadyForQuery T 2024-04-08 19:39:22.689330 F 34 Query "fetch absolute 0 from srv_cu1" 2024-04-08 19:39:22.689349 B 32 RowDescription 1 "book_id" 25034 1 23 4 -1 0 2024-04-08 19:39:22.689351 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.689352 B 5 ReadyForQuery T 2024-04-08 19:39:22.689370 F 34 Query "fetch forward 50 from srv_cu1" 2024-04-08 19:39:22.689392 B 32 RowDescription 1 "book_id" 25034 1 23 4 -1 0 2024-04-08 19:39:22.689394 B 15 DataRow 1 5 '10103' 2024-04-08 19:39:22.689395 B 15 DataRow 1 5 '10202' 2024-04-08 19:39:22.689396 B 15 DataRow 1 5 '10301' 2024-04-08 19:39:22.689397 B 15 DataRow 1 5 '10304' 2024-04-08 19:39:22.689398 B 15 DataRow 1 5 '10201' 2024-04-08 19:39:22.689399 B 15 DataRow 1 5 '10302' 2024-04-08 19:39:22.689400 B 15 DataRow 1 5 '20057' 2024-04-08 19:39:22.689401 B 15 DataRow 1 5 '10101' 2024-04-08 19:39:22.689402 B 15 DataRow 1 5 '10303' 2024-04-08 19:39:22.689403 B 15 DataRow 1 5 '10104' 2024-04-08 19:39:22.689404 B 15 DataRow 1 5 '10203' 2024-04-08 19:39:22.689405 B 15 DataRow 1 5 '10102' 2024-04-08 19:39:22.689406 B 13 CommandComplete "FETCH 12" 2024-04-08 19:39:22.689407 B 5 ReadyForQuery T 2024-04-08 19:39:22.689643 F 34 Query "fetch forward 50 from srv_cu1" 2024-04-08 19:39:22.689661 B 32 RowDescription 1 "book_id" 25034 1 23 4 -1 0 2024-04-08 19:39:22.689663 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.689664 B 5 ReadyForQuery T 2024-04-08 19:39:22.689688 F 18 Query "close srv_cu1" 2024-04-08 19:39:22.689727 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 19:39:22.689729 B 5 ReadyForQuery T 2024-04-08 19:39:22.689769 F 19 Query "deallocate cu1" 2024-04-08 19:39:22.689786 B 15 CommandComplete "DEALLOCATE" 2024-04-08 19:39:22.689787 B 5 ReadyForQuery T 2024-04-08 19:39:22.689841 F 66 Parse "cu1" "declare srv_cu1 cursor for select auth_id from author" 0 2024-04-08 19:39:22.689842 F 4 Sync 2024-04-08 19:39:22.689864 B 4 ParseComplete 2024-04-08 19:39:22.689866 B 5 ReadyForQuery T 2024-04-08 19:39:22.689867 F 17 Bind "" "cu1" 0 0 1 0 2024-04-08 19:39:22.689868 F 6 Describe P "" 2024-04-08 19:39:22.689869 F 9 Execute "" 0 2024-04-08 19:39:22.689870 F 4 Sync 2024-04-08 19:39:22.689898 B 4 BindComplete 2024-04-08 19:39:22.689899 B 4 NoData 2024-04-08 19:39:22.689900 B 19 CommandComplete "DECLARE CURSOR" 2024-04-08 19:39:22.689901 B 5 ReadyForQuery T 2024-04-08 19:39:22.689903 F 34 Query "fetch absolute 0 from srv_cu1" 2024-04-08 19:39:22.689924 B 32 RowDescription 1 "auth_id" 25027 1 23 4 -1 0 2024-04-08 19:39:22.689926 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.689927 B 5 ReadyForQuery T 2024-04-08 19:39:22.689946 F 34 Query "fetch forward 50 from srv_cu1" 2024-04-08 19:39:22.689965 B 32 RowDescription 1 "auth_id" 25027 1 23 4 -1 0 2024-04-08 19:39:22.689967 B 13 DataRow 1 3 '100' 2024-04-08 19:39:22.689968 B 13 DataRow 1 3 '101' 2024-04-08 19:39:22.689969 B 13 DataRow 1 3 '102' 2024-04-08 19:39:22.689970 B 13 DataRow 1 3 '103' 2024-04-08 19:39:22.689971 B 12 CommandComplete "FETCH 4" 2024-04-08 19:39:22.689972 B 5 ReadyForQuery T 2024-04-08 19:39:22.690054 F 34 Query "fetch forward 50 from srv_cu1" 2024-04-08 19:39:22.690072 B 32 RowDescription 1 "auth_id" 25027 1 23 4 -1 0 2024-04-08 19:39:22.690073 B 12 CommandComplete "FETCH 0" 2024-04-08 19:39:22.690074 B 5 ReadyForQuery T 2024-04-08 19:39:22.690099 F 18 Query "close srv_cu1" 2024-04-08 19:39:22.690115 B 17 CommandComplete "CLOSE CURSOR" 2024-04-08 19:39:22.690116 B 5 ReadyForQuery T 2024-04-08 19:39:22.690139 F 19 Query "deallocate cu1" 2024-04-08 19:39:22.690158 B 15 CommandComplete "DEALLOCATE" 2024-04-08 19:39:22.690160 B 5 ReadyForQuery T 2024-04-08 19:39:22.690199 F 115 Parse "" "update dbsync_udsinfo SET udsi_temp_mtime = $1 WHERE udsi_user_id = $2 AND udsi_table_name = $3" 3 1114 1043 1043 2024-04-08 19:39:22.690201 F 68 Bind "" "" 3 0 0 0 3 26 '2024-04-08 17:39:22.685000' 4 'mike' 6 'author' 1 0 2024-04-08 19:39:22.690203 F 6 Describe P "" 2024-04-08 19:39:22.690204 F 9 Execute "" 0 2024-04-08 19:39:22.690205 F 4 Sync 2024-04-08 19:39:22.690371 B 4 ParseComplete 2024-04-08 19:39:22.690372 B 4 BindComplete 2024-04-08 19:39:22.690373 B 4 NoData 2024-04-08 19:39:22.690374 B 13 CommandComplete "UPDATE 1" 2024-04-08 19:39:22.690375 B 5 ReadyForQuery T 2024-04-08 19:39:22.690429 F 115 Parse "" "update dbsync_udsinfo SET udsi_temp_mtime = $1 WHERE udsi_user_id = $2 AND udsi_table_name = $3" 3 1114 1043 1043 2024-04-08 19:39:22.690431 F 66 Bind "" "" 3 0 0 0 3 26 '2024-04-08 17:39:22.685000' 4 'mike' 4 'book' 1 0 2024-04-08 19:39:22.690432 F 6 Describe P "" 2024-04-08 19:39:22.690433 F 9 Execute "" 0 2024-04-08 19:39:22.690434 F 4 Sync 2024-04-08 19:39:22.690517 B 4 ParseComplete 2024-04-08 19:39:22.690518 B 4 BindComplete 2024-04-08 19:39:22.690519 B 4 NoData 2024-04-08 19:39:22.690520 B 13 CommandComplete "UPDATE 1" 2024-04-08 19:39:22.690521 B 5 ReadyForQuery T 2024-04-08 19:39:22.690548 F 19 Query "deallocate cu0" 2024-04-08 19:39:22.690568 B 15 CommandComplete "DEALLOCATE" 2024-04-08 19:39:22.690570 B 5 ReadyForQuery T 2024-04-08 19:39:22.690574 F 11 Query "commit" 2024-04-08 19:39:22.692828 B 11 CommandComplete "COMMIT" 2024-04-08 19:39:22.692839 B 5 ReadyForQuery I 2024-04-08 19:39:22.692895 F 4 Terminate ^ permalink raw reply [nested|flat] 3+ messages in thread
end of thread, other threads:[~2024-04-08 17:44 UTC | newest] Thread overview: 3+ messages (download: mbox mbox.gz follow: Atom feed) -- links below jump to the message on this page -- 2024-04-08 16:25 Re: prepared statement "cu1" already exists (but it does not) Sebastien Flaesch <[email protected]> 2024-04-08 17:36 ` Tom Lane <[email protected]> 2024-04-08 17:44 ` Sebastien Flaesch <[email protected]>
This inbox is served by agora; see mirroring instructions for how to clone and mirror all data and code used for this inbox