From: | "Thomas H(dot)" <me(at)alternize(dot)com> |
---|---|
To: | "Tom Lane" <tgl(at)sss(dot)pgh(dot)pa(dot)us> |
Cc: | <pgsql-bugs(at)postgresql(dot)org> |
Subject: | Re: fsync and semctl errors with 8.1.5/win32 |
Date: | 2006-12-05 04:38:51 |
Message-ID: | 00f801c71827$43e5e700$0201a8c0@iwing |
Views: | Raw Message | Whole Thread | Download mbox | Resend email |
Thread: | |
Lists: | pgsql-bugs |
>> ... in addition to the above messages, the log is now also
>> flooded by:
>
>> 2006-12-05 04:16:29 [5196] LOG: could not rename temporary statistics
>> file
>> "global/pgstat.tmp" to "global/pgstat.stat": A blocking operation was
>> interrupted by a call to WSACancelBlockingCall.
>
> Hm ... there simply isn't anything that holds pgstat.stat open for long,
> so this behavior seems independent of any other issues we might have.
> Can you find any evidence about what's wrong here?
hope this helps:
05:33:14 postgres.exe:5196 CREATE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Options: OverwriteIf Access: 00120196
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 0 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 4096 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 8192 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 12288 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 16384 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 20480 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 24576 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 28672 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 32768 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 36864 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 40960 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 45056 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 49152 Length: 1650
05:33:14 postgres.exe:5196 CLOSE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS
05:33:14 postgres.exe:5196 OPEN D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Options: Open Access: 00110080
05:33:14 postgres.exe:5196 QUERY INFORMATION
D:\DB\postgreSQL.82\data\global\pgstat.tmp SUCCESS
FileAttributeTagInformation
05:33:14 postgres.exe:5196 QUERY INFORMATION
D:\DB\postgreSQL.82\data\global\pgstat.tmp SUCCESS Attributes: A
05:33:14 postgres.exe:5196 OPEN D:\DB\postgreSQL.82\data\global\pgstat.stat
SUCCESS Options: Open Access: 00100002
05:33:14 postgres.exe:5196 SET INFORMATION
D:\DB\postgreSQL.82\data\global\pgstat.tmp * 0xC0000123
FileRenameInformation
05:33:14 postgres.exe:5196 CLOSE D:\DB\postgreSQL.82\data\global\pgstat.stat
SUCCESS
05:33:14 postgres.exe:5196 OPEN D:\DB\postgreSQL.82\data\global\pgstat.tmp
NOT FOUND Options: Open Access: 00110080
05:33:14 postgres.exe:5196 OPEN D:\DB\postgreSQL.82\data\global\pgstat.tmp
NOT FOUND Options: Open Access: 00010080
05:33:14 postgres.exe:5196 CREATE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Options: OverwriteIf Access: 00120196
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 0 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 4096 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 8192 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 12288 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 16384 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 20480 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 24576 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 28672 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 32768 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 36864 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 40960 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 45056 Length: 4096
05:33:14 postgres.exe:5196 WRITE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Offset: 49152 Length: 1650
05:33:14 postgres.exe:5196 CLOSE D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS
05:33:14 postgres.exe:5196 OPEN D:\DB\postgreSQL.82\data\global\pgstat.tmp
SUCCESS Options: Open Access: 00110080
05:33:14 postgres.exe:5196 QUERY INFORMATION
D:\DB\postgreSQL.82\data\global\pgstat.tmp SUCCESS
FileAttributeTagInformation
05:33:14 postgres.exe:5196 QUERY INFORMATION
D:\DB\postgreSQL.82\data\global\pgstat.tmp SUCCESS Attributes: A
05:33:14 postgres.exe:5196 OPEN D:\DB\postgreSQL.82\data\global\pgstat.stat
SUCCESS Options: Open Access: 00100002
05:33:14 postgres.exe:5196 SET INFORMATION
D:\DB\postgreSQL.82\data\global\pgstat.tmp * 0xC0000123
FileRenameInformation
05:33:14 postgres.exe:5196 CLOSE D:\DB\postgreSQL.82\data\global\pgstat.stat
SUCCESS
05:33:14 postgres.exe:5196 OPEN D:\DB\postgreSQL.82\data\global\pgstat.tmp
NOT FOUND Options: Open Access: 00110080
05:33:14 postgres.exe:5196 OPEN D:\DB\postgreSQL.82\data\global\pgstat.tmp
NOT FOUND Options: Open Access: 00010080
those are the file actions that are happening at the same time as the error
log message appears.
2006-12-05 05:33:14 [5196] LOG: could not rename temporary statistics file
"global/pgstat.tmp" to "global/pgstat.stat": A blocking operation was
interrupted by a call to WSACancelBlockingCall.
2006-12-05 05:33:14 [5196] LOG: could not rename temporary statistics file
"global/pgstat.tmp" to "global/pgstat.stat": A blocking operation was
interrupted by a call to WSACancelBlockingCall.
the next file actions with pgstat take place some seconds later.
more or less the same thing is happening every 2-3 seconds when the log
errors appear. there was a short pause of ~30min when this error didn't
appear, but for over 40min now it is logged every few seconds. the rc1
doesn't show this behaviour, i've just doublechecked.
- thomas
From | Date | Subject | |
---|---|---|---|
Next Message | Thomas H. | 2006-12-05 04:59:54 | Re: fsync and semctl errors with 8.1.5/win32 |
Previous Message | Tom Lane | 2006-12-05 04:25:39 | Re: fsync and semctl errors with 8.1.5/win32 |