Bug #843: pg_clog files problem

Nikolay Hristov (charlie(at)mail(dot)vega(dot)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