Prev: [patch] build failure against db-5.0
Next: Postfix, SASL and LDAPDB [solved]
From: "Len Conrad" on 20 May 2010 12:06
FreeBSD 7.0-RELEASE

mail_version = 2.8-20100323

postfix start

or

/usr/local/etc/rc.d/postfix start

followed immediately by

postfix stop

gives

postfix/postfix-script: fatal: the Postfix mail system is not running

ps auxw| egrep master

.... nothing.

rc.conf.local has postfix_enable="YES"

I've edit postscript-script, adding "-v -v":

start)

$daemon_directory/master -t 2>/dev/null || {
$FATAL the Postfix mail system is already running
exit 1
}
if [ -f $queue_directory/quick-start ]
then
rm -f $queue_directory/quick-start
else
$daemon_directory/postfix-script check-fatal || {
$FATAL Postfix integrity check failed!
exit 1
}
# Foreground this so it can be stopped. All inodes are cached.
$daemon_directory/postfix-script check-warn
fi
$INFO starting the Postfix mail system
$daemon_directory/master -v -v &
;;

the tail of maillog shows:

May 20 10:37:35 src(a)sl1.hctc.net postfix/master[29415]: dict_eval: const
May 20 10:37:35 src(a)sl1.hctc.net postfix/master[29415]: dict_update: master_service_disable =
May 20 10:37:35 src(a)sl1.hctc.net postfix/master[29415]: dict_lookup: default_process_limit = (notfound)
May 20 10:37:35 src(a)sl1.hctc.net postfix/master[29415]: dict_update: default_process_limit = 100
May 20 10:37:35 src(a)sl1.hctc.net postfix/master[29415]: mac_parse: 60s
May 20 10:37:35 src(a)sl1.hctc.net postfix/master[29415]: dict_eval: const 60s
May 20 10:37:35 src(a)sl1.hctc.net postfix/master[29415]: dict_lookup: service_throttle_time = (notfound)
May 20 10:37:35 src(a)sl1.hctc.net postfix/master[29415]: dict_update: service_throttle_time = 60s
May 20 10:37:35 src(a)sl1.hctc.net postfix/master[29415]: dict_lookup: service_throttle_time = 60s
May 20 10:37:35 src(a)sl1.hctc.net postfix/master[29415]: mac_parse: 60s
May 20 10:37:35 src(a)sl1.hctc.net postfix/master[29415]: dict_eval: const 60s
May 20 10:37:35 src(a)sl1.hctc.net postfix/master[29415]: name_mask: ipv4
May 20 10:37:35 src(a)sl1.hctc.net postfix/master[29415]: set_eugid: euid 125 egid 125
May 20 10:37:35 src(a)sl1.hctc.net postfix/master[29415]: setugid: uid 0 gid 0

..... no errors in system messages file, no errors in maillog, no errors in dmesg system buffer.

I've thrown in 3 different main.cf from other postfix boxes, which should have thrown lots of errors in maillog, no change, no errors, no master ever.

I've totally cleaned out postfix and all config files, and did new make in dir postfix-current.

Leaving the virgin, unconfigged, distributed main.cf and editing postfix-script just to add -v -v. same results.

Len

From: Wietse Venema on 20 May 2010 13:08
Len Conrad:
> FreeBSD 7.0-RELEASE
>
> mail_version = 2.8-20100323
>
> postfix start
>
> or
>
> /usr/local/etc/rc.d/postfix start
>
> followed immediately by
>
> postfix stop
>
> gives
>
> postfix/postfix-script: fatal: the Postfix mail system is not running
>
> ps auxw| egrep master
>
> ... nothing.

So, what has changed?

Wietse

From: "Len Conrad" on 20 May 2010 14:35
---------- Original Message ----------------------------------
From: Wietse Venema <wietse(a)porcupine.org>
Reply-To: Postfix users <postfix-users(a)postfix.org>
Date: Thu, 20 May 2010 13:08:31 -0400 (EDT)

>Len Conrad:
>> FreeBSD 7.0-RELEASE
>>
>> mail_version = 2.8-20100323
>>
>> postfix start
>>
>> or
>>
>> /usr/local/etc/rc.d/postfix start
>>
>> followed immediately by
>>
>> postfix stop
>>
>> gives
>>
>> postfix/postfix-script: fatal: the Postfix mail system is not running
>>
>> ps auxw| egrep master
>>
>> ... nothing.
>
>So, what has changed?
>
> Wietse

/change/ DUNNO

I found that pf, packet filter was activated in rc.conf.local, but no rules in place. deactivated it.

the machine had over 1 year uptime (it's our syslog server), but I rebooted anyway.

no change. Master refuses quietly to stay resident.

master's last maillog words are still:

postfix/master[2137]: setugid: uid 0 gid 0

and then silence.

Len

From: Wietse Venema on 20 May 2010 15:34
Len Conrad:
> >> postfix/postfix-script: fatal: the Postfix mail system is not running
> >>
> >> ps auxw| egrep master
> >>
> >> ... nothing.
> >
> >So, what has changed?
> >
> > Wietse
>
> /change/ DUNNO
>
> I found that pf, packet filter was activated in rc.conf.local, but no rules in place. deactivated it.
>
> the machine had over 1 year uptime (it's our syslog server), but I rebooted anyway.
>
> no change. Master refuses quietly to stay resident.
>
> master's last maillog words are still:
>
> postfix/master[2137]: setugid: uid 0 gid 0
>
> and then silence.

Try running the master under ktrace:

ktrace /some/where/master -d
kdump

My speculation is that some library (or the master executable)
got corrupted.

Wietse

From: "Len Conrad" on 20 May 2010 15:42
---------- Original Message ----------------------------------
From: "Len Conrad" <lconrad(a)Go2France.com>
Reply-To: <lconrad(a)Go2France.com>
Date: Thu, 20 May 2010 20:35:40 +0200

>---------- Original Message ----------------------------------
>From: Wietse Venema <wietse(a)porcupine.org>
>Reply-To: Postfix users <postfix-users(a)postfix.org>
>Date: Thu, 20 May 2010 13:08:31 -0400 (EDT)
>
>>Len Conrad:
>>> FreeBSD 7.0-RELEASE
>>>
>>> mail_version = 2.8-20100323
>>>
>>> postfix start
>>>
>>> or
>>>
>>> /usr/local/etc/rc.d/postfix start
>>>
>>> followed immediately by
>>>
>>> postfix stop
>>>
>>> gives
>>>
>>> postfix/postfix-script: fatal: the Postfix mail system is not running
>>>
>>> ps auxw| egrep master
>>>
>>> ... nothing.
>>
>>So, what has changed?
>>
>> Wietse
>
>/change/ DUNNO
>
>I found that pf, packet filter was activated in rc.conf.local, but no rules in place. deactivated it.
>
>the machine had over 1 year uptime (it's our syslog server), but I rebooted anyway.
>
>no change. Master refuses quietly to stay resident.
>
>master's last maillog words are still:
>
> postfix/master[2137]: setugid: uid 0 gid 0
>
>and then silence.
>
>Len

=========

I inserted truss in postfix-script before master. Here's the last few lines of truss output:

close(486) ERR#9 'Bad file descriptor'
close(487) ERR#9 'Bad file descriptor'
close(488) ERR#9 'Bad file descriptor'
close(489) ERR#9 'Bad file descriptor'
close(490) ERR#9 'Bad file descriptor'
close(491) ERR#9 'Bad file descriptor'
close(492) ERR#9 'Bad file descriptor'
close(493) ERR#9 'Bad file descriptor'
close(494) ERR#9 'Bad file descriptor'
close(495) ERR#9 'Bad file descriptor'
close(496) ERR#9 'Bad file descriptor'
close(497) ERR#9 'Bad file descriptor'
close(498) ERR#9 'Bad file descriptor'
close(499) ERR#9 'Bad file descriptor'
geteuid(0xa,0x805da9a,0xbfbfe9a8,0x8056cbf,0x28202048,0x28202048) = 0 (0x0)
getuid(0xa,0x805da9a,0xbfbfe9a8,0x8056cbf,0x28202048,0x28202048) = 0 (0x0)
issetugid(0xa,0x805da9a,0xbfbfe9a8,0x8056cbf,0x28202048,0x28202048) = 0 (0x0)
getgid(0xa,0x805da9a,0xbfbfe9a8,0x8056cbf,0x28202048,0x28202048) = 0 (0x0)
getegid(0xa,0x805da9a,0xbfbfe9a8,0x8056cbf,0x28202048,0x28202048) = 0 (0x0)
geteuid(0x0,0x1,0xbfbfe9c8,0x805593d,0x28203048,0x805ef98) = 0 (0x0)
getuid(0x0,0x1,0xbfbfe9c8,0x805593d,0x28203048,0x805ef98) = 0 (0x0)
issetugid(0x0,0x1,0xbfbfe9c8,0x805593d,0x28203048,0x805ef98) = 0 (0x0)
getgid(0x0,0x1,0xbfbfe9c8,0x805593d,0x28203048,0x805ef98) = 0 (0x0)
getegid(0x0,0x1,0xbfbfe9c8,0x805593d,0x28203048,0x805ef98) = 0 (0x0)
access("/etc/localtime",4) = 0 (0x0)
open("/etc/localtime",O_RDONLY,00) = 3 (0x3)
fstat(3,{mode=-r--r--r-- ,inode=188781,size=1279,blksize=4096}) = 0 (0x0)
read(3,"TZif\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,7944) = 1279 (0x4ff)
close(3) = 0 (0x0)
socket(PF_LOCAL,SOCK_DGRAM,0) = 3 (0x3)
fcntl(3,F_SETFD,FD_CLOEXEC) = 0 (0x0)
connect(3,{ AF_UNIX "/var/run/logpriv" },106) = 0 (0x0)
getuid(0x80559a0,0x1,0x10,0xbfbfeb1c,0xbfbfeb24,0x281beda0) = 0 (0x0)
geteuid(0x4,0xbfbfea4c,0xbfbfea08,0x8049eec,0x80559a0,0x1) = 0 (0x0)
getuid(0x4,0xbfbfea4c,0xbfbfea08,0x8049eec,0x80559a0,0x1) = 0 (0x0)
issetugid(0x4,0xbfbfea4c,0xbfbfea08,0x8049eec,0x80559a0,0x1) = 0 (0x0)
getgid(0x4,0xbfbfea4c,0xbfbfea08,0x8049eec,0x80559a0,0x1) = 0 (0x0)
getegid(0x4,0xbfbfea4c,0xbfbfea08,0x8049eec,0x80559a0,0x1) = 0 (0x0)
close(0) = 0 (0x0)
open("/dev/null",O_RDWR,00) = 0 (0x0)
close(1) = 0 (0x0)
open("/dev/null",O_RDWR,00) = 1 (0x1)
close(2) = 0 (0x0)
open("/dev/null",O_RDWR,00) = 2 (0x2)
setsid(0x805c71d,0x2,0x0,0xbfbfeb1c,0xbfbfeb24,0x281beda0) ERR#1 'Operation not permitted'
getsid(0x0,0x2,0x0,0xbfbfeb1c,0xbfbfeb24,0x281beda0) = 798 (0x31e)
getpid(0x0,0x2,0x0,0xbfbfeb1c,0xbfbfeb24,0x281beda0) = 18366 (0x47be)
gettimeofday({1274384341.299480},0x0) = 0 (0x0)
getpid(0x28201068,0x281c3e20,0xbfbfe8c2,0x0,0x0,0xbfbfdc7e) = 18366 (0x47be)
sendto(3,"<18>May 20 14:39:01 postfix/mast"...,117,0x0,NULL,0x0) = 117 (0x75)
nanosleep({1.000000000}) = 0 (0x0)
process exit, rval = 1

Len

 |  Next  |  Last
Pages: 1 2 3
Prev: [patch] build failure against db-5.0
Next: Postfix, SASL and LDAPDB [solved]