025_stuck_on_old_timeline_cascade.log
application/octet-stream
Filename: 025_stuck_on_old_timeline_cascade.log
Type: application/octet-stream
Part: 2
Message:
Re: Race condition in recovery?
2021-06-03 16:16:53.749 EDT [47790] LOG: starting PostgreSQL 14beta1 on x86_64-apple-darwin19.6.0, compiled by clang version 5.0.2 (tags/RELEASE_502/final), 64-bit 2021-06-03 16:16:53.749 EDT [47790] LOG: listening on Unix socket "/var/folders/jh/925hn4t97mb_sby_1s37k7dc0000gs/T/sdk3QMgbuK/.s.PGSQL.50638" 2021-06-03 16:16:53.754 EDT [47791] LOG: database system was interrupted while in recovery at log time 2021-06-03 16:16:51 EDT 2021-06-03 16:16:53.754 EDT [47791] HINT: If this has occurred more than once some data might be corrupted and you might need to choose an earlier recovery target. 2021-06-03 16:16:53.769 EDT [47791] LOG: restored log file "00000002.history" from archive cp: /Users/rhaas/pgsql/src/test/recovery/tmp_check/t_025_stuck_on_old_timeline_primary_data/archives/00000003.history: No such file or directory 2021-06-03 16:16:53.784 EDT [47791] LOG: entering standby mode 2021-06-03 16:16:53.796 EDT [47791] LOG: restored log file "00000002.history" from archive cp: /Users/rhaas/pgsql/src/test/recovery/tmp_check/t_025_stuck_on_old_timeline_primary_data/archives/000000010000000000000002: No such file or directory 2021-06-03 16:16:53.816 EDT [47796] LOG: started streaming WAL from primary at 0/2000000 on timeline 1 2021-06-03 16:16:53.900 EDT [47791] LOG: restored log file "00000002.history" from archive 2021-06-03 16:16:53.913 EDT [47796] LOG: replication terminated by primary server 2021-06-03 16:16:53.913 EDT [47796] DETAIL: End of WAL reached on timeline 1 at 0/3000000. cp: /Users/rhaas/pgsql/src/test/recovery/tmp_check/t_025_stuck_on_old_timeline_primary_data/archives/00000003.history: No such file or directory cp: /Users/rhaas/pgsql/src/test/recovery/tmp_check/t_025_stuck_on_old_timeline_primary_data/archives/000000010000000000000002: No such file or directory 2021-06-03 16:16:53.958 EDT [47791] LOG: redo starts at 0/2000028 2021-06-03 16:16:53.960 EDT [47791] LOG: consistent recovery state reached at 0/3000000 2021-06-03 16:16:53.960 EDT [47790] LOG: database system is ready to accept read only connections cp: /Users/rhaas/pgsql/src/test/recovery/tmp_check/t_025_stuck_on_old_timeline_primary_data/archives/000000020000000000000003: No such file or directory cp: /Users/rhaas/pgsql/src/test/recovery/tmp_check/t_025_stuck_on_old_timeline_primary_data/archives/000000010000000000000003: No such file or directory 2021-06-03 16:16:53.984 EDT [47796] LOG: restarted WAL streaming at 0/3000000 on timeline 2 2021-06-03 16:16:54.197 EDT [47813] 025_stuck_on_old_timeline.pl LOG: statement: SELECT count(*) FROM tab_int 2021-06-03 16:16:54.197 EDT [47813] 025_stuck_on_old_timeline.pl ERROR: relation "tab_int" does not exist at character 22 2021-06-03 16:16:54.197 EDT [47813] 025_stuck_on_old_timeline.pl STATEMENT: SELECT count(*) FROM tab_int 2021-06-03 16:16:54.314 EDT [47796] FATAL: could not receive data from WAL stream: server closed the connection unexpectedly This probably means the server terminated abnormally before or while processing the request. cp: /Users/rhaas/pgsql/src/test/recovery/tmp_check/t_025_stuck_on_old_timeline_primary_data/archives/00000003.history: No such file or directory 2021-06-03 16:16:54.426 EDT [47790] LOG: received immediate shutdown request 2021-06-03 16:16:54.430 EDT [47790] LOG: database system is shut down