BUG #16365: recieve smart shutdown after system start

Started by PG Bug reporting formalmost 6 years ago3 messagesbugs
Jump to latest
#1PG Bug reporting form
noreply@postgresql.org

The following bug has been logged on the website:

Bug reference: 16365
Logged by: Roman Pivnitskiy
Email address: prd87@mail.ru
PostgreSQL version: 9.5.7
Operating system: Debian GNU/Linux 8.8 (jessie)
Description:

Hello.
On some servers, we began to encounter the "strange" behavior of
postgresql.
When shutting down the server at the command of UPS (shutdown now). The next
time you turn on postgresql, it gets smart shutdown immediately at startup
In logs pg
when server shutdown
2020-04-15 05:26:48 MSK [936]: [4-1] db=,user=,app=,client= LOG: received
fast shutdown request
2020-04-15 05:26:48 MSK [936]: [5-1] db=,user=,app=,client= LOG: aborting
any active transactions
2020-04-15 05:26:48 MSK [1338]: [2-1] db=,user=,app=,client= LOG:
autovacuum launcher shutting down
2020-04-15 05:26:53 MSK [1335]: [7664-1] db=,user=,app=,client= LOG:
checkpoint complete: wrote 13604 buffers (23.6%); 0 transaction log file(s)
added, 0 removed, 0 recycled; write=472.958 s, sync=2.984 s, total=476.084
s; sync files=251, longest=1.098 s, average=0.011 s; distance=125092 kB,
estimate=203540 kB
2020-04-15 05:26:53 MSK [1335]: [7665-1] db=,user=,app=,client= LOG:
shutting down
2020-04-15 05:26:54 MSK [1335]: [7666-1] db=,user=,app=,client= LOG:
checkpoint starting: shutdown immediate
2020-04-15 05:26:54 MSK [1335]: [7667-1] db=,user=,app=,client= LOG:
checkpoint complete: wrote 79 buffers (0.1%); 0 transaction log file(s)
added, 8 removed, 0 recycled; write=0.001 s, sync=0.393 s, total=0.552 s;
sync files=18, longest=0.104 s, average=0.021 s; distance=15863 kB,
estimate=184772 kB
2020-04-15 05:26:54 MSK [1335]: [7668-1] db=,user=,app=,client= LOG:
database system is shut down

after power on and start OS
2020-04-15 07:49:08 MSK [947]: [3-1] db=,user=,app=,client= LOG: received
smart shutdown request
2020-04-15 07:49:08 MSK [1524]: [1-1] db=,user=,app=,client= LOG: database
system was shut down at 2020-04-15 05:26:54 MSK
2020-04-15 07:49:15 MSK [1524]: [2-1] db=,user=,app=,client= LOG: MultiXact
member wraparound protections are now enabled
2020-04-15 07:49:15 MSK [2398]: [1-1] db=,user=,app=,client= LOG: shutting
down
2020-04-15 07:49:16 MSK [2398]: [2-1] db=,user=,app=,client= LOG:
checkpoint starting: shutdown immediate
2020-04-15 07:49:16 MSK [2398]: [3-1] db=,user=,app=,client= LOG:
checkpoint complete: wrote 0 buffers (0.0%); 0 transaction log file(s)
added, 1 removed, 0 recycled; write=0.001 s, sync=0.000 s, total=0.779 s;
sync files=0, longest=0.000 s, average=0.000 s; distance=16384 kB,
estimate=16384 kB
2020-04-15 07:49:16 MSK [2398]: [4-1] db=,user=,app=,client= LOG: database
system is shut down

after manual start all ok (Even if you just restart the server in any way -
auto start will happen correctly)
2020-04-15 09:27:49 MSK [21204]: [1-1] db=,user=,app=,client= LOG: database
system was shut down at 2020-04-15 07:49:16 MSK
2020-04-15 09:27:49 MSK [21204]: [2-1] db=,user=,app=,client= LOG:
MultiXact member wraparound protections are now enabled
2020-04-15 09:27:49 MSK [21208]: [1-1] db=,user=,app=,client= LOG:
autovacuum launcher started
2020-04-15 09:27:49 MSK [21202]: [3-1] db=,user=,app=,client= LOG: database
system is ready to accept connections
2020-04-15 09:27:50 MSK [21213]: [1-1]
db=[unknown],user=[unknown],app=[unknown],client=[local] LOG: connection
received: host=[local]

#2Tom Lane
tgl@sss.pgh.pa.us
In reply to: PG Bug reporting form (#1)
Re: BUG #16365: recieve smart shutdown after system start

PG Bug reporting form <noreply@postgresql.org> writes:

On some servers, we began to encounter the "strange" behavior of
postgresql.
When shutting down the server at the command of UPS (shutdown now). The next
time you turn on postgresql, it gets smart shutdown immediately at startup

Something is sending the server a SIGTERM signal. This is not a
Postgres bug, it's something else in your system doing something
it shouldn't.

regards, tom lane

In reply to: Tom Lane (#2)
Re[2]: BUG #16365: recieve smart shutdown after system start

Thanks for the answer.
The only thing that united all the servers on which this behavior manifested was a shutdown on command from the UPS.
The UPS software has now changed. There was apcupsd, became chick-monitoring.
However, the behavior of postgresql persisted.
Completion does not apply to any other system processes. But it applies to all elements of the cluster (i.e., it was originally 1 - main, now there are 2 of them).

 

Среда, 15 апреля 2020, 17:53 +04:00 от Tom Lane <tgl@sss.pgh.pa.us>:
 
PG Bug reporting form < noreply@postgresql.org > writes:

On some servers, we began to encounter the "strange" behavior of
postgresql.
When shutting down the server at the command of UPS (shutdown now). The next
time you turn on postgresql, it gets smart shutdown immediately at startup

Something is sending the server a SIGTERM signal. This is not a
Postgres bug, it's something else in your system doing something
it shouldn't.

regards, tom lane

 
 
С уважением.