Hi,
On a dovecot server (2.3.21) I have a simple sieve script:
require ["duplicate"];
# rule:[duplicate]
if duplicate {
discard;
stop;
}
I use virtual users with mail aliases on a LDAP backend.
I have user "resposit" having 2 mail aliases:
- respo...@na.infn.it
- rosario.espos...@na.infn.it
If I send a single message to both aliases I still receive 2 copies as
you can see from the attached log.
Is the "duplicate" sieve extension supposed to work this way ?
Any help would be much appreciated !
--
Rosario Esposito
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: auth-master:
userdb lookup(respo...@na.infn.it): Started userdb lookup
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: auth-master:
userdb lookup(respo...@na.infn.it): auth USER input: respo...@na.infn.it
home=/mail/resposit uid=10000 gid=10000
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: auth-master:
userdb lookup(respo...@na.infn.it): Finished userdb lookup
(username=respo...@na.infn.it home=/mail/resposit uid=10000 gid=10000)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
auth-master: userdb lookup(rosario.espos...@na.infn.it): Started userdb lookup
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
auth-master: userdb lookup(rosario.espos...@na.infn.it): auth USER input:
rosario.espos...@na.infn.it home=/mail/resposit uid=10000 gid=10000
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
auth-master: userdb lookup(rosario.espos...@na.infn.it): Finished userdb lookup
(username=rosario.espos...@na.infn.it home=/mail/resposit uid=10000 gid=10000)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: Effective
uid=10000, gid=10000, home=/mail/resposit
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: Quota root:
name=User quota backend=count args=
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: Quota rule:
root=User quota mailbox=* bytes=107374182400 messages=0
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: Quota grace:
root=User quota bytes=10737418240 (10%)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug:
open(/proc/self/io) failed: Permission denied
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: Namespace
inbox: type=private, prefix=, sep=, inbox=yes, hidden=no, list=yes,
subscriptions=yes location=mdbox:~/mdbox
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: fs:
root=/mail/resposit/mdbox, index=, indexpvt=, control=, inbox=, alt=
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: quota:
quota_over_flag check: quota_over_script unset - skipping
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: duplicate
db: Initialize
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
Pigeonhole version 0.5.21 (f6cd4b8e) initializing
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
include: sieve_global is not set; it is currently not possible to include
`:global' scripts.
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve: file
storage: Using active Sieve script path: /mail/resposit/.dovecot.sieve
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve: file
storage: Using script storage path: /mail/resposit/sieve
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve: file
storage: Relative path to sieve storage in active link: sieve/
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve: file
storage: quota: Script count limit: 1 scripts
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve: file
storage: Using Sieve script path: /mail/resposit/.dovecot.sieve
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve: file
storage: script `mailfilter': Opened script `mailfilter' from
`/mail/resposit/.dovecot.sieve'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve: file
storage: Using script storage path: /etc/dovecot/sieve.d/
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve: file
storage: script: Opened script `01-incoming' from
`/etc/dovecot/sieve.d/01-incoming.sieve'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
Executed before user's personal Sieve script(1):
/etc/dovecot/sieve.d/01-incoming.sieve
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve: Using
the following location for user's Sieve script: /mail/resposit/.dovecot.sieve
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
multi-script: Start execute sequence
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
Opening script 1 of 2 from `/etc/dovecot/sieve.d/01-incoming.sieve'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
Loading script /etc/dovecot/sieve.d/01-incoming.sieve
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
Script binary /etc/dovecot/sieve.d/01-incoming.svbin successfully loaded
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
binary /etc/dovecot/sieve.d/01-incoming.svbin: save: not saving binary, because
it is already stored
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
Executing script from `/etc/dovecot/sieve.d/01-incoming.svbin'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
multi-script: Run script `/etc/dovecot/sieve.d/01-incoming.svbin'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
Started running script `/etc/dovecot/sieve.d/01-incoming.svbin'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
Finished running script `/etc/dovecot/sieve.d/01-incoming.svbin' (status=ok,
resource usage: no usage recorded)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
multi-script: Execute result
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Executing result
(status=ok, commit=no)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Starting execution of
actions
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Executing actions
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finished executing
actions (status=ok, keep=implicit, executed=no)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finished executing
result (no commit, status=ok, keep=yes)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
multi-script: Sequence active
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
Opening script 2 of 2 from `/mail/resposit/.dovecot.sieve'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
Loading script /mail/resposit/.dovecot.sieve
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
Script binary /mail/resposit/.dovecot.svbin successfully loaded
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
binary /mail/resposit/.dovecot.svbin: save: not saving binary, because it is
already stored
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
Executing script from `/mail/resposit/.dovecot.svbin'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
multi-script: Run script `/mail/resposit/.dovecot.svbin'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
Started running script `/mail/resposit/.dovecot.svbin'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: duplicate
db: transaction: Transaction begin; lock /mail/resposit/.dovecot.lda-dupes
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: duplicate
db: transaction: Reading /mail/resposit/.dovecot.lda-dupes
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve: Check
duplicate ID
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: duplicate
db: transaction: Lock duplicate ID
(path=/mail/resposit/.dovecot.lda-dupes.locks/duplicate.lock.5fd78b10f714c6be1e46acfe898b9ce4)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: duplicate
db: transaction: DB file not created yet
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: duplicate
db: transaction: Check ID: not found
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
Finished running script `/mail/resposit/.dovecot.svbin' (status=ok, resource
usage: no usage recorded)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
multi-script: Execute result
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Executing result
(status=ok, commit=no)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Starting execution of
actions
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Executing actions
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Executing
duplicate_mark action
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finished executing
duplicate_mark action (status=ok, keep=implicit)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finished executing
actions (status=ok, keep=implicit, executed=no)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finished executing
result (no commit, status=ok, keep=yes)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
multi-script: Sequence active
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
multi-script: Finishing sequence (status=ok)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Executing result
(status=ok, commit=yes)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Starting execution of
actions
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Executing actions
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finished executing
actions (status=ok, keep=implicit, executed=no)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Execute implicit keep
(status=ok)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Start storing into
mailbox INBOX
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Executing implicit
keep action
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Execute storing into
mailbox 'INBOX'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: Mailbox
INBOX: Mailbox opened
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: Namespace :
Using permissions from /mail/resposit/mdbox: mode=0700 gid=default
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: Mailbox
INBOX: Mailbox opened
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Saving to mailbox
'INBOX' successful so far
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finished executing
implicit keep action (status=ok)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finalizing actions
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finalize
duplicate_mark action (status=ok, action_status=ok, commit_status=ok,
pre-commit=yes)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Commit duplicate_mark
action
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finished finalizing
actions (status=ok, keep=implicit, committed=no)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finalize implicit keep
(status=ok)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finalize implicit keep
action(status=ok, action_status=ok, commit_status=ok)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Commit implicit keep
action
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Commit storing into
mailbox 'INBOX'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: replication:
Replication requested by 'act_store_execute', priority=2
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finish implicit keep
action
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finishing actions
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finish duplicate_mark
action
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: duplicate_mark action:
Marking duplicate
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve: Mark
ID as duplicate
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: duplicate
db: transaction: Mark ID
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finished executing
result (final, status=ok, keep=yes)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
multi-script: Sequence finished (status=ok, keep=yes)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: duplicate
db: transaction: Commit; overwrite /mail/resposit/.dovecot.lda-dupes
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: duplicate
db: transaction: Unlock duplicate ID
(path=/mail/resposit/.dovecot.lda-dupes.locks/duplicate.lock.5fd78b10f714c6be1e46acfe898b9ce4)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: duplicate
db: transaction: Transaction free
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: sieve:
multi-script: Destroy
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: duplicate
db: Cleanup
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(respo...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA>: Debug: User session
is finished
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
Effective uid=10000, gid=10000, home=/mail/resposit
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
Quota root: name=User quota backend=count args=
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
Quota rule: root=User quota mailbox=* bytes=107374182400 messages=0
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
Quota grace: root=User quota bytes=10737418240 (10%)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
open(/proc/self/io) failed: Permission denied
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
Namespace inbox: type=private, prefix=, sep=, inbox=yes, hidden=no, list=yes,
subscriptions=yes location=mdbox:~/mdbox
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
fs: root=/mail/resposit/mdbox, index=, indexpvt=, control=, inbox=, alt=
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
quota: quota_over_flag check: quota_over_script unset - skipping
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
duplicate db: Initialize
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: Pigeonhole version 0.5.21 (f6cd4b8e) initializing
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: include: sieve_global is not set; it is currently not possible to
include `:global' scripts.
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: file storage: Using active Sieve script path:
/mail/resposit/.dovecot.sieve
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: file storage: Using script storage path: /mail/resposit/sieve
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: file storage: Relative path to sieve storage in active link: sieve/
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: file storage: quota: Script count limit: 1 scripts
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: file storage: Using Sieve script path: /mail/resposit/.dovecot.sieve
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: file storage: script `mailfilter': Opened script `mailfilter' from
`/mail/resposit/.dovecot.sieve'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: file storage: Using script storage path: /etc/dovecot/sieve.d/
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: file storage: script: Opened script `01-incoming' from
`/etc/dovecot/sieve.d/01-incoming.sieve'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: Executed before user's personal Sieve script(1):
/etc/dovecot/sieve.d/01-incoming.sieve
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: Using the following location for user's Sieve script:
/mail/resposit/.dovecot.sieve
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: multi-script: Start execute sequence
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: Opening script 1 of 2 from `/etc/dovecot/sieve.d/01-incoming.sieve'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: Loading script /etc/dovecot/sieve.d/01-incoming.sieve
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: Script binary /etc/dovecot/sieve.d/01-incoming.svbin successfully loaded
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: binary /etc/dovecot/sieve.d/01-incoming.svbin: save: not saving binary,
because it is already stored
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: Executing script from `/etc/dovecot/sieve.d/01-incoming.svbin'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: multi-script: Run script `/etc/dovecot/sieve.d/01-incoming.svbin'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: Started running script `/etc/dovecot/sieve.d/01-incoming.svbin'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: Finished running script `/etc/dovecot/sieve.d/01-incoming.svbin'
(status=ok, resource usage: no usage recorded)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: multi-script: Execute result
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Executing
result (status=ok, commit=no)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Starting
execution of actions
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Executing
actions
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finished
executing actions (status=ok, keep=implicit, executed=no)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finished
executing result (no commit, status=ok, keep=yes)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: multi-script: Sequence active
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: Opening script 2 of 2 from `/mail/resposit/.dovecot.sieve'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: Loading script /mail/resposit/.dovecot.sieve
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: Script binary /mail/resposit/.dovecot.svbin successfully loaded
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: binary /mail/resposit/.dovecot.svbin: save: not saving binary, because
it is already stored
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: Executing script from `/mail/resposit/.dovecot.svbin'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: multi-script: Run script `/mail/resposit/.dovecot.svbin'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: Started running script `/mail/resposit/.dovecot.svbin'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
duplicate db: transaction: Transaction begin; lock
/mail/resposit/.dovecot.lda-dupes
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
duplicate db: transaction: Reading /mail/resposit/.dovecot.lda-dupes
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: Check duplicate ID
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
duplicate db: transaction: Lock duplicate ID
(path=/mail/resposit/.dovecot.lda-dupes.locks/duplicate.lock.5fd78b10f714c6be1e46acfe898b9ce4)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
duplicate db: transaction: DB file not changed
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
duplicate db: transaction: Check ID: not found
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: Finished running script `/mail/resposit/.dovecot.svbin' (status=ok,
resource usage: no usage recorded)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: multi-script: Execute result
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Executing
result (status=ok, commit=no)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Starting
execution of actions
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Executing
actions
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Executing
duplicate_mark action
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finished
executing duplicate_mark action (status=ok, keep=implicit)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finished
executing actions (status=ok, keep=implicit, executed=no)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finished
executing result (no commit, status=ok, keep=yes)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: multi-script: Sequence active
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: multi-script: Finishing sequence (status=ok)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Executing
result (status=ok, commit=yes)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Starting
execution of actions
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Executing
actions
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finished
executing actions (status=ok, keep=implicit, executed=no)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Execute
implicit keep (status=ok)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Start storing
into mailbox INBOX
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Executing
implicit keep action
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Execute storing
into mailbox 'INBOX'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
Mailbox INBOX: Mailbox opened
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
Namespace : Using permissions from /mail/resposit/mdbox: mode=0700 gid=default
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
Mailbox INBOX: Mailbox opened
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Saving to
mailbox 'INBOX' successful so far
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finished
executing implicit keep action (status=ok)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finalizing
actions
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finalize
duplicate_mark action (status=ok, action_status=ok, commit_status=ok,
pre-commit=yes)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Commit
duplicate_mark action
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finished
finalizing actions (status=ok, keep=implicit, committed=no)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finalize
implicit keep (status=ok)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finalize
implicit keep action(status=ok, action_status=ok, commit_status=ok)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Commit implicit
keep action
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Commit storing
into mailbox 'INBOX'
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
replication: Replication requested by 'act_store_execute', priority=2
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finish implicit
keep action
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finishing
actions
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finish
duplicate_mark action
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: duplicate_mark
action: Marking duplicate
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: Mark ID as duplicate
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
duplicate db: transaction: Mark ID
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: msgid=<c25e4b61-ac2a-44d4-98ef-3933f8f2a...@na.infn.it>: Finished
executing result (final, status=ok, keep=yes)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: multi-script: Sequence finished (status=ok, keep=yes)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
duplicate db: transaction: Commit; overwrite /mail/resposit/.dovecot.lda-dupes
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
duplicate db: transaction: Unlock duplicate ID
(path=/mail/resposit/.dovecot.lda-dupes.locks/duplicate.lock.5fd78b10f714c6be1e46acfe898b9ce4)
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
duplicate db: transaction: Transaction free
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
sieve: multi-script: Destroy
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
duplicate db: Cleanup
Jul 18 15:10:19 imap1 dovecot[991120]:
lmtp(rosario.espos...@na.infn.it)<1026401><ENglKTsUmWZhqQ8AkdPNPA:R2>: Debug:
User session is finished
# 2.3.21 (47349e2482): /etc/dovecot/dovecot.conf
# Pigeonhole version 0.5.21 (f6cd4b8e)
# OS: Linux 5.14.0-427.24.1.el9_4.x86_64 x86_64 Rocky Linux release 9.4 (Blue
Onyx)
# Hostname: imap1.na.infn.it
auth_master_user_separator = +
auth_mechanisms = plain login oauthbearer xoauth2
default_client_limit = 8192
default_process_limit = 2048
default_vsz_limit = 2 G
doveadm_password = # hidden, use -P to show it
doveadm_port = 12345
first_valid_uid = 10000
haproxy_trusted_networks = 192.84.134.252 192.84.134.253 2001:760:4214:134::252
2001:760:4214:134::253
lda_mailbox_autocreate = yes
lda_mailbox_autosubscribe = yes
login_trusted_networks = 172.18.6.0/23
mail_debug = yes
mail_gid = vmail
mail_home = /mail/%u/
mail_location = mdbox:~/mdbox
mail_plugins = " quota notify replication"
mail_uid = vmail
mail_vsize_bg_after_count = 100
managesieve_notify_capability = mailto
managesieve_sieve_capability = fileinto reject envelope encoded-character
vacation subaddress comparator-i;ascii-numeric relational regex imap4flags copy
include variables body enotify environment mailbox date index ihave duplicate
mime foreverypart extracttext
mbox_write_locks = fcntl
namespace inbox {
inbox = yes
location =
mailbox Archives {
special_use = \Archive
}
mailbox Drafts {
special_use = \Drafts
}
mailbox Junk {
special_use = \Junk
}
mailbox Sent {
special_use = \Sent
}
mailbox Trash {
special_use = \Trash
}
prefix =
}
passdb {
args = /etc/dovecot/secret-master-users
driver = passwd-file
master = yes
pass = yes
}
passdb {
args = /etc/dovecot/dovecot-ldap-aai.conf.ext
driver = ldap
}
passdb {
args = /etc/dovecot/dovecot-ldap-local.conf.ext
driver = ldap
}
passdb {
args = /etc/dovecot/dovecot-oauth2.conf.ext
driver = oauth2
mechanisms = xoauth2 oauthbearer
}
plugin {
mail_replica = tcp:imap2.na.infn.it
quota = count:User quota
quota_rule = *:storage=100G
quota_vsizes = yes
sieve = file:~/sieve;active=~/.dovecot.sieve
sieve_before = /etc/dovecot/sieve.d/
sieve_duplicate_default_period = 1h
sieve_duplicate_max_period = 1d
sieve_extensions = +duplicate
sieve_quota_max_scripts = 1
sieve_trace_debug = yes
}
postmaster_address = postmas...@na.infn.it
protocols = imap lmtp sieve
replication_max_conns = 16
service aggregator {
fifo_listener replication-notify-fifo {
user = vmail
}
unix_listener replication-notify {
user = vmail
}
}
service auth {
unix_listener /var/spool/postfix/private/auth {
group = postfix
mode = 0660
user = postfix
}
unix_listener auth-userdb {
mode = 0777
}
}
service doveadm {
inet_listener {
port = 12345
}
}
service imap-login {
inet_listener imap {
port = 143
ssl = no
}
inet_listener imaps {
port = 993
ssl = yes
}
inet_listener imaps_haproxy {
haproxy = yes
port = 10993
ssl = yes
}
}
service imap {
executable = imap
}
service lmtp {
inet_listener lmtp {
port = 24
}
inet_listener lmtp_haproxy {
haproxy = yes
port = 1124
}
process_min_avail = 5
unix_listener /var/spool/postfix/private/dovecot-lmtp {
group = postfix
mode = 0600
user = postfix
}
user = vmail
}
service managesieve-login {
inet_listener sieve {
port = 4190
}
inet_listener sieve_haproxy {
haproxy = yes
port = 14190
}
}
service replicator {
process_min_avail = 1
unix_listener replicator-doveadm {
mode = 0600
user = vmail
}
vsz_limit = 0
}
ssl = required
ssl_cert = </etc/dovecot/cert/cert.pem
ssl_cipher_list = PROFILE=SYSTEM
ssl_client_ca_file = /etc/dovecot/cert/ca.pem
ssl_key = # hidden, use -P to show it
submission_host = localhost:10026
submission_relay_host = smtp.na.infn.it
submission_relay_trusted = yes
syslog_facility = local5
userdb {
args = /etc/dovecot/dovecot-ldap-aai.conf.ext
driver = ldap
}
userdb {
args = /etc/dovecot/dovecot-ldap-local.conf.ext
driver = ldap
}
protocol lmtp {
mail_plugins = " quota notify replication sieve"
}
protocol !indexer-worker {
mail_vsize_bg_after_count = 100
}
protocol lda {
mail_plugins = " quota notify replication sieve"
}
protocol imap {
mail_plugins = " quota notify replication imap_quota"
}
_______________________________________________
dovecot mailing list -- dovecot@dovecot.org
To unsubscribe send an email to dovecot-le...@dovecot.org
