http://bugzilla.novell.com/show_bug.cgi?id=600409

http://bugzilla.novell.com/show_bug.cgi?id=600409#c0

Summary: amavisd not starting after system crash because of stale pid file Classification: openSUSE Product: openSUSE 11.2 Version: Final Platform: x86-64 OS/Version: openSUSE 11.2 Status: NEW Severity: Normal Priority: P5 - None Component: Basesystem AssignedTo: bnc-team-screening@forge.provo.novell.com ReportedBy: novell-web@zmi.at QAContact: qa@suse.de Found By: --- Blocker: ---

Created an attachment (id=357327) --> (http://bugzilla.novell.com/attachment.cgi?id=357327) Patch for amavis init script

User-Agent: Mozilla/5.0 (X11; U; Linux x86_64; de; rv:1.9.1.9) Gecko/20100317 SUSE/3.5.9-0.1.1 Firefox/3.5.9

One of our VMs stopped working, we had to "force shutdown" and restart it. The start script of amavisd failed to remove the old, stale pid file from amavis, and therefore amavis wouldn't start until we manually removed it with rm /var/spool/amavis/amavisd.pid

Here the amavis log when we tried to start it with "rcamavis start": Apr 28 11:08:08 protegate54 amavis[2352]: Ignoring stale PID file /var/spool/amavis/amavisd.pid, older than system uptime 0 0:00:00 Apr 28 11:08:08 protegate54 amavis[2352]: starting. /usr/sbin/amavisd at protegate54.zmi.at amavisd-new-2.6.2 (20081215), Unicode aware, LC_ALL="POSIX" Apr 28 11:08:08 protegate54 amavis[2352]: user=, EUID: 65 (65); group=, EGID: 103 103 (103 103) Apr 28 11:08:08 protegate54 amavis[2352]: Perl version 5.010000 Apr 28 11:08:09 protegate54 amavis[2352]: SpamControl: init_pre_chroot on SpamAssassin done Apr 28 11:08:09 protegate54 amavis[2352]: (!)Net::Server: 2010/04/28-11:08:09 Pid_file already exists for running process (2335)... aborting\n\n at line 277 in file /usr/lib/perl5/vendor_perl/5.10.0/Net/Server.pm Apr 28 11:08:09 protegate54 amavis[2352]: Net::Server: 2010/04/28-11:08:09 Server closing! Apr 28 11:10:16 protegate54 amavis[2833]: Ignoring stale PID file /var/spool/amavis/amavisd.pid, older than system uptime 0 0:02:00 Apr 28 11:10:16 protegate54 amavis[2833]: starting. /usr/sbin/amavisd at protegate54.zmi.at amavisd-new-2.6.2 (20081215), Unicode aware, LC_ALL="POSIX", LANG="de_DE.UTF-8" Apr 28 11:10:16 protegate54 amavis[2833]: user=, EUID: 65 (65); group=, EGID: 103 103 (103 103) Apr 28 11:10:16 protegate54 amavis[2833]: Perl version 5.010000 Apr 28 11:10:16 protegate54 amavis[2833]: SpamControl: init_pre_chroot on SpamAssassin done Apr 28 11:10:16 protegate54 amavis[2833]: (!)Net::Server: 2010/04/28-11:10:16 Pid_file already exists for running process (2335)... aborting\n\n at line 277 in file /usr/lib/perl5/vendor_perl/5.10.0/Net/Server.pm Apr 28 11:10:16 protegate54 amavis[2833]: Net::Server: 2010/04/28-11:10:16 Server closing! Apr 28 11:10:43 protegate54 amavis[2957]: Ignoring stale PID file /var/spool/amavis/amavisd.pid, older than system uptime 0 0:02:00 Apr 28 11:10:43 protegate54 amavis[2957]: starting. /usr/sbin/amavisd at protegate54.zmi.at amavisd-new-2.6.2 (20081215), Unicode aware, LC_ALL="POSIX", LANG="de_DE.UTF-8" Apr 28 11:10:43 protegate54 amavis[2957]: user=, EUID: 65 (65); group=, EGID: 103 103 (103 103) Apr 28 11:10:43 protegate54 amavis[2957]: Perl version 5.010000 Apr 28 11:10:44 protegate54 amavis[2957]: SpamControl: init_pre_chroot on SpamAssassin done Apr 28 11:10:44 protegate54 amavis[2957]: (!)Net::Server: 2010/04/28-11:10:44 Pid_file already exists for running process (2335)... aborting\n\n at line 277 in file /usr/lib/perl5/vendor_perl/5.10.0/Net/Server.pm Apr 28 11:10:44 protegate54 amavis[2957]: Net::Server: 2010/04/28-11:10:44 Server closing! Apr 28 11:11:20 protegate54 amavis[3064]: Ignoring stale PID file /var/spool/amavis/amavisd.pid, older than system uptime 0 0:03:00 Apr 28 11:11:20 protegate54 amavis[3064]: starting. /usr/sbin/amavisd at protegate54.zmi.at amavisd-new-2.6.2 (20081215), Unicode aware, LC_ALL="POSIX", LANG="de_DE.UTF-8" Apr 28 11:11:20 protegate54 amavis[3064]: user=, EUID: 65 (65); group=, EGID: 103 103 (103 103) Apr 28 11:11:20 protegate54 amavis[3064]: Perl version 5.010000 Apr 28 11:11:20 protegate54 amavis[3064]: SpamControl: init_pre_chroot on SpamAssassin done Apr 28 11:11:20 protegate54 amavis[3064]: (!)Net::Server: 2010/04/28-11:11:20 Pid_file already exists for running process (2335)... aborting\n\n at line 277 in file /usr/lib/perl5/vendor_perl/5.10.0/Net/Server.pm Apr 28 11:11:20 protegate54 amavis[3064]: Net::Server: 2010/04/28-11:11:20 Server closing!

And after "rm /var/spool/amavis/amavisd.pid" it was OK:

Apr 28 11:11:46 protegate54 amavis[3127]: starting. /usr/sbin/amavisd at protegate54.zmi.at amavisd-new-2.6.2 (20081215), Unicode aware, LC_ALL="POSIX", LANG="de_DE.UTF-8" Apr 28 11:11:46 protegate54 amavis[3127]: user=, EUID: 65 (65); group=, EGID: 103 103 (103 103) Apr 28 11:11:46 protegate54 amavis[3127]: Perl version 5.010000 Apr 28 11:11:46 protegate54 amavis[3127]: SpamControl: init_pre_chroot on SpamAssassin done Apr 28 11:11:46 protegate54 amavis[3128]: Net::Server: Process Backgrounded Apr 28 11:11:46 protegate54 amavis[3128]: Net::Server: 2010/04/28-11:11:46 Amavis (type Net::Server::PreForkSimple) starting! pid(3128) Apr 28 11:11:46 protegate54 amavis[3128]: Net::Server: Binding to UNIX socket file /var/spool/amavis/amavisd.sock using SOCK_STREAM Apr 28 11:11:46 protegate54 amavis[3128]: Net::Server: Binding to TCP port 10024 on host 127.0.0.1 Apr 28 11:11:46 protegate54 amavis[3128]: Net::Server: Group Not Defined. Defaulting to EGID '103 103' Apr 28 11:11:46 protegate54 amavis[3128]: Net::Server: User Not Defined. Defaulting to EUID '65'

So please improve the start script of amavisd

Reproducible: Didn't try

Steps to Reproduce: 1. VM crashes, leaving amavisd.pid file 2. restart VM 3. amavis won't start until pid file manually removed Actual Results: amavisd doesn't start

Expected Results: amavisd should start when the pid file is stale. I attach a patch for /etc/init.d/amavis