search for: pollpri

it's verry slow i saw in the archives something about strace and will include it below please help: my dovecot is crawling when downloading through pop here is my last trace file contents :18:04.657706 poll([{fd=10, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=15, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=13, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=17, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=23, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=22, events=POLLIN|POLLPRI|POLLERR|POLLHU...

...CourierMailAccount on users with imap/pop logins. the passwords in openldap are plain (b64) i have included the strace output... 13:49:54.112641 gettimeofday({1176385794, 112728}, {0, 0}) = 0 13:49:54.112757 gettimeofday({1176385794, 112771}, NULL) = 0 13:49:54.112792 poll([{fd=5, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=7, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=0, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=3, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=15, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=8, events=POLLIN|POLLPRI|POLLERR|POLLH...

Hi, I installed Dovecot on FreeBSD 4-STABLE machine and have a problem. MTA is postfix delivering to ~/Maildir, runs perfectly. Dovecot is configured to use plaintext auth, config file is at the end of this mail. When trying to get mail via IMAP, I'm getting the following errors: /var/log/dovecot.log > Aug 24 12:00:35 Info: Dovecot starting up > Aug 24 12:00:51 Info: Login: goshik

...d object file: Too many open files] So, during the event I performed an strace against the dovecot-auth process and noticed the following error as well: accept(3, 0xbfe05a50, [2]) = -1 EMFILE (Too many open files) gettimeofday({1192538310, 41972}, NULL) = 0 poll([{fd=3, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL, revents=POLLIN}, {fd=0, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=18, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=10, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=7, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=23, events=POLLIN|POLLPRI|...

...l client, and when playing around with powertop I discovered that Dovecot (in particular imap-login) wakes up every 1000ms and then every 50ms even when no clients are connected. A bit of stracing shows this: gettimeofday({1180875699, 667917}, NULL) = 0 <0.000010> poll([{fd=7, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=10, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=3, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=0, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=1, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}], 5, 999) = 0 <0.999595> gettimeofday({118...

...127.0.0.1:34661 ESTABLISHED tcp 0 0 127.0.0.1:34661 127.0.0.1:993 ESTABLISHED STRACE: 17:00:33.225030 gettimeofday({1171501233, 225048}, {480, 0}) = 0 17:00:33.225072 gettimeofday({1171501233, 225090}, NULL) = 0 17:00:33.225113 poll([{fd=7, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=10, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=3, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=1, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}], 4, 0) = 0 17:00:33.225163 gettimeofday({1171501233, 225182}, {480, 0}) = 0 17:00:33.225212 gettimeo...

...it to, so did a "ps aux" (Centos 5.2, btw) and chose the first "pop3" process: [root at postfix cur]# strace -p 1697 Process 1697 attached - interrupt to quit gettimeofday({1238146840, 724484}, {0, 0}) = 0 gettimeofday({1238146840, 724542}, NULL) = 0 poll([{fd=4, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=2, events=POLLERR|POLLHUP|POLLNVAL}, {fd=0, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=1, events=POLLOUT|POLLERR|POLLHUP|POLLNVAL}], 4, 3123) = 0 gettimeofday({1238146843, 847540}, {0, 0}) = 0 gettimeofday({1238146843, 847590}, NULL) = 0 poll([{fd=4, events...

...n APPEND - 46. stalled for 1789 secs in APPEND - 46. stalled for 1790 secs in APPEND (Sometimes SELECT or COPY) The maximum stalled time in APPEND is 1790s; in SELECT and COPY the maximum time is less than 20s until now. The only IMAP process loops around a poll(): poll([{fd=4, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=2, events=POLLERR|POLLHUP|POLLNVAL}, {fd=0, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}], 3, 0) = 0 gettimeofday({1174389105, 882286}, {4294967236, 0}) = 0 gettimeofday({1174389105, 882339}, NULL) = 0 poll([{fd=4, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL},...

http://dovecot.org/releases/dovecot-1.0.rc23.tar.gz http://dovecot.org/releases/dovecot-1.0.rc23.tar.gz.sig Documentation is probably the only important thing left before v1.0. * deliver doesn't ever exit with Dovecot's internal exit codes anymore. All its internal exit codes are changed to EX_TEMPFAIL. * mbox: X-Delivery-ID header is now dropped when saving mails. * mbox: If

http://dovecot.org/releases/dovecot-1.0.rc23.tar.gz http://dovecot.org/releases/dovecot-1.0.rc23.tar.gz.sig Documentation is probably the only important thing left before v1.0. * deliver doesn't ever exit with Dovecot's internal exit codes anymore. All its internal exit codes are changed to EX_TEMPFAIL. * mbox: X-Delivery-ID header is now dropped when saving mails. * mbox: If

...orker process is actually a client that connects to the main dovecot-auth process ( the server) I restarted dovecot and I straced the auth worker process ... after 20-30 minutes it just existed here is the output of strace : gettimeofday({0, 0}, NULL) = 0 poll([{fd=5, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=4, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}], 2, 0) = 0 gettimeofday({1133138508, 221796}, {0, 0}) = 0 gettimeofday({0, 0}, NULL) = 0 poll([{fd=5, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=4, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLN...

...UP, {SIG_IGN}, NULL, 8) = 0 [pid 24795] rt_sigaction(SIGUSR2, {SIG_IGN}, NULL, 8) = 0 [pid 24795] rt_sigaction(SIGCHLD, {0xb7ebbb40, [], 0}, NULL, 8) = 0 [pid 24795] write(2, "\1FCRAM-MD5 mechanism can\'t be su"..., 59) = 59 [pid 24794] <... poll resumed> [{fd=10, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=12, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=16, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL, revents=POLLIN}, {fd=14, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=18, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}], 5, 986) = 1 [pid 24794]...

...this: 03:55:28.624759 accept(1, 0xbffffaa0, [28]) = -1 EAGAIN (Resource temporarily unavailable) Along with the normal stuff: 03:55:30.682212 gettimeofday({1175586930, 682327}, {300, 0}) = 0 03:55:30.682412 gettimeofday({1175586930, 682483}, NULL) = 0 03:55:30.682525 poll([{fd=5, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=8, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNV AL}, {fd=3, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=1, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}], 4, 1000) = 0 ssl_cert_file = /home/steve/loft/mail/pop.loftsoftware.ca.crt pop3_uidl_format = %08Xu...

Dear All, I constantly encounter 'dovecot-auth', 'login-imap', 'login-pop3' and 'imap' processes consume 100% CPU. I run 'ps' and found those hanged up processes were running for a long time. I am wondering whether dovecot.conf has some configuration parameters that timeout those processes (or kill those after certain period of time). I am using dovecot

...O condition) @ 0 (0) --- rt_sigaction(SIGURG, {0x80a5cc0, [URG], SA_RESTART}, {0x80a5cc0, [URG], SA_RESTART}, 8) = 0 sigreturn() = ? (mask now []) time(NULL) = 1149625396 kill(2980, SIGKILL) = 0 poll([{fd=8, events=POLLIN|POLLPRI, revents=POLLIN}], 1, 100) = 1 read(8, "\1\0\377\377\1\0\377\377\0\0\0\0\0\0\1\0\377\377\0\0\0"..., 8192) = 8192 time(NULL) = 1149625396 poll([{fd=8, events=POLLIN|POLLPRI, revents=POLLHUP}], 1, 100) = 1 read(8, "", 8192) = 0 c...

...er running /etc/init.d/dovecot stop, I would have several imap processes left over in my uid. They don't do much: # strace -p 5014 Process 5014 attached - interrupt to quit gettimeofday({1125460345, 997748}, {420, 0}) = 0 gettimeofday({1125460345, 998465}, NULL) = 0 poll([{fd=8, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=0, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}], 2, 410) = 0 gettimeofday({1125460346, 410768}, {420, 0}) = 0 gettimeofday({1125460346, 410890}, NULL) = 0 poll([{fd=8, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=0, events=POLLIN|POLLPRI|POLLERR|POLLHUP|PO...

...ss stay in memory but do nothing. Here a strace output of this case: Process 349 attached - interrupt to quit gettimeofday({1161965973, 768478}, {0, 0}) = 0 poll( Strace output nothing before the SIGKILL from postfix (command time exceed 1200 second), the end of the strace: [{fd=5, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=9, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}], 2, 2147483647) = -1 EINTR (Interrupted system call) +++ killed by SIGKILL +++ I'm not sure is this problem has a relation with our deliver problem. But in the deliver log /var/log/dovecot/deliver, I have a lots...

...({0, 170189000}, NULL) = 0 lstat64("/var/cache/dovecot/31045/control/.Trash/dovecot-uidlist.lock", {st_mode=S_IFREG|0600, st_size=0, ...}) = 0 time(NULL) = 1181630732 process #2: gettimeofday({1181630713, 945424}, NULL) = 0 poll([{fd=4, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}, {fd=2, events=POLLERR|POLLHUP|POLLNVAL}, {fd=0, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVAL}], 3, 9335) = 0 gettimeofday({1181630723, 281935}, {4294967176, 0}) = 0 gettimeofday({1181630723, 282014}, NULL) = 0 poll([{fd=4, events=POLLIN|POLLPRI|POLLERR|POLLHUP|POLLNVA...

..., SA_RESTORER, 0x7f0dca289390}, 8) = 0 alarm(16) = 0 clock_gettime(CLOCK_BOOTTIME, {84255, 473497017}) = 0 clock_gettime(CLOCK_BOOTTIME, {84255, 473578560}) = 0 write(13, "0r\2\1\21cm\4'sambaDomainName=EXAMPLE,d"..., 116) = 116 poll([{fd=13, events=POLLIN|POLLPRI}], 1, 15000) = 1 ([{fd=13, revents=POLLIN}]) read(13, "00\2\1\21d+\4", 8) = 8 read(13, "'sambaDomainName=EXAMPLE,dc=exampl"..., 42) = 42 poll([{fd=13, events=POLLIN|POLLPRI}], 1, 14999) = 1 ([{fd=13, revents=POLLIN}]) read(13, "0\f\2\1\21e\7\n", 8)...

...contains similar output, except that there's continue output after the "Storing salt" message. If I use strace, I see the following: write(7, "0c\2\1\10c^\4\25dc=AD,dc=SEAKR,dc=COM\n\1"..., 101) = 101 gettimeofday({1274971641, 629786}, NULL) = 0 poll([{fd=7, events=POLLIN|POLLPRI|POLLERR|POLLHUP}], 1, 15000) = 1 ([{fd=7, revents=POLLIN}]) read(7, "0\204\0\0\r\271\2\1", 8) = 8 read(7, "\10d\204\0\0\r\260\4.CN=xenprint,CN=Computer"..., 3511) = 3511 gettimeofday({1274971641, 630532}, NULL) = 0 poll([{fd=7, events=POLLIN|POLLPRI|POLLERR|POLLHUP}], 1, 1...