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