On Fri, 2006-05-05 at 15:10 -0400, Tom Lane wrote:
> Rod Taylor <[EMAIL PROTECTED]> writes:
> > On Fri, 2006-05-05 at 14:31 -0400, Tom Lane wrote:
> >> Unless you had an actual backend crash, that's not an adequate
> >> explanation. Transaction abort does clean up created files.
>
> > The only thing I can come up with is that perhaps someone forcefully
> > gave it a kick. SIGTERM is a necessary action once in a while to unwedge
> > a stuck db connection (killing the client script doesn't always get it
> > immediately).
>
> SIGTERM wouldn't cause that either. I hope your people are not in the
> habit of using "kill -9"?
Command line records, etc. are not available, but I did track down a a
snippet of logs from the backups (daily log rotation). Sorry, I didn't
realize there were backups initially -- it's unusual. Appears it did
crash or get killed in some way "exited with exit code 1".
It's a temp DB to try a different database encoding (prep for 8.1
upgrade) with production data.
Is there something you would like me to try doing in an attempt to
reproduce? Preferably with a smaller structure.
The truncate would have happened as part of the prepareTableForCopy()
call.
slony%ssdb 10171 4621947 2006-05-02 05:09:40 EDTLOG: 00000: duration:
30526368.316 ms statement: select "_ssrep".prepareTableForCopy(1010); copy
<SNIP> from stdin;
slony%ssdb 10171 4621947 2006-05-02 05:09:40 EDTLOCATION: exec_simple_query,
postgres.c:1103
slony%ssdb 10171 4621947 2006-05-02 05:09:40 EDTLOCATION: exec_simple_query,
postgres.c:1103
slony%ssdb 10181 0 2006-05-02 15:32:06 EDTLOG: 08P01: unexpected EOF on client
connection
slony%ssdb 10181 0 2006-05-02 15:32:06 EDTLOCATION: SocketBackend,
postgres.c:295
slony%ssdb 10154 0 2006-05-02 15:32:06 EDTLOG: 08P01: unexpected EOF on client
connection
slony%ssdb 10154 0 2006-05-02 15:32:06 EDTLOCATION: SocketBackend,
postgres.c:295
slony%ssdb 10173 0 2006-05-02 16:30:53 EDTLOG: 08P01: unexpected EOF on client
connection
slony%ssdb 10173 0 2006-05-02 16:30:53 EDTLOCATION: SocketBackend,
postgres.c:295
slony%ssdb 10755 0 2006-05-02 16:30:53 EDTLOG: 08P01: unexpected EOF on client
connection
slony%ssdb 10755 0 2006-05-02 16:30:53 EDTLOCATION: SocketBackend,
postgres.c:295
slony%ssdb 300 0 2006-05-02 16:55:18 EDTLOG: 08P01: unexpected EOF on client
connection
slony%ssdb 300 0 2006-05-02 16:55:18 EDTLOCATION: SocketBackend, postgres.c:295
slony%ssdb 301 0 2006-05-02 16:55:18 EDTLOG: 08P01: unexpected EOF on client
connection
slony%ssdb 301 0 2006-05-02 16:55:18 EDTLOCATION: SocketBackend, postgres.c:295
% 1960 2006-05-02 17:03:19 EDTLOG: 00000: server process (PID 10171) exited
with exit code 1
% 1960 2006-05-02 17:03:19 EDTLOCATION: LogChildExit, postmaster.c:2416
% 1960 2006-05-02 17:03:19 EDTLOG: 00000: terminating any other active server
processes
% 1960 2006-05-02 17:03:19 EDTLOCATION: HandleChildCrash, postmaster.c:2306
% 1960 2006-05-02 17:03:19 EDTLOCATION: HandleChildCrash, postmaster.c:2306
% 1960 2006-05-02 17:03:19 EDTLOG: 00000: all server processes terminated;
reinitializing
% 1960 2006-05-02 17:03:19 EDTLOCATION: reaper, postmaster.c:2206
< snip connection attempts >
% 5826 2006-05-02 17:03:22 EDTLOG: 00000: database system was interrupted at
2006-05-02 16:06:20 EDT
% 5826 2006-05-02 17:03:22 EDTLOCATION: StartupXLOG, xlog.c:4374
% 5826 2006-05-02 17:03:22 EDTLOG: 00000: checkpoint record is at 59/E0B56920
% 5826 2006-05-02 17:03:22 EDTLOCATION: StartupXLOG, xlog.c:4442
% 5826 2006-05-02 17:03:22 EDTLOG: 00000: redo record is at 59/E0B56920; undo
record is at 0/0; shutdown FALSE
% 5826 2006-05-02 17:03:22 EDTLOCATION: StartupXLOG, xlog.c:4469
% 5826 2006-05-02 17:03:22 EDTLOG: 00000: next transaction ID: 4863932; next
OID: 1441853
% 5826 2006-05-02 17:03:22 EDTLOCATION: StartupXLOG, xlog.c:4472
% 5826 2006-05-02 17:03:22 EDTLOG: 00000: next MultiXactId: 1; next
MultiXactOffset: 0
% 5826 2006-05-02 17:03:22 EDTLOCATION: StartupXLOG, xlog.c:4475
% 5826 2006-05-02 17:03:22 EDTLOG: 00000: database system was not properly
shut down; automatic recovery in progress
% 5826 2006-05-02 17:03:22 EDTLOCATION: StartupXLOG, xlog.c:4532
% 5826 2006-05-02 17:03:22 EDTLOG: 00000: redo starts at 59/E0B56970
% 5826 2006-05-02 17:03:22 EDTLOCATION: StartupXLOG, xlog.c:4569
% 5826 2006-05-02 17:03:22 EDTLOG: 00000: record with zero length at
59/E0E429B8
% 5826 2006-05-02 17:03:22 EDTLOCATION: ReadRecord, xlog.c:2764
% 5826 2006-05-02 17:03:22 EDTLOG: 00000: redo done at 59/E0E42988
% 5826 2006-05-02 17:03:22 EDTLOCATION: StartupXLOG, xlog.c:4627
% 5826 2006-05-02 17:03:23 EDTLOG: 00000: database system is ready
% 5826 2006-05-02 17:03:23 EDTLOCATION: StartupXLOG, xlog.c:4821
% 5826 2006-05-02 17:03:23 EDTLOG: 00000: transaction ID wrap limit is
1073749769, limited by database "ssdb"
% 5826 2006-05-02 17:03:23 EDTLOCATION: SetTransactionIdLimit, varsup.c:234
--
---------------------------(end of broadcast)---------------------------
TIP 1: if posting/reading through Usenet, please send an appropriate
subscribe-nomail command to [EMAIL PROTECTED] so that your
message can get through to the mailing list cleanly
