Bug#376222: dovecot-common: dovecot dies immediately
On sab, 01 lug 2006, Neil Roeth wrote: Content-Description: message body text strace output is attached. Hi Neil, could you please run again strace with the -f switch, in order to trace the child process too? Thanks, Fabio -- Fabio Tranchitella http://www.kobold.it Free Software Developer and Consultant http://www.tranchitella.it _ 1024D/7F961564, fpr 5465 6E69 E559 6466 BF3D 9F01 2BF8 EE2B 7F96 1564 -- To UNSUBSCRIBE, email to [EMAIL PROTECTED] with a subject of unsubscribe. Trouble? Contact [EMAIL PROTECTED]
Bug#376222: dovecot-common: dovecot dies immediately
On Jul 2, Fabio Tranchitella ([EMAIL PROTECTED]) wrote: On sab, 01 lug 2006, Neil Roeth wrote: Content-Description: message body text strace output is attached. Hi Neil, could you please run again strace with the -f switch, in order to trace the child process too? Sure, attached. execve(/usr/sbin/dovecot, [/usr/sbin/dovecot], [/* 26 vars */]) = 0 uname({sys=Linux, node=ml330, ...}) = 0 brk(0) = 0x8067ffc access(/etc/ld.so.nohwcap, F_OK) = -1 ENOENT (No such file or directory) mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x40017000 access(/etc/ld.so.preload, R_OK) = -1 ENOENT (No such file or directory) open(/etc/ld.so.cache, O_RDONLY) = 3 fstat64(3, {st_mode=S_IFREG|0644, st_size=34292, ...}) = 0 mmap2(NULL, 34292, PROT_READ, MAP_PRIVATE, 3, 0) = 0x40018000 close(3)= 0 access(/etc/ld.so.nohwcap, F_OK) = -1 ENOENT (No such file or directory) open(/lib/libc.so.6, O_RDONLY)= 3 read(3, \177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\220T\1..., 512) = 512 fstat64(3, {st_mode=S_IFREG|0755, st_size=1177116, ...}) = 0 mmap2(NULL, 1186964, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x40021000 mmap2(0x40139000, 32768, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x117) = 0x40139000 mmap2(0x40141000, 7316, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x40141000 close(3)= 0 mprotect(0x40139000, 20480, PROT_READ) = 0 munmap(0x40018000, 34292) = 0 time(NULL) = 1151842963 brk(0) = 0x8067ffc brk(0x8088ffc) = 0x8088ffc brk(0x8089000) = 0x8089000 uname({sys=Linux, node=ml330, ...}) = 0 getpid()= 18815 geteuid32() = 0 open(/etc/dovecot/dovecot.conf, O_RDONLY|O_LARGEFILE) = 3 fstat64(3, {st_mode=S_IFREG|0600, st_size=39348, ...}) = 0 pread64(3, ## Dovecot configuration file\n\n#..., 2048, 0) = 2048 pread64(3, fix). This however\n# means that ..., 1992, 2048) = 1992 pread64(3, bout permissions. Note that\n# ev..., 2001, 4040) = 2001 pread64(3, m number of users\n# logging in a..., 1988, 6041) = 1988 pread64(3, is simply done by having a\n# nam..., 2000, 8029) = 2000 pread64(3, ped = yes.\n#mail_read_mmaped = n..., 1979, 10029) = 1979 pread64(3, retty high.\n#mail_process_size =..., 1986, 12008) = 1986 pread64(3, them.\n#\n# Usually you should jus..., 2030, 13994) = 2030 pread64(3, e.\n# If you care about performan..., 1971, 16024) = 1971 pread64(3, irty_syncs = no\n\n# Delay writing..., 2036, 17995) = 2036 pread64(3, ary for\n # clients to request i..., 1978, 20031) = 1978 pread64(3, it doesn\'t move files\n # from ..., 1996, 22009) = 1996 pread64(3, plugins. mail_plugins is a spac..., 2012, 24005) = 2012 pread64(3, Note that bsdauth, PAM and vpopm..., 2046, 26017) = 2046 pread64(3, rator character here. The format..., 2005, 28063) = 2005 pread64(3, the destination user to be looke..., 2020, 30068) = 2020 pread64(3, ervice (ie. IMAP, POP3) must mat..., 2019, 32088) = 2019 pread64(3, static settings generated from ..., 2045, 34107) = 2045 pread64(3, ssible to export the authenticat..., 2037, 36152) = 2037 pread64(3, n. Multiple backends are support..., 2033, 38189) = 1159 pread64(3, , 874, 39348) = 0 close(3)= 0 socket(PF_FILE, SOCK_STREAM, 0) = 3 fcntl64(3, F_GETFL) = 0x2 (flags O_RDWR) fcntl64(3, F_SETFL, O_RDWR|O_NONBLOCK) = 0 connect(3, {sa_family=AF_FILE, path=/var/run/nscd/socket}, 110) = -1 ENOENT (No such file or directory) close(3)= 0 socket(PF_FILE, SOCK_STREAM, 0) = 3 fcntl64(3, F_GETFL) = 0x2 (flags O_RDWR) fcntl64(3, F_SETFL, O_RDWR|O_NONBLOCK) = 0 connect(3, {sa_family=AF_FILE, path=/var/run/nscd/socket}, 110) = -1 ENOENT (No such file or directory) close(3)= 0 open(/etc/nsswitch.conf, O_RDONLY)= 3 fstat64(3, {st_mode=S_IFREG|0644, st_size=465, ...}) = 0 mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x40018000 read(3, # /etc/nsswitch.conf\n#\n# Example..., 4096) = 465 read(3, , 4096) = 0 close(3)= 0 munmap(0x40018000, 4096)= 0 open(/etc/ld.so.cache, O_RDONLY) = 3 fstat64(3, {st_mode=S_IFREG|0644, st_size=34292, ...}) = 0 mmap2(NULL, 34292, PROT_READ, MAP_PRIVATE, 3, 0) = 0x40018000 close(3)= 0 access(/etc/ld.so.nohwcap, F_OK) = -1 ENOENT (No such file or directory) open(/lib/libnss_compat.so.2, O_RDONLY) = 3 read(3, \177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\320\20..., 512) = 512 fstat64(3, {st_mode=S_IFREG|0644, st_size=30428, ...}) = 0 mmap2(NULL, 29296, PROT_READ|PROT_EXEC,
Bug#376222: dovecot-common: dovecot dies immediately
From the strace output I just sent, it appears that the child process is failing to find the function epoll_create(), which a quick Google shows is a function introduced in Linux kernel 2.5.44. I suppose it's relevant that I am running a 2.4 kernel. :-) -- Neil Roeth -- To UNSUBSCRIBE, email to [EMAIL PROTECTED] with a subject of unsubscribe. Trouble? Contact [EMAIL PROTECTED]
Bug#376222: dovecot-common: dovecot dies immediately
On Sun, 2006-07-02 at 08:32 -0400, Neil Roeth wrote: From the strace output I just sent, it appears that the child process is failing to find the function epoll_create(), which a quick Google shows is a function introduced in Linux kernel 2.5.44. I suppose it's relevant that I am running a 2.4 kernel. :-) Yes. However your strace shows something weird going on in there. It should have logged the error message but it didn't. I'll check the code why. signature.asc Description: This is a digitally signed message part
Bug#376222: dovecot-common: dovecot dies immediately
On Sun, 2 Jul 2006, Neil Roeth wrote: From the strace output I just sent, it appears that the child process is failing to find the function epoll_create(), which a quick Google shows is a function introduced in Linux kernel 2.5.44. I suppose it's relevant that I am running a 2.4 kernel. :-) Yes this is the same conclusion I reached. But dovecot should not be using it by default. Looks like the configure check may be broken? -- Jaldhar H. Vyas [EMAIL PROTECTED] La Salle Debain - http://www.braincells.com/debian/ -- To UNSUBSCRIBE, email to [EMAIL PROTECTED] with a subject of unsubscribe. Trouble? Contact [EMAIL PROTECTED]
Bug#376222: dovecot-common: dovecot dies immediately
On Sun, 2 Jul 2006, Neil Roeth wrote: On Jul 2, Fabio Tranchitella ([EMAIL PROTECTED]) wrote: On sab, 01 lug 2006, Neil Roeth wrote: Content-Description: message body text strace output is attached. Hi Neil, could you please run again strace with the -f switch, in order to trace the child process too? Sure, attached. This appears to be your problem here: epoll_create(128) = -1 ENOSYS (Function not implemented) write(2, Fatal: , 7) = -1 EBADF (Bad file descriptor) write(2, epoll_create(): Bad file descrip..., 35) = -1 EBADF (Bad file descriptor) write(2, \n, 1) = -1 EBADF (Bad file descriptor) Does your kernel not support epoll? The other question is why is dovecot trying to use it? I thought you needed to have a special configure option to enable it and poll(2) is used by default. Investigating... -- Jaldhar H. Vyas [EMAIL PROTECTED] La Salle Debain - http://www.braincells.com/debian/ -- To UNSUBSCRIBE, email to [EMAIL PROTECTED] with a subject of unsubscribe. Trouble? Contact [EMAIL PROTECTED]
Bug#376222: dovecot-common: dovecot dies immediately
On Sun, 2006-07-02 at 10:06 -0400, Jaldhar H. Vyas wrote: On Sun, 2 Jul 2006, Neil Roeth wrote: From the strace output I just sent, it appears that the child process is failing to find the function epoll_create(), which a quick Google shows is a function introduced in Linux kernel 2.5.44. I suppose it's relevant that I am running a 2.4 kernel. :-) Yes this is the same conclusion I reached. But dovecot should not be using it by default. Looks like the configure check may be broken? Sort of. The patch that was supposed to fix the epoll/kqueue/etc checks also made it use epoll/kqueue by default if they were found. I changed this back and added --with-ioloop=auto to do it if wanted.. Shouldn't accept patches that blindly. :) signature.asc Description: This is a digitally signed message part
Bug#376222: dovecot-common: dovecot dies immediately
On Jun 30, Jaldhar H. Vyas ([EMAIL PROTECTED]) wrote: On Fri, 30 Jun 2006, Neil Roeth wrote: Thanks for the quick response. I see this in /tmp/dovecot.log, which is what I had log_path set to in dovecot.conf for a while: dovecot: 2006-06-28 23:02:29 Error: IMAP([EMAIL PROTECTED]): utimes() failed with mbox file /var/mail/virtual_mailboxes/athenamontes sori.org/neil/inbox: Operation not permitted but I think that is unrelated, I got the same message the day before in /var/log/mail/mail.warn, when everything was working fine. In /var/log/syslog, I had just this: Jun 28 20:56:56 ml330 dovecot: Killed with signal 15 which corresponds to the old version being killed as the new version was being installed. can you run an strace on /usr/sbin/dovecot and tell me the results? Are you sure there is nothing else listening on TCP port 143? I'll do the strace and get back to you. I did do telnet localhost 143 originally and got back a connection refused error (from telnet, not dovecot) so I believe nothing else was listening on port 143. -- Neil Roeth -- To UNSUBSCRIBE, email to [EMAIL PROTECTED] with a subject of unsubscribe. Trouble? Contact [EMAIL PROTECTED]
Bug#376222: dovecot-common: dovecot dies immediately
strace output is attached. [EMAIL PROTECTED]:/etc/init.d# strace /usr/sbin/dovecot execve(/usr/sbin/dovecot, [/usr/sbin/dovecot], [/* 26 vars */]) = 0 uname({sys=Linux, node=ml330, ...}) = 0 brk(0) = 0x8067ffc access(/etc/ld.so.nohwcap, F_OK) = -1 ENOENT (No such file or directory) mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x40017000 access(/etc/ld.so.preload, R_OK) = -1 ENOENT (No such file or directory) open(/etc/ld.so.cache, O_RDONLY) = 3 fstat64(3, {st_mode=S_IFREG|0644, st_size=34292, ...}) = 0 mmap2(NULL, 34292, PROT_READ, MAP_PRIVATE, 3, 0) = 0x40018000 close(3)= 0 access(/etc/ld.so.nohwcap, F_OK) = -1 ENOENT (No such file or directory) open(/lib/libc.so.6, O_RDONLY)= 3 read(3, \177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\220T\1..., 512) = 512 fstat64(3, {st_mode=S_IFREG|0755, st_size=1177116, ...}) = 0 mmap2(NULL, 1186964, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x40021000 mmap2(0x40139000, 32768, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x117) = 0x40139000 mmap2(0x40141000, 7316, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x40141000 close(3)= 0 mprotect(0x40139000, 20480, PROT_READ) = 0 munmap(0x40018000, 34292) = 0 time(NULL) = 1151800889 brk(0) = 0x8067ffc brk(0x8088ffc) = 0x8088ffc brk(0x8089000) = 0x8089000 uname({sys=Linux, node=ml330, ...}) = 0 getpid()= 10844 geteuid32() = 0 open(/etc/dovecot/dovecot.conf, O_RDONLY|O_LARGEFILE) = 3 fstat64(3, {st_mode=S_IFREG|0600, st_size=39348, ...}) = 0 pread64(3, ## Dovecot configuration file\n\n#..., 2048, 0) = 2048 pread64(3, fix). This however\n# means that ..., 1992, 2048) = 1992 pread64(3, bout permissions. Note that\n# ev..., 2001, 4040) = 2001 pread64(3, m number of users\n# logging in a..., 1988, 6041) = 1988 pread64(3, is simply done by having a\n# nam..., 2000, 8029) = 2000 pread64(3, ped = yes.\n#mail_read_mmaped = n..., 1979, 10029) = 1979 pread64(3, retty high.\n#mail_process_size =..., 1986, 12008) = 1986 pread64(3, them.\n#\n# Usually you should jus..., 2030, 13994) = 2030 pread64(3, e.\n# If you care about performan..., 1971, 16024) = 1971 pread64(3, irty_syncs = no\n\n# Delay writing..., 2036, 17995) = 2036 pread64(3, ary for\n # clients to request i..., 1978, 20031) = 1978 pread64(3, it doesn\'t move files\n # from ..., 1996, 22009) = 1996 pread64(3, plugins. mail_plugins is a spac..., 2012, 24005) = 2012 pread64(3, Note that bsdauth, PAM and vpopm..., 2046, 26017) = 2046 pread64(3, rator character here. The format..., 2005, 28063) = 2005 pread64(3, the destination user to be looke..., 2020, 30068) = 2020 pread64(3, ervice (ie. IMAP, POP3) must mat..., 2019, 32088) = 2019 pread64(3, static settings generated from ..., 2045, 34107) = 2045 pread64(3, ssible to export the authenticat..., 2037, 36152) = 2037 pread64(3, n. Multiple backends are support..., 2033, 38189) = 1159 pread64(3, , 874, 39348) = 0 close(3)= 0 socket(PF_FILE, SOCK_STREAM, 0) = 3 fcntl64(3, F_GETFL) = 0x2 (flags O_RDWR) fcntl64(3, F_SETFL, O_RDWR|O_NONBLOCK) = 0 connect(3, {sa_family=AF_FILE, path=/var/run/nscd/socket}, 110) = -1 ENOENT (No such file or directory) close(3)= 0 socket(PF_FILE, SOCK_STREAM, 0) = 3 fcntl64(3, F_GETFL) = 0x2 (flags O_RDWR) fcntl64(3, F_SETFL, O_RDWR|O_NONBLOCK) = 0 connect(3, {sa_family=AF_FILE, path=/var/run/nscd/socket}, 110) = -1 ENOENT (No such file or directory) close(3)= 0 open(/etc/nsswitch.conf, O_RDONLY)= 3 fstat64(3, {st_mode=S_IFREG|0644, st_size=465, ...}) = 0 mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x40018000 read(3, # /etc/nsswitch.conf\n#\n# Example..., 4096) = 465 read(3, , 4096) = 0 close(3)= 0 munmap(0x40018000, 4096)= 0 open(/etc/ld.so.cache, O_RDONLY) = 3 fstat64(3, {st_mode=S_IFREG|0644, st_size=34292, ...}) = 0 mmap2(NULL, 34292, PROT_READ, MAP_PRIVATE, 3, 0) = 0x40018000 close(3)= 0 access(/etc/ld.so.nohwcap, F_OK) = -1 ENOENT (No such file or directory) open(/lib/libnss_compat.so.2, O_RDONLY) = 3 read(3, \177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\320\20..., 512) = 512 fstat64(3, {st_mode=S_IFREG|0644, st_size=30428, ...}) = 0 mmap2(NULL, 29296, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x40143000 mmap2(0x40149000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x6) = 0x40149000 close(3)= 0
Bug#376222: dovecot-common: dovecot dies immediately
Package: dovecot-common Version: 1.0.rc1-1 Severity: grave File: /usr/sbin/dovecot I upgraded from 1.0beta9-1 to 1.0rc1-1, and was immediately unable to contact the IMAP server. I tried starting it by hand, both by executing /etc/init.d/dovecot start as well as by running start-stop-daemon by hand, with no luck. I checked if /usr/sbin/dovecot was running, and it was not. I synced up my dovecot.conf with the one from the package as much as possible without changing what I needed, and that didn't help (it took a while, too, since that file appears to have undergone a gratuitous reshuffling of the contents). I also attempted to change the config file to turn on various bits of logging, but that did not help, it did not get that far. I found that no matter what, /usr/sbin/dovecot just does not run at all. Downgrading back to 1.0beta9-1 resolved the problem. Let me know if there is anything else you'd like me to try. Thanks. -- System Information: Debian Release: testing/unstable APT prefers unstable APT policy: (990, 'unstable') Architecture: i386 (i686) Shell: /bin/sh linked to /bin/bash Kernel: Linux 2.4.19 Locale: LANG=C, LC_CTYPE=C (charmap=ANSI_X3.4-1968) -- no debconf information -- Neil Roeth -- To UNSUBSCRIBE, email to [EMAIL PROTECTED] with a subject of unsubscribe. Trouble? Contact [EMAIL PROTECTED]
Bug#376222: dovecot-common: dovecot dies immediately
On Fri, 30 Jun 2006, Neil Roeth wrote: Package: dovecot-common Version: 1.0.rc1-1 Severity: grave File: /usr/sbin/dovecot I upgraded from 1.0beta9-1 to 1.0rc1-1, and was immediately unable to contact the IMAP server. I tried starting it by hand, both by executing /etc/init.d/dovecot start as well as by running start-stop-daemon by hand, with no luck. I checked if /usr/sbin/dovecot was running, and it was not. I synced up my dovecot.conf with the one from the package as much as possible without changing what I needed, and that didn't help (it took a while, too, since that file appears to have undergone a gratuitous reshuffling of the contents). I also attempted to change the config file to turn on various bits of logging, but that did not help, it did not get that far. I found that no matter what, /usr/sbin/dovecot just does not run at all. Downgrading back to 1.0beta9-1 resolved the problem. What if anything do the logs say? -- Jaldhar H. Vyas [EMAIL PROTECTED] La Salle Debain - http://www.braincells.com/debian/ -- To UNSUBSCRIBE, email to [EMAIL PROTECTED] with a subject of unsubscribe. Trouble? Contact [EMAIL PROTECTED]
Bug#376222: dovecot-common: dovecot dies immediately
On Jun 30, Jaldhar H. Vyas ([EMAIL PROTECTED]) wrote: On Fri, 30 Jun 2006, Neil Roeth wrote: Package: dovecot-common Version: 1.0.rc1-1 Severity: grave File: /usr/sbin/dovecot I upgraded from 1.0beta9-1 to 1.0rc1-1, and was immediately unable to contact the IMAP server. I tried starting it by hand, both by executing /etc/init.d/dovecot start as well as by running start-stop-daemon by hand, with no luck. I checked if /usr/sbin/dovecot was running, and it was not. I synced up my dovecot.conf with the one from the package as much as possible without changing what I needed, and that didn't help (it took a while, too, since that file appears to have undergone a gratuitous reshuffling of the contents). I also attempted to change the config file to turn on various bits of logging, but that did not help, it did not get that far. I found that no matter what, /usr/sbin/dovecot just does not run at all. Downgrading back to 1.0beta9-1 resolved the problem. What if anything do the logs say? Thanks for the quick response. I see this in /tmp/dovecot.log, which is what I had log_path set to in dovecot.conf for a while: dovecot: 2006-06-28 23:02:29 Error: IMAP([EMAIL PROTECTED]): utimes() failed with mbox file /var/mail/virtual_mailboxes/athenamontes sori.org/neil/inbox: Operation not permitted but I think that is unrelated, I got the same message the day before in /var/log/mail/mail.warn, when everything was working fine. In /var/log/syslog, I had just this: Jun 28 20:56:56 ml330 dovecot: Killed with signal 15 which corresponds to the old version being killed as the new version was being installed. -- Neil Roeth -- To UNSUBSCRIBE, email to [EMAIL PROTECTED] with a subject of unsubscribe. Trouble? Contact [EMAIL PROTECTED]
Bug#376222: dovecot-common: dovecot dies immediately
On Fri, 30 Jun 2006, Neil Roeth wrote: Thanks for the quick response. I see this in /tmp/dovecot.log, which is what I had log_path set to in dovecot.conf for a while: dovecot: 2006-06-28 23:02:29 Error: IMAP([EMAIL PROTECTED]): utimes() failed with mbox file /var/mail/virtual_mailboxes/athenamontes sori.org/neil/inbox: Operation not permitted but I think that is unrelated, I got the same message the day before in /var/log/mail/mail.warn, when everything was working fine. In /var/log/syslog, I had just this: Jun 28 20:56:56 ml330 dovecot: Killed with signal 15 which corresponds to the old version being killed as the new version was being installed. can you run an strace on /usr/sbin/dovecot and tell me the results? Are you sure there is nothing else listening on TCP port 143? -- Jaldhar H. Vyas [EMAIL PROTECTED] La Salle Debain - http://www.braincells.com/debian/ -- To UNSUBSCRIBE, email to [EMAIL PROTECTED] with a subject of unsubscribe. Trouble? Contact [EMAIL PROTECTED]