[Dovecot] Dovecot startup at boottime fails

Thu Apr 8 20:55:38 EEST 2004

I don't even have a seperate /var partition. Just / and swap.

Attached you can find an strace output of /usr/libexec/dovecot/dovecot-auth 
during boot.

During boot, the last service to start is dovecot (I did this on purpose to 
make sure everything is up and running before attempting to start dovecot in 
case dovecot had some dependencies), this fails with the error message 
(in /var/log/mail.err)

"dovecot: Login process died too early - shutting down"

If, after boot, I just login as root and type:

/etc/init.d/dovecot start

Dovecot starts fine.

As you can see from the strace, the dovecot-auth seems to have some trouble 
reading the socket.

B.

On Tuesday 23 March 2004 18:43, Skye Poier wrote:
> OK, I guess those perms are probably right.
> Is /var mounted rw during your "run level 3" ?
> I know nothing about SUSE.
>
> Skye
>
> > Hi,
> >
> > What exactly do you mean with this?
> > These are the permissions of the /var/run/dovecot/login directory:
> > drwxr-x---    2 root     dovecot        72 Mar 23 00:20 login
> >
> > B.
> >
> > On Friday 19 March 2004 20:05, Skye Poier wrote:
> > > Does dovecot-auth have permissions to /var/run/dovecot/login
> > > during boot time?
> > >
> > > Skye
> > >
> > > Word on the street is Bavo De Ridder said:
> > > > Hi,
> > > >
> > > > I am running dovecot 0.99.10.4 on SuSE 9. I installed it using
> > > > apt-get from the gwdg repository.
> > > >
> > > > The dovecot service is configured to start at boottime in run level 3
> > > > and 5. However, it dies immediately with this error
> > > > (/var/log/mail.err):
> > > >
> > > > dovecot: Login process died too early - shutting down
> > > >
> > > > Starting the service afterwords from a prompt as root with the
> > > > command:
> > > >
> > > > /etc/init.d/dovecot start
> > > >
> > > > works without a glitch. Attached you can find my dovecot.conf and the
> > > > startup script /etc/init.d/dovecot.
> > > >
> > > > I hope someone could shed some light on this issue.

-- 
Bavo De Ridder
Web Service Consulting & EMEA Linux Practice
Novell, Inc.

	"In God We Trust, everyone else get yourself an X.500 certificate"

-------------- next part --------------
execve("/usr/libexec/dovecot/dovecot-auth2", ["/usr/libexec/dovecot/dovecot-auth2"], [/* 16 vars */]) = 0
uname({sys="Linux", node="BRU-P7J0J-BDERIDDER", ...}) = 0
brk(0)                                  = 0x8064b04
open("/etc/ld.so.preload", O_RDONLY)    = -1 ENOENT (No such file or directory)
open("/etc/ld.so.cache", O_RDONLY)      = 5
fstat64(5, {st_mode=S_IFREG|0644, st_size=86746, ...}) = 0
old_mmap(NULL, 86746, PROT_READ, MAP_PRIVATE, 5, 0) = 0x40016000
close(5)                                = 0
open("/lib/libpam.so.0", O_RDONLY)      = 5
read(5, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\220\25\0\0004\0\0\0\234u\0\0\0\0\0\0004\0 \0\3\0(\0\31\0\26\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\372o\0\0\372o\0\0\5\0\0\0\0\20\0\0\1\0\0\0\0p\0\0\0p\0\0\0p\0\0\224\2\0\0\230\2\0\0\6\0\0\0\0\20\0\0\2\0\0\0\310p\0\0\310p\0\0\310p\0\0\320\0\0\0\320\0\0\0\6\0\0\0\4\0\0\0a\0\0\0f\0\0\0Y\0\0\0\0\0\0\0I\0\0\0?\0\0\0L\0\0\0$\0\0\0\0\0\0\0\33\0\0\0\0\0\0\0H\0\0\0\0\0\0\0Q\0\0\0,\0\0\0^\0\0\0J\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0S\0\0\0N\0\0\0-\0\0\0\0\0"..., 512) = 512
fstat64(5, {st_mode=S_IFREG|0755, st_size=36200, ...}) = 0
old_mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x4002c000
old_mmap(NULL, 29336, PROT_READ|PROT_EXEC, MAP_PRIVATE, 5, 0) = 0x4002d000
old_mmap(0x40034000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 5, 0x7000) = 0x40034000
close(5)                                = 0
open("/usr/lib/libldap.so.2", O_RDONLY) = 5
read(5, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0 \210\0\0004\0\0\0\2604\3\0\0\0\0\0004\0 \0\3\0(\0\31\0\26\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0c\26\3\0c\26\3\0\5\0\0\0\0\20\0\0\1\0\0\0\0 \3\0\0 \3\0\0 \3\0l\r\0\0\250\r\0\0\6\0\0\0\0\20\0\0\2\0\0\0\f&\3\0\f&\3\0\f&\3\0\370\0\0\0\370\0\0\0\6\0\0\0\4\0\0\0\t\2\0\0?\2\0\0\316\1\0\0>\1\0\0\0\0\0\0y\1\0\0001\2\0\0\0\0\0\0\0\0\0\0\353\1\0\0\0\0\0\0X\1\0\0\212\1\0\0\266\1\0\0\340\0\0\0\312\1\0\0\307\1\0\0{\0\0\0\330\1\0\0[\1\0\0\0\0\0\0\327\0\0\0\221\1\0\0W\0"..., 512) = 512
fstat64(5, {st_mode=S_IFREG|0755, st_size=237971, ...}) = 0
old_mmap(NULL, 208296, PROT_READ|PROT_EXEC, MAP_PRIVATE, 5, 0) = 0x40035000
old_mmap(0x40067000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 5, 0x32000) = 0x40067000
close(5)                                = 0
open("/usr/lib/liblber.so.2", O_RDONLY) = 5
read(5, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0p%\0\0004\0\0\0L\266\0\0\0\0\0\0004\0 \0\3\0(\0\31\0\26\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\203\256\0\0\203\256\0\0\5\0\0\0\0\20\0\0\1\0\0\0\0\260\0\0\0\260\0\0\0\260\0\0\254\3\0\0P\4\0\0\6\0\0\0\0\20\0\0\2\0\0\0\24\261\0\0\24\261\0\0\24\261\0\0\310\0\0\0\310\0\0\0\6\0\0\0\4\0\0\0\203\0\0\0\262\0\0\0\220\0\0\0\213\0\0\0\202\0\0\0V\0\0\0\0\0\0\0`\0\0\0\205\0\0\0\261\0\0\0\230\0\0\0O\0\0\0\257\0\0\0\0\0\0\0\207\0\0\0\231\0\0\0=\0\0\0\0\0\0\0\201\0\0\0\0\0"..., 512) = 512
fstat64(5, {st_mode=S_IFREG|0755, st_size=56275, ...}) = 0
old_mmap(NULL, 46160, PROT_READ|PROT_EXEC, MAP_PRIVATE, 5, 0) = 0x40068000
old_mmap(0x40073000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 5, 0xb000) = 0x40073000
close(5)                                = 0
open("/usr/lib/libsasl2.so.2", O_RDONLY) = 5
read(5, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\20/\0\0004\0\0\0\30.\1\0\0\0\0\0004\0 \0\3\0(\0\31\0\26\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\264$\1\0\264$\1\0\5\0\0\0\0\20\0\0\1\0\0\0\300$\1\0\3004\1\0\3004\1\0\220\6\0\0\354\6\0\0\6\0\0\0\0\20\0\0\2\0\0\0\304\'\1\0\3047\1\0\3047\1\0\330\0\0\0\330\0\0\0\6\0\0\0\4\0\0\0\305\0\0\0\330\0\0\0\313\0\0\0\220\0\0\0\261\0\0\0\0\0\0\0e\0\0\0\0\0\0\0\252\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\214\0\0\0\257\0\0\0\0\0\0\0\323\0\0\0q\0\0\0\0\0\0\0\0\0\0\0\203\0\0\0Q\0\0\0\0"..., 512) = 512
fstat64(5, {st_mode=S_IFREG|0755, st_size=89417, ...}) = 0
old_mmap(NULL, 80812, PROT_READ|PROT_EXEC, MAP_PRIVATE, 5, 0) = 0x40074000
old_mmap(0x40087000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 5, 0x12000) = 0x40087000
close(5)                                = 0
open("/lib/libresolv.so.2", O_RDONLY)   = 5
read(5, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\0*\0\0004\0\0\0(\374\0\0\0\0\0\0004\0 \0\6\0(\0\34\0\31\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0\300\0\0\0\300\0\0\0\5\0\0\0\4\0\0\0\3\0\0\0l\344\0\0l\344\0\0l\344\0\0\23\0\0\0\23\0\0\0\4\0\0\0\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\177\344\0\0\177\344\0\0\5\0\0\0\0\20\0\0\1\0\0\0\0\360\0\0\0\360\0\0\0\360\0\0\210\10\0\0\250/\0\0\6\0\0\0\0\20\0\0\2\0\0\0\344\365\0\0\344\365\0\0\344\365\0\0\330\0\0\0\330\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\364\0\0\0\364\0\0\0\364"..., 512) = 512
fstat64(5, {st_mode=S_IFREG|0755, st_size=74577, ...}) = 0
old_mmap(NULL, 73640, PROT_READ|PROT_EXEC, MAP_PRIVATE, 5, 0) = 0x40088000
old_mmap(0x40097000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 5, 0xf000) = 0x40097000
old_mmap(0x40098000, 8104, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x40098000
close(5)                                = 0
open("/usr/lib/libssl.so.0.9.7", O_RDONLY) = 5
read(5, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\360\204\0\0004\0\0\0h\371\2\0\0\0\0\0004\0 \0\3\0(\0\33\0\30\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0A\315\2\0A\315\2\0\5\0\0\0\0\20\0\0\1\0\0\0\0\320\2\0\0\320\2\0\0\320\2\0\244#\0\0\320*\0\0\6\0\0\0\0\20\0\0\2\0\0\0<\357\2\0<\357\2\0<\357\2\0\340\0\0\0\340\0\0\0\6\0\0\0\4\0\0\0\t\2\0\0005\2\0\0\34\2\0\0v\0\0\0\0\0\0\0:\0\0\0r\1\0\0\23\2\0\0\0\0\0\0\0\0\0\0.\1\0\0\35\2\0\0\210\1\0\0\0\0\0\0009\1\0\0\t\2\0\0\322\1\0\0\266\1\0\0\33\1\0\0\253\0\0\0\0\0\0\0\253"..., 512) = 512
fstat64(5, {st_mode=S_IFREG|0555, st_size=223898, ...}) = 0
old_mmap(NULL, 195280, PROT_READ|PROT_EXEC, MAP_PRIVATE, 5, 0) = 0x4009a000
old_mmap(0x400c7000, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 5, 0x2d000) = 0x400c7000
close(5)                                = 0
open("/usr/lib/libcrypto.so.0.9.7", O_RDONLY) = 5
read(5, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\320\275\2\0004\0\0\0000\31\17\0\0\0\0\0004\0 \0\4\0(\0\35\0\32\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\354\304\r\0\354\304\r\0\5\0\0\0\0\20\0\0\1\0\0\0\0\320\r\0\0\320\r\0\0\320\r\0\314\21\1\0\330L\1\0\6\0\0\0\0\20\0\0\2\0\0\0\370\333\16\0\370\333\16\0\370\333\16\0\330\0\0\0\330\0\0\0\6\0\0\0\4\0\0\0P\345td\320\304\r\0\320\304\r\0\320\304\r\0\34\0\0\0\34\0\0\0\4\0\0\0\4\0\0\0\5\10\0\0\332\n\0\0\0\0\0\0\236\n\0\0\0\0\0\0002\7\0\0\0\0\0\0\0\0\0\0<\7\0\0\205\n"..., 512) = 512
fstat64(5, {st_mode=S_IFREG|0555, st_size=1143807, ...}) = 0
old_mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x400ca000
old_mmap(NULL, 990424, PROT_READ|PROT_EXEC, MAP_PRIVATE, 5, 0) = 0x400cb000
old_mmap(0x401a8000, 73728, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 5, 0xdd000) = 0x401a8000
old_mmap(0x401ba000, 11480, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x401ba000
close(5)                                = 0
open("/usr/lib/libpq.so.3", O_RDONLY)   = 5
read(5, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0`F\0\0004\0\0\0(N\1\0\0\0\0\0004\0 \0\3\0(\0\31\0\26\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0T6\1\0T6\1\0\5\0\0\0\0\20\0\0\1\0\0\0\0@\1\0\0@\1\0\0@\1\0D\v\0\0\300\v\0\0\6\0\0\0\0\20\0\0\2\0\0\0\24G\1\0\24G\1\0\24G\1\0\360\0\0\0\360\0\0\0\6\0\0\0\4\0\0\0\7\1\0\0/\1\0\0\0\0\0\0\0\0\0\0k\0\0\0-\1\0\0\201\0\0\0\317\0\0\0\274\0\0\0\0\0\0\0\221\0\0\0\0\0\0\0\265\0\0\0\0\0\0\0$\1\0\0\351\0\0\0\0\0\0\0\364\0\0\0\0\0\0\0\373\0\0\0\0\0\0\0\34\1\0\0\32\1\0\0\333\0\0\0\302"..., 512) = 512
fstat64(5, {st_mode=S_IFREG|0755, st_size=99920, ...}) = 0
old_mmap(NULL, 84928, PROT_READ|PROT_EXEC, MAP_PRIVATE, 5, 0) = 0x401bd000
old_mmap(0x401d1000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 5, 0x14000) = 0x401d1000
close(5)                                = 0
open("/lib/libcrypt.so.1", O_RDONLY)    = 5
read(5, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0p\n\0\0004\0\0\0\360\225\0\0\0\0\0\0004\0 \0\6\0(\0\34\0\31\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0\300\0\0\0\300\0\0\0\5\0\0\0\4\0\0\0\3\0\0\0,\200\0\0,\200\0\0,\200\0\0\23\0\0\0\23\0\0\0\4\0\0\0\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0?\200\0\0?\200\0\0\5\0\0\0\0\20\0\0\1\0\0\0@\200\0\0@\220\0\0@\220\0\0(\23\0\0\\\204\2\0\6\0\0\0\0\20\0\0\2\0\0\0\10\222\0\0\10\242\0\0\10\242\0\0\330\0\0\0\330\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\364\0\0\0\364\0\0\0\364\0\0\0 \0"..., 512) = 512
fstat64(5, {st_mode=S_IFREG|0755, st_size=43574, ...}) = 0
old_mmap(NULL, 201884, PROT_READ|PROT_EXEC, MAP_PRIVATE, 5, 0) = 0x401d2000
old_mmap(0x401db000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 5, 0x8000) = 0x401db000
old_mmap(0x401dd000, 156828, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x401dd000
close(5)                                = 0
open("/lib/libdl.so.2", O_RDONLY)       = 5
read(5, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\240\34\0\0004\0\0\0H$\0\0\0\0\0\0004\0 \0\6\0(\0\34\0\31\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0\300\0\0\0\300\0\0\0\5\0\0\0\4\0\0\0\3\0\0\0\242\36\0\0\242\36\0\0\242\36\0\0\23\0\0\0\23\0\0\0\4\0\0\0\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\265\36\0\0\265\36\0\0\5\0\0\0\0\20\0\0\1\0\0\0\0 \0\0\0 \0\0\0 \0\0\230\1\0\0\270\1\0\0\6\0\0\0\0\20\0\0\2\0\0\0\f \0\0\f \0\0\f \0\0\340\0\0\0\340\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\364\0\0\0\364\0\0\0\364\0\0\0 \0\0\0 \0"..., 512) = 512
fstat64(5, {st_mode=S_IFREG|0755, st_size=13625, ...}) = 0
old_mmap(NULL, 8632, PROT_READ|PROT_EXEC, MAP_PRIVATE, 5, 0) = 0x40204000
old_mmap(0x40206000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 5, 0x2000) = 0x40206000
close(5)                                = 0
open("/lib/libc.so.6", O_RDONLY)        = 5
read(5, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\0^\1\0004\0\0\0,\255\23\0\0\0\0\0004\0 \0\7\0(\0009\0006\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0\340\0\0\0\340\0\0\0\5\0\0\0\4\0\0\0\3\0\0\0\310\333\22\0\310\333\22\0\310\333\22\0\23\0\0\0\23\0\0\0\4\0\0\0\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0X\341\22\0X\341\22\0\5\0\0\0\0\20\0\0\1\0\0\0`\341\22\0`\361\22\0`\361\22\0\340B\0\0$m\0\0\6\0\0\0\0\20\0\0\2\0\0\0t \23\0t0\23\0t0\23\0\330\0\0\0\330\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\24\1\0\0\24\1\0\0\24\1\0\0 \0\0"..., 512) = 512
fstat64(5, {st_mode=S_IFREG|0755, st_size=1470060, ...}) = 0
old_mmap(NULL, 1269380, PROT_READ|PROT_EXEC, MAP_PRIVATE, 5, 0) = 0x40207000
old_mmap(0x40336000, 20480, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 5, 0x12e000) = 0x40336000
old_mmap(0x4033b000, 7812, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x4033b000
close(5)                                = 0
open("/lib/libnsl.so.1", O_RDONLY)      = 5
read(5, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\20<\0\0004\0\0\0\364#\1\0\0\0\0\0004\0 \0\6\0(\0\34\0\31\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0\300\0\0\0\300\0\0\0\5\0\0\0\4\0\0\0\3\0\0\0g\24\1\0g\24\1\0g\24\1\0\23\0\0\0\23\0\0\0\4\0\0\0\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0z\24\1\0z\24\1\0\5\0\0\0\0\20\0\0\1\0\0\0\200\24\1\0\200$\1\0\200$\1\0H\t\0\0\240*\0\0\6\0\0\0\0\20\0\0\2\0\0\0\304\31\1\0\304)\1\0\304)\1\0\330\0\0\0\330\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\364\0\0\0\364\0\0\0\364\0\0\0 \0\0\0 \0\0\0"..., 512) = 512
fstat64(5, {st_mode=S_IFREG|0755, st_size=89022, ...}) = 0
old_mmap(NULL, 85792, PROT_READ|PROT_EXEC, MAP_PRIVATE, 5, 0) = 0x4033d000
old_mmap(0x4034f000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 5, 0x11000) = 0x4034f000
old_mmap(0x40350000, 7968, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x40350000
close(5)                                = 0
old_mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x40352000
munmap(0x40016000, 86746)               = 0
fcntl64(4, F_GETFD)                     = 0
getsockname(4, 0xbffffbc0, [28])        = -1 ENOTSOCK (Socket operation on non-socket)
fstat64(4, {st_mode=S_IFIFO|0600, st_size=0, ...}) = 0
--- SIGSEGV (Segmentation fault) @ 0 (0) ---
+++ killed by SIGSEGV +++