Bug #843: pg_clog files problem

Nikolay Hristov (charlie@mail.vega.bg) reports a bug with a severity of 1
The lower the number the more severe it is.

Short Description
pg_clog files problem

Long Description
I am running PostgreSQL 7.2.1 distributed with cygwin on
Windows NT4 SP6.
The data directory is on NTFS drive.

I performed the following test:
- started a transaction with many(about 50) inserts, updates and deletes);
- in the middle of this I unplugged the power cable of the machine.

After rebooting, I started the postmaster again and the entries in the log file ware as follows:

FindExec: found "/usr/bin/postgres" using argv[0]
invoking IpcMemoryCreate(size=1441792)
FindExec: found "/usr/bin/postmaster" using argv[0]
DEBUG:  database system was interrupted at 2002-12-09 15:20:37 EEST
DEBUG:  checkpoint record is at 0/43B2D20
DEBUG:  redo record is at 0/43B2D20; undo record is at 0/0; shutdown TRUE
DEBUG:  next transaction id: 4565; next oid: 70678
DEBUG:  database system was not properly shut down; automatic recovery in progress
DEBUG:  ReadRecord: record with zero length at 0/43B2D60
DEBUG:  redo is not required
DEBUG:  database system is ready

I stopped the server, changed some debug display options and started it again:

FindExec: found "/usr/bin/postgres" using argv[0]
invoking IpcMemoryCreate(size=1441792)
FindExec: found "/usr/bin/postmaster" using argv[0]
2002-12-09 15:42:03 [243]    DEBUG:  database system was shut down at 2002-12-09 15:41:49 EEST
2002-12-09 15:42:03 [243]    DEBUG:  checkpoint record is at 0/43B2DA0
2002-12-09 15:42:03 [243]    DEBUG:  redo record is at 0/43B2DA0; undo record is at 0/0; shutdown TRUE
2002-12-09 15:42:03 [243]    DEBUG:  next transaction id: 4565; next oid: 70678
2002-12-09 15:42:03 [243]    DEBUG:  database system is ready


After that I established a connection and executed a query
(select count(*) from pg_class):

2002-12-09 15:42:59 [180]    DEBUG:  connection: host=127.0.0.1 user=admin database=lager
/usr/bin/postmaster child[180]: starting with (postgres -d2 -v131072 -p lager )
2002-12-09 15:42:59 [180]    DEBUG:  InitPostgres
2002-12-09 15:42:59 [180]    DEBUG:  StartTransactionCommand
2002-12-09 15:42:59 [180]    DEBUG:  query: select getdatabaseencoding()
2002-12-09 15:42:59 [180]    DEBUG:  ProcessQuery
2002-12-09 15:42:59 [180]    DEBUG:  CommitTransactionCommand
2002-12-09 15:42:59 [180]    DEBUG:  StartTransactionCommand
2002-12-09 15:42:59 [180]    DEBUG:  query: SELECT usesuper FROM pg_user WHERE usename = 'admin'
2002-12-09 15:42:59 [180]    DEBUG:  ProcessQuery
2002-12-09 15:42:59 [180]    DEBUG:  CommitTransactionCommand
2002-12-09 15:43:16 [180]    DEBUG:  StartTransactionCommand
2002-12-09 15:43:16 [180]    DEBUG:  query: select count(*) from pg_class;
2002-12-09 15:43:16 [180]    DEBUG:  ProcessQuery
2002-12-09 15:43:16 [180]    FATAL 2:  open of /cygdrive/d/TEMP/data/pg_clog/0677 failed: No such file or directory
2002-12-09 15:43:16 [180]    DEBUG:  proc_exit(2)
2002-12-09 15:43:16 [180]    DEBUG:  shmem_exit(2)
2002-12-09 15:43:17 [180]    DEBUG:  exit(2)

There is only one file in pg_clog:
-rw-r--r--    1 nike     None         8192 Dec  9 15:05 0000

I performed this test a few times during the last two days.
This situation was reproduced twice.

Sample Code


No file was uploaded with this report