search for: pollnval

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|POLLHUP|POLLNVAL}, {fd=25, even...

...ers 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|POLLHUP|POLLNVAL}, {fd=17, ev...

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

...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|POLLERR|POLLHUP|POLLNVAL}...

...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=POLLIN|POLLPRI|POLLERR|P...

...ng 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({1180875700, 667627}, {429496...

...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 gettimeofday({1171501233, 225230}...

...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}, {fd=2, events=POLLERR|P...

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

...) + max_fd = fd; + } + + ret = select(max_fd+1, &rfds, &wfds, &efds, timeo); + + for (i = 0; i < _nfds; i++) { + fd = _pfd[i].fd; + if (FD_ISSET(fd, &efds)) { + /* anything bad happens we set POLLERR, ignoring PULLHUP + * POLLNVAL */ + _pfd[i].revents |= POLLERR; + continue; + } + if (FD_ISSET(fd, &rfds)) + _pfd[i].revents |= POLLIN; + if (FD_ISSET(fd, &wfds)) + _pfd[i].revents |= POLLOUT; + } + + DEBUG("poll("); + dump_pollfds(_pfd,...

...y 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|POLLNVAL, revents=POLLIN}], 2,...

...= 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|POLLNVAL}, {fd=2, events=POLLER...

...= 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] gettimeofday( <unfini...

...ent(s) just sit their idling. The mailbox is empty. I'm not running out of memory. stracing the process doesn't show anything interesting... ... gettimeofday({1233024777, 844804}, {420, 0}) = 0 gettimeofday({1233024777, 844912}, 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, 10000) = -1 EINTR (Interrupted system call) +++ killed by SIGKILL +++ This is on a CentOS 5.2 VPS. I haven't changed much other than installing a few packages. I've also had this exact sa...

...ovecot 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|POLLNVAL}], 2, 0) = 0 getti...

...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 of message: deliver(inf...

...; > + cmd->errorfd = -1; > > + nr_fds--; > > + } > > Now fds[0] is -1, and fds[1] is still an open file > descriptor. > > Next time around the loop it will call poll() on 'fds' array > which contains this FD == -1. In theory that results in POLLNVAL, > but on OS-X at least it causes poll() itself to return an error. Hmm in the documentations there are these bits: http://man7.org/linux/man-pages/man2/poll.2.html "The field fd contains a file descriptor for an open file. If this field is negative, then the corresponding events field...

...ccept(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%08Xv ssl_key_file = /hom...

While working on a new test of what happens when the server goes away while commands are in flight, I managed to hit a race where I hit death from SIGPIPE instead of a clean transition to the DEAD state. I also found myself wanting to use nbd_poll from the test, but with a way to distinguish between the state machine progressing vs. hanging. Eric Blake (2): socket: Avoid SIGPIPE where possible