relcache_issue_2.log
application/octet-stream
Filename: relcache_issue_2.log
Type: application/octet-stream
Part: 1
2017-01-29 10:44:31.142 UTC [73119] [xid=0]LOG: Rebuilding index list for (pg_class) 2017-01-29 10:44:31.142 UTC [73119] [xid=0]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.143 UTC [73119] [xid=0]LOG: Adding index (2662) to the list of indexes for (pg_class) 2017-01-29 10:44:31.143 UTC [73119] [xid=0]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.143 UTC [73119] [xid=0]LOG: Adding index (2663) to the list of indexes for (pg_class) 2017-01-29 10:44:31.143 UTC [73119] [xid=0]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.143 UTC [73119] [xid=0]LOG: Adding index (3455) to the list of indexes for (pg_class) 2017-01-29 10:44:31.143 UTC [73119] [xid=0]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]LOG: Rebuilding index list for (pg_attribute) 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]LOG: Adding index (2658) to the list of indexes for (pg_attribute) 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]LOG: Adding index (2659) to the list of indexes for (pg_attribute) 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]LOG: Rebuilding index list for (pg_index) 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]LOG: Adding index (2678) to the list of indexes for (pg_index) 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]LOG: Adding index (2679) to the list of indexes for (pg_index) 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]LOG: Rebuilding index list for (pg_depend) 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]LOG: Adding index (2673) to the list of indexes for (pg_depend) 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]LOG: Adding index (2674) to the list of indexes for (pg_depend) 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]LOG: Received RelationClearRelation(pgb_a_aid1, rebuild=T) 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]LOG: Received RelationDestroyRelation(pgb_a_aid1) 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]LOG: Received RelationClearRelation(cic_tab_accounts, rebuild=T) 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]LOG: Received RelationDestroyRelation(cic_tab_accounts) 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]LOG: CIC (pgb_a_aid1) - create index entry 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]LOG: CIC (pgb_a_aid1) Committed txn (4670889) for phase 1 2017-01-29 10:44:31.143 UTC [73119] [xid=4670889]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.144 UTC [73119] [xid=0]LOG: Received RelationClearRelation(cic_tab_accounts, rebuild=F) 2017-01-29 10:44:31.144 UTC [73119] [xid=0]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.144 UTC [73119] [xid=0]LOG: Received RelationDestroyRelation(cic_tab_accounts) 2017-01-29 10:44:31.144 UTC [73119] [xid=0]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.144 UTC [73119] [xid=0]LOG: Received RelationClearRelation(pgb_a_aid1, rebuild=F) 2017-01-29 10:44:31.144 UTC [73119] [xid=0]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.144 UTC [73119] [xid=0]LOG: Received RelationDestroyRelation(pgb_a_aid1) 2017-01-29 10:44:31.144 UTC [73119] [xid=0]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.144 UTC [73119] [xid=0]LOG: CIC (pgb_a_aid1) Wait for all existing txns to end 2017-01-29 10:44:31.144 UTC [73119] [xid=0]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.158 UTC [73090] [xid=0]LOG: Received RelationClearRelation(cic_tab_accounts, rebuild=F) 2017-01-29 10:44:31.158 UTC [73090] [xid=0]STATEMENT: BEGIN; 2017-01-29 10:44:31.158 UTC [73090] [xid=0]LOG: Received RelationDestroyRelation(cic_tab_accounts) 2017-01-29 10:44:31.158 UTC [73090] [xid=0]STATEMENT: BEGIN; 2017-01-29 10:44:31.159 UTC [73090] [xid=0]LOG: Rebuilding index list for (cic_tab_accounts) 2017-01-29 10:44:31.159 UTC [73090] [xid=0]CONTEXT: SQL statement "UPDATE cic_tab_accounts p SET aid1 = aid1 + chg, abalance = abalance + 2017-01-29 10:44:31.159 UTC [73090] [xid=0]STATEMENT: SELECT cic_tab_update_using_aid1(-2, 444466, 1641); 2017-01-29 10:44:31.159 UTC [73090] [xid=0]LOG: Adding index (16663) to the list of indexes for (cic_tab_accounts) 2017-01-29 10:44:31.159 UTC [73090] [xid=0]CONTEXT: SQL statement "UPDATE cic_tab_accounts p SET aid1 = aid1 + chg, abalance = abalance + 2017-01-29 10:44:31.159 UTC [73090] [xid=0]STATEMENT: SELECT cic_tab_update_using_aid1(-2, 444466, 1641); 2017-01-29 10:44:31.159 UTC [73090] [xid=0]LOG: Adding index (16652) to the list of indexes for (cic_tab_accounts) 2017-01-29 10:44:31.159 UTC [73090] [xid=0]CONTEXT: SQL statement "UPDATE cic_tab_accounts p SET aid1 = aid1 + chg, abalance = abalance + 2017-01-29 10:44:31.159 UTC [73090] [xid=0]STATEMENT: SELECT cic_tab_update_using_aid1(-2, 444466, 1641); 2017-01-29 10:44:31.194 UTC [73091] [xid=4670892]LOG: Received RelationClearRelation(cic_tab_accounts, rebuild=T) 2017-01-29 10:44:31.194 UTC [73091] [xid=4670892]CONTEXT: SQL statement "UPDATE cic_tab_accounts p SET aid1 = aid1 + chg, abalance = abalance + 2017-01-29 10:44:31.194 UTC [73091] [xid=4670892]STATEMENT: SELECT cic_tab_update_using_aid1(-2, 855346, 414); 2017-01-29 10:44:31.194 UTC [73091] [xid=4670892]LOG: Received RelationDestroyRelation(cic_tab_accounts) 2017-01-29 10:44:31.194 UTC [73091] [xid=4670892]CONTEXT: SQL statement "UPDATE cic_tab_accounts p SET aid1 = aid1 + chg, abalance = abalance + 2017-01-29 10:44:31.194 UTC [73091] [xid=4670892]STATEMENT: SELECT cic_tab_update_using_aid1(-2, 855346, 414); 2017-01-29 10:44:31.194 UTC [73091] [xid=4670892]LOG: Examining index (pgb_a_aid) 2017-01-29 10:44:31.194 UTC [73091] [xid=4670892]CONTEXT: SQL statement "UPDATE cic_tab_accounts p SET aid1 = aid1 + chg, abalance = abalance + 2017-01-29 10:44:31.194 UTC [73091] [xid=4670892]STATEMENT: SELECT cic_tab_update_using_aid1(-2, 855346, 414); 2017-01-29 10:44:31.194 UTC [73091] [xid=4670892]LOG: RelationGetIndexAttrBitmap: relation(cic_tab_accounts) hot_attrs((b 9)) 2017-01-29 10:44:31.194 UTC [73091] [xid=4670892]CONTEXT: SQL statement "UPDATE cic_tab_accounts p SET aid1 = aid1 + chg, abalance = abalance + 2017-01-29 10:44:31.194 UTC [73091] [xid=4670892]STATEMENT: SELECT cic_tab_update_using_aid1(-2, 855346, 414); 2017-01-29 10:44:31.194 UTC [73091] [xid=4670892]LOG: heap_update (cic_tab_accounts), hot_attrs ((b 9)) 2017-01-29 10:44:31.194 UTC [73091] [xid=4670892]CONTEXT: SQL statement "UPDATE cic_tab_accounts p SET aid1 = aid1 + chg, abalance = abalance + 2017-01-29 10:44:31.194 UTC [73091] [xid=4670892]STATEMENT: SELECT cic_tab_update_using_aid1(-2, 855346, 414); 2017-01-29 10:44:31.238 UTC [73119] [xid=0]LOG: CIC (pgb_a_aid1) building first phase with snapshot (4670891:4670893) 2017-01-29 10:44:31.238 UTC [73119] [xid=0]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.238 UTC [73119] [xid=0]LOG: CIC (pgb_a_aid1) xip[4670891] 2017-01-29 10:44:31.238 UTC [73119] [xid=0]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.238 UTC [73091] [xid=0]LOG: Rebuilding index list for (cic_tab_accounts) 2017-01-29 10:44:31.238 UTC [73091] [xid=0]CONTEXT: SQL statement "UPDATE cic_tab_accounts p SET aid1 = aid1 + chg, abalance = abalance + 2017-01-29 10:44:31.238 UTC [73091] [xid=0]STATEMENT: SELECT cic_tab_update_using_aid1(-1, 3297451, 382); 2017-01-29 10:44:31.238 UTC [73091] [xid=0]LOG: Adding index (16663) to the list of indexes for (cic_tab_accounts) 2017-01-29 10:44:31.238 UTC [73091] [xid=0]CONTEXT: SQL statement "UPDATE cic_tab_accounts p SET aid1 = aid1 + chg, abalance = abalance + 2017-01-29 10:44:31.238 UTC [73091] [xid=0]STATEMENT: SELECT cic_tab_update_using_aid1(-1, 3297451, 382); 2017-01-29 10:44:31.238 UTC [73091] [xid=0]LOG: Adding index (16652) to the list of indexes for (cic_tab_accounts) 2017-01-29 10:44:31.238 UTC [73091] [xid=0]CONTEXT: SQL statement "UPDATE cic_tab_accounts p SET aid1 = aid1 + chg, abalance = abalance + 2017-01-29 10:44:31.238 UTC [73091] [xid=0]STATEMENT: SELECT cic_tab_update_using_aid1(-1, 3297451, 382); 2017-01-29 10:44:31.263 UTC [73090] [xid=4670895]LOG: Examining index (pgb_a_aid) 2017-01-29 10:44:31.263 UTC [73090] [xid=4670895]CONTEXT: SQL statement "UPDATE cic_tab_accounts p SET aid1 = aid1 + chg, abalance = abalance + 2017-01-29 10:44:31.263 UTC [73090] [xid=4670895]STATEMENT: SELECT cic_tab_update_using_aid1(-2, 444466, 1641); 2017-01-29 10:44:31.263 UTC [73090] [xid=4670895]LOG: Examining index (pgb_a_aid1) 2017-01-29 10:44:31.263 UTC [73090] [xid=4670895]CONTEXT: SQL statement "UPDATE cic_tab_accounts p SET aid1 = aid1 + chg, abalance = abalance + 2017-01-29 10:44:31.263 UTC [73090] [xid=4670895]STATEMENT: SELECT cic_tab_update_using_aid1(-2, 444466, 1641); 2017-01-29 10:44:31.263 UTC [73090] [xid=4670895]LOG: RelationGetIndexAttrBitmap: relation(cic_tab_accounts) hot_attrs((b 9 11)) 2017-01-29 10:44:31.263 UTC [73090] [xid=4670895]CONTEXT: SQL statement "UPDATE cic_tab_accounts p SET aid1 = aid1 + chg, abalance = abalance + 2017-01-29 10:44:31.263 UTC [73090] [xid=4670895]STATEMENT: SELECT cic_tab_update_using_aid1(-2, 444466, 1641); 2017-01-29 10:44:31.263 UTC [73090] [xid=4670895]LOG: heap_update (cic_tab_accounts), hot_attrs ((b 9 11)) 2017-01-29 10:44:31.263 UTC [73090] [xid=4670895]CONTEXT: SQL statement "UPDATE cic_tab_accounts p SET aid1 = aid1 + chg, abalance = abalance + 2017-01-29 10:44:31.263 UTC [73090] [xid=4670895]STATEMENT: SELECT cic_tab_update_using_aid1(-2, 444466, 1641); 2017-01-29 10:44:31.764 UTC [73119] [xid=0]LOG: Received RelationClearRelation(cic_tab_accounts, rebuild=T) 2017-01-29 10:44:31.764 UTC [73119] [xid=0]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.764 UTC [73119] [xid=0]LOG: Received RelationDestroyRelation(cic_tab_accounts) 2017-01-29 10:44:31.764 UTC [73119] [xid=0]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.764 UTC [73119] [xid=0]LOG: Received RelationClearRelation(pgb_a_aid1, rebuild=T) 2017-01-29 10:44:31.764 UTC [73119] [xid=0]STATEMENT: CREATE INDEX CONCURRENTLY pgb_a_aid1 ON cic_tab_accounts(aid1); 2017-01-29 10:44:31.889 UTC [73091] [xid=4670908]LOG: heap_update (cic_tab_accounts), hot_attrs ((b 9)) 2017-01-29 10:44:31.889 UTC [73091] [xid=4670908]CONTEXT: SQL statement "UPDATE cic_tab_accounts p SET aid1 = aid1 + chg, abalance = abalance + 2017-01-29 10:44:31.889 UTC [73091] [xid=4670908]STATEMENT: SELECT cic_tab_update_using_aid1(-2, 696415, 412); 2017-01-29 10:44:32.008 UTC [73090] [xid=4670910]LOG: heap_update (cic_tab_accounts), hot_attrs ((b 9 11)) 2017-01-29 10:44:32.008 UTC [73090] [xid=4670910]CONTEXT: SQL statement "UPDATE cic_tab_accounts p SET aid1 = aid1 + chg, abalance = abalance + 2017-01-29 10:44:32.008 UTC [73090] [xid=4670910]STATEMENT: SELECT cic_tab_update_using_aid1(-1, 56380, -2422);