2024-06-06 09:28:46.858 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E404000, reqLen=1168 2024-06-06 09:28:46.858 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.858 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: set count = XLOG_BLCKSZ =8192 (2000) 2024-06-06 09:28:46.858 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.858 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning count=8192 2024-06-06 09:28:46.858 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.858 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #2 returned readLen 8192 2024-06-06 09:28:46.858 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.858 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: before ReadPageInternal-2 2024-06-06 09:28:46.858 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.858 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #2 2024-06-06 09:28:46.858 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.858 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.858 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.858 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: calling XLogBackgroundFlush 2024-06-06 09:28:46.858 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.858 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: 1. RecentFlushPtr assigned 0/1E406000 2024-06-06 09:28:46.858 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.858 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: got_STOPPING; break #1 2024-06-06 09:28:46.858 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.858 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return at bottom of function 0/1E406000 2024-06-06 09:28:46.858 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.858 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E406000, reqLen=459 2024-06-06 09:28:46.858 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.858 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning -1. flushptr=0/1E406000, targetPagePtr=0/1E406000, reqLen=459 2024-06-06 09:28:46.858 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.858 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #2 returned readLen -1 2024-06-06 09:28:46.858 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.858 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: called ReadPageInternal-2, which returned -1 2024-06-06 09:28:46.858 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.858 AEST [4988] tap_sub LOG: >>> XLogSendLogical: EndRecPtr is 0/1E404478, flushPtr is 0/1E406000, WalSndCaughtUp=0 2024-06-06 09:28:46.858 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.858 AEST [4988] tap_sub LOG: >>> XLogSendLogical: 2024-06-06 09:28:46.858 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.858 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: before ReadPageInternal-1 2024-06-06 09:28:46.858 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.858 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #1 2024-06-06 09:28:46.858 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return #1 0/1E406000 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E000000, reqLen=8192 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: set count = XLOG_BLCKSZ =8192 (2000) 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning count=8192 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #1 returned readLen 8192 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #2 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return #1 0/1E406000 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E404000, reqLen=1168 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: set count = XLOG_BLCKSZ =8192 (2000) 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning count=8192 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #2 returned readLen 8192 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: before ReadPageInternal-2 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #2 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: calling XLogBackgroundFlush 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: 1. RecentFlushPtr assigned 0/1E406000 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: got_STOPPING; break #1 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return at bottom of function 0/1E406000 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E406000, reqLen=459 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning -1. flushptr=0/1E406000, targetPagePtr=0/1E406000, reqLen=459 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #2 returned readLen -1 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: called ReadPageInternal-2, which returned -1 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> XLogSendLogical: EndRecPtr is 0/1E404478, flushPtr is 0/1E406000, WalSndCaughtUp=0 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> XLogSendLogical: 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: before ReadPageInternal-1 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #1 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return #1 0/1E406000 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E000000, reqLen=8192 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: set count = XLOG_BLCKSZ =8192 (2000) 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning count=8192 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #1 returned readLen 8192 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #2 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return #1 0/1E406000 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E404000, reqLen=1168 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: set count = XLOG_BLCKSZ =8192 (2000) 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning count=8192 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #2 returned readLen 8192 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: before ReadPageInternal-2 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #2 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: calling XLogBackgroundFlush 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: 1. RecentFlushPtr assigned 0/1E406000 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: got_STOPPING; break #1 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return at bottom of function 0/1E406000 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E406000, reqLen=459 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning -1. flushptr=0/1E406000, targetPagePtr=0/1E406000, reqLen=459 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #2 returned readLen -1 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: called ReadPageInternal-2, which returned -1 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> XLogSendLogical: EndRecPtr is 0/1E404478, flushPtr is 0/1E406000, WalSndCaughtUp=0 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> XLogSendLogical: 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: before ReadPageInternal-1 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #1 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return #1 0/1E406000 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E000000, reqLen=8192 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: set count = XLOG_BLCKSZ =8192 (2000) 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning count=8192 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #1 returned readLen 8192 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #2 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return #1 0/1E406000 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E404000, reqLen=1168 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: set count = XLOG_BLCKSZ =8192 (2000) 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning count=8192 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #2 returned readLen 8192 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: before ReadPageInternal-2 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #2 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: calling XLogBackgroundFlush 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: 1. RecentFlushPtr assigned 0/1E406000 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: got_STOPPING; break #1 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return at bottom of function 0/1E406000 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E406000, reqLen=459 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning -1. flushptr=0/1E406000, targetPagePtr=0/1E406000, reqLen=459 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #2 returned readLen -1 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: called ReadPageInternal-2, which returned -1 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> XLogSendLogical: EndRecPtr is 0/1E404478, flushPtr is 0/1E406000, WalSndCaughtUp=0 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> XLogSendLogical: 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: before ReadPageInternal-1 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #1 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return #1 0/1E406000 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E000000, reqLen=8192 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: set count = XLOG_BLCKSZ =8192 (2000) 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning count=8192 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #1 returned readLen 8192 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.859 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #2 2024-06-06 09:28:46.859 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return #1 0/1E406000 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E404000, reqLen=1168 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: set count = XLOG_BLCKSZ =8192 (2000) 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning count=8192 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #2 returned readLen 8192 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: before ReadPageInternal-2 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #2 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: calling XLogBackgroundFlush 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: 1. RecentFlushPtr assigned 0/1E406000 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: got_STOPPING; break #1 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return at bottom of function 0/1E406000 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E406000, reqLen=459 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning -1. flushptr=0/1E406000, targetPagePtr=0/1E406000, reqLen=459 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #2 returned readLen -1 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: called ReadPageInternal-2, which returned -1 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> XLogSendLogical: EndRecPtr is 0/1E404478, flushPtr is 0/1E406000, WalSndCaughtUp=0 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> XLogSendLogical: 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: before ReadPageInternal-1 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #1 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return #1 0/1E406000 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E000000, reqLen=8192 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: set count = XLOG_BLCKSZ =8192 (2000) 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning count=8192 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #1 returned readLen 8192 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #2 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return #1 0/1E406000 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E404000, reqLen=1168 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: set count = XLOG_BLCKSZ =8192 (2000) 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning count=8192 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #2 returned readLen 8192 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: before ReadPageInternal-2 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #2 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: calling XLogBackgroundFlush 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: 1. RecentFlushPtr assigned 0/1E406000 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: got_STOPPING; break #1 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return at bottom of function 0/1E406000 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E406000, reqLen=459 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning -1. flushptr=0/1E406000, targetPagePtr=0/1E406000, reqLen=459 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #2 returned readLen -1 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: called ReadPageInternal-2, which returned -1 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> XLogSendLogical: EndRecPtr is 0/1E404478, flushPtr is 0/1E406000, WalSndCaughtUp=0 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> XLogSendLogical: 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: before ReadPageInternal-1 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #1 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return #1 0/1E406000 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E000000, reqLen=8192 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: set count = XLOG_BLCKSZ =8192 (2000) 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning count=8192 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #1 returned readLen 8192 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #2 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return #1 0/1E406000 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E404000, reqLen=1168 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: set count = XLOG_BLCKSZ =8192 (2000) 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning count=8192 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #2 returned readLen 8192 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: before ReadPageInternal-2 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #2 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: calling XLogBackgroundFlush 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: 1. RecentFlushPtr assigned 0/1E406000 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: got_STOPPING; break #1 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return at bottom of function 0/1E406000 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E406000, reqLen=459 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning -1. flushptr=0/1E406000, targetPagePtr=0/1E406000, reqLen=459 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #2 returned readLen -1 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: called ReadPageInternal-2, which returned -1 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> XLogSendLogical: EndRecPtr is 0/1E404478, flushPtr is 0/1E406000, WalSndCaughtUp=0 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> XLogSendLogical: 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: before ReadPageInternal-1 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #1 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return #1 0/1E406000 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E000000, reqLen=8192 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: set count = XLOG_BLCKSZ =8192 (2000) 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning count=8192 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #1 returned readLen 8192 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #2 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return #1 0/1E406000 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E404000, reqLen=1168 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: set count = XLOG_BLCKSZ =8192 (2000) 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning count=8192 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #2 returned readLen 8192 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: before ReadPageInternal-2 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #2 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: calling XLogBackgroundFlush 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: 1. RecentFlushPtr assigned 0/1E406000 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.860 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: got_STOPPING; break #1 2024-06-06 09:28:46.860 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return at bottom of function 0/1E406000 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E406000, reqLen=459 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning -1. flushptr=0/1E406000, targetPagePtr=0/1E406000, reqLen=459 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #2 returned readLen -1 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: called ReadPageInternal-2, which returned -1 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> XLogSendLogical: EndRecPtr is 0/1E404478, flushPtr is 0/1E406000, WalSndCaughtUp=0 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> XLogSendLogical: 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: before ReadPageInternal-1 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #1 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return #1 0/1E406000 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E000000, reqLen=8192 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: set count = XLOG_BLCKSZ =8192 (2000) 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning count=8192 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #1 returned readLen 8192 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #2 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return #1 0/1E406000 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E404000, reqLen=1168 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: set count = XLOG_BLCKSZ =8192 (2000) 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning count=8192 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #2 returned readLen 8192 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: before ReadPageInternal-2 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #2 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: calling XLogBackgroundFlush 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: 1. RecentFlushPtr assigned 0/1E406000 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: got_STOPPING; break #1 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return at bottom of function 0/1E406000 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E406000, reqLen=459 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning -1. flushptr=0/1E406000, targetPagePtr=0/1E406000, reqLen=459 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #2 returned readLen -1 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: called ReadPageInternal-2, which returned -1 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> XLogSendLogical: EndRecPtr is 0/1E404478, flushPtr is 0/1E406000, WalSndCaughtUp=0 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> XLogSendLogical: 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> XLogDecodeNextRecord: before ReadPageInternal-1 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> ReadPageInternal: before calling routine.page_read #1 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: calling WalSndWaitForWal 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> WalSndWaitForWal: return #1 0/1E406000 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: just called WalSndWaitForWal. flushptr=0/1E406000, targetPagePtr=0/1E000000, reqLen=8192 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4958] LOG: received immediate shutdown request 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: set count = XLOG_BLCKSZ =8192 (2000) 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> logical_read_xlog_page: returning count=8192 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.861 AEST [4988] tap_sub LOG: >>> ReadPageInternal: routine.page_read #1 returned readLen 8192 2024-06-06 09:28:46.861 AEST [4988] tap_sub STATEMENT: START_REPLICATION SLOT "tap_sub" LOGICAL 0/1E2A8DC0 (proto_version '4', origin 'any', publication_names '"tap_pub"') 2024-06-06 09:28:46.864 AEST [4958] LOG: database system is shut down