Timo Sirainen wrote:
On Mon, 2008-09-22 at 13:04 -0400, Stewart Dean wrote:
Sep 22 11:54:13 egg mail:err|error dovecot: IMAP(sdean): posix_fallocate() faile
d: Protocol not available
See if this helps: http://hg.dovecot.org/dovecot-1.1/rev/ad13463328aa
My apologies for not getting back to you...I was sick and out last week
and am not exactly shining brightly this week :)
I rebuilt with the patch you specified. I made sure that my imap
session from my TBird client to my production (DC V1.0.15) server was
shut down, that it was reconfigured NOT to periodically look for mail,
and I have rechecked since then to make sure that there are no session
in the PS table for it. When I started up on my DC V1.1.3 test server,
I got the following messages:
Sep 30 13:24:13 egg mail:info dovecot: Dovecot v1.1.3 starting up
Sep 30 13:24:26 egg mail:info dovecot: imap-login: Login: user=<sdean>, method=P
LAIN, rip=10.20.10.169, lip=192.246.229.31
Sep 30 13:24:28 egg mail:info dovecot: imap-login: Login: user=<sdean>, method=P
LAIN, rip=10.20.10.169, lip=192.246.229.31
Sep 30 13:24:30 egg mail:err|error dovecot: IMAP(sdean): mbox sync: UID inserted
in the middle of mailbox /var/spool/mail/sdean (646581 > 646564, seq=1125, idx_
msgs=1126)
Sep 30 13:24:31 egg mail:err|error dovecot: IMAP(sdean): mbox sync: UID inserted
in the middle of mailbox /var/spool/mail/sdean (646581 > 646564, seq=1125, idx_
msgs=1126)
Sep 30 13:24:33 egg mail:err|error dovecot: IMAP(sdean): posix_fallocate() faile
d: File exists
Sep 30 13:24:33 egg mail:err|error dovecot: IMAP(sdean): file_set_size() failed
with mbox file /var/spool/mail/sdean: File exists
Sep 30 13:24:35 egg mail:err|error dovecot: IMAP(sdean): posix_fallocate() faile
d: File exists
Sep 30 13:24:35 egg mail:err|error dovecot: IMAP(sdean): file_set_size() failed
with mbox file /var/spool/mail/sdean: File exists
Sep 30 13:25:37 egg mail:info dovecot: ssl-build-param: SSL parameters regenerat
ion completed
Sep 30 13:27:42 egg mail:info dovecot: imap-login: Login: user=<sdean>, method=P
LAIN, rip=10.20.10.169, lip=192.246.229.31
Sep 30 13:30:28 egg mail:info dovecot: imap-login: Login: user=<sdean>, method=P
LAIN, rip=10.20.10.169, lip=192.246.229.31
I would assume that, when the test server started up, the index and such
stuff it had from the last time it was run was grossly out of synch and
that this is therefore just DC on the test server setting things right.
Since then, as I wrote a message, DC on the test machine coughed out an
errmsg relating to the Drafts folder, which again makes sense as it also
likely out of sync:
Sep 30 13:49:25 egg mail:info dovecot: imap-login: Login: user=<sdean>, method=P
LAIN, rip=10.20.10.169, lip=192.246.229.31
Sep 30 13:51:03 egg mail:err|error dovecot: IMAP(sdean): mbox sync: UID inserted
in the middle of mailbox /home/hcrc/sdean/mail/Drafts (9422 > 9403, seq=607, id
x_msgs=651)
Sep 30 13:51:04 egg mail:err|error dovecot: IMAP(sdean): mbox sync: UID inserted
in the middle of mailbox /home/hcrc/sdean/mail/Drafts (9422 > 9403, seq=607, id
x_msgs=651)
Sep 30 13:53:45 egg mail:info dovecot: IMAP(sdean): Disconnected: Logged out byt
es=73/3631
So there are two possibilities
1) That this just happens once (for any given folder), as long as the
test DC server is the only one to ride heard on the folders
and/or
2) even so, these messages shouldn't happen and something is wrong.
I will watch it carefully for a day and see if I can confirm that #1 is
true........
I have attached my original note with its copies of the dovecot -n
output for both machines
--- Begin Message ---
My production DC machine owns the mail filesystems and is running DC
V1.0.15 and mbox folder format.
I am looking to test V1.1.3 on another machine, which NFS mounts the
mail filesystems, but has its own local index FS.
I have made this test environment my default connection in TBird, and it
seems to work just fine. Also, I have made sure that my TBird client
isn't connecting to the production server (it has multiple accounts but
I have turned off the cehck for mail when starting and check for new
mail every N minutes functions, and then check the ps table to make sure
there are no imap connections)
However, I'm seeing two errmsgs in the maillog on the test machine:
Sep 22 11:54:13 egg mail:err|error dovecot: IMAP(sdean): posix_fallocate() faile
d: Protocol not available
Sep 22 11:54:13 egg mail:err|error dovecot: IMAP(sdean): file_set_size() failed
with mbox file /var/spool/mail/sdean: Protocol not available
which appear to happen AFTER mail arrives at the production server....it
seems to happen on my test server the next time my client goes to access
mail AFTER mail has arrived at the production server. Subsequent client
requests of the test server execute without error until AFTER the next
time mail arrives at and my inbox is updated with it.
Again, if I hadn't looked at the logs, I wouldn't know there was a
problem...I can see my new mail just fine from the test server.
The questions: Is this anything I should be concerned about? Is this a
bug or a legit problem coming from my improper use of two servers
against the same data.
FWIW, I am using fcntl for both mbox read and write locks. procmail in
the MDA on the production server, and its locking hierarchy
<dotlock,fcntl>, which Timo previously approved.
Thanks!
Production dovecot -n output:
# 1.0.15: /usr/local/etc/dovecot.conf
listen: *:143
ssl_listen: *:993
disable_plaintext_auth: no
verbose_ssl: yes
login_dir: /var/run/dovecot/login
login_executable: /usr/local/libexec/dovecot/imap-login
login_processes_count: 12
login_max_processes_count: 774
verbose_proctitle: yes
first_valid_uid: 200
mail_location: mbox:~/mail:INBOX=/var/spool/mail/%u:INDEX=/var/dcindx/%u
mbox_write_locks: fcntl
mbox_dirty_syncs: no
auth default:
passdb:
driver: pam
userdb:
driver: passwd
Test dovecot -n output:
# 1.1.3: /usr/local/etc/dovecot.conf
listen: *:143
ssl_listen: *:993
disable_plaintext_auth: no
verbose_ssl: yes
login_dir: /var/run/dovecot/login
login_executable: /usr/local/libexec/dovecot/imap-login
login_processes_count: 12
login_max_processes_count: 774
max_mail_processes: 1024
verbose_proctitle: yes
first_valid_uid: 200
mail_location: mbox:~/mail:INBOX=/var/spool/mail/%u:INDEX=/var/dcindx/%u
mbox_write_locks: fcntl
mbox_dirty_syncs: no
auth default:
passdb:
driver: pam
userdb:
driver: passwd
--- End Message ---
