Can sync/migrate all mail from remote imap account except the main "INBOX"
Greetings! I've been trying to sync my email to a server, however it only syncs the mail in folders other than INBOX.
For testing purposes, I've created a fake domain, "letest.tld" and a new empty user account "mailto:saywhatnow@letest.tld" to receive the copy of the mail being migrated.
What I've been trying are iterations of:
/usr/bin/doveadm -D -o mail_fsync=never -o dsync_features=empty-header-workaround -o imapc_ssl=imaps -o imapc_features=rfc822.size,fetch-headers -o dsync_commit_msgs_interval=100 -o imapc_port=993 -o imapc_host=imap.zoho.com -o imapc_password=NoNoTRe4LLyMyP4$$ -o imapc_user=mailto:decker@n3t.net -o mail_prefetch_count=20 sync -1Ru mailto:saywhatnow@letest.tld imapc:
Regardless of running sync -1 or backup (I want to keep original mailbox as-is for now) I get errors related to INBOX.
With sync -1 ;
May 10 16:53:29 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Ignore nonexistent mailbox GUID c92f64f79f0d1ed01e6d5b314f04886c with -1 sync
May 10 16:53:29 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: We don't have mailbox c92f64f79f0d1ed01e6d5b314f04886c
May 10 16:53:29 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Ignoring missing remote box GUID c92f64f79f0d1ed01e6d5b314f04886c
May 10 16:53:29 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.Archive: Mailbox opened
May 10 16:53:29 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.Archive: Mailbox opened
May 10 16:53:29 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox 51a58e1d1d5c491aac71488647b20224
May 10 16:53:29 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.Commercial Spam: Mailbox opened
May 10 16:53:29 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.Commercial Spam: Mailbox opened
With backup :
May 10 16:54:55 doveadm(mailto:saywhatnow@letest.tld): Debug: brain M: Namespace INBOX. has location maildir:/home/letest/mail/letest.tld/saywhatnow:UTF-8
May 10 16:54:55 doveadm(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 10 16:54:55 doveadm(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 10 16:54:55 doveadm(mailto:saywhatnow@letest.tld): Debug: Namespace INBOX.: Using permissions from /home/letest/mail/letest.tld/saywhatnow: mode=0700 gid=default
...
May 10 16:54:55 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Namespace INBOX. has location imapc:
May 10 16:54:57 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX guid=c92f64f79f0d1ed01e6d5b314f04886c uid_validity=1 uid_next=1 subs=yes last_change=0 last_subs=1652217475
May 10 16:54:57 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX guid=c92f64f79f0d1ed01e6d5b314f04886c uid_validity=1 uid_next=8230 subs=yes last_change=0 last_subs=0 ... May 10 16:54:57 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX guid=c92f64f79f0d1ed01e6d5b314f04886c uid_validity=1 uid_next=8230 subs=yes last_change=0 last_subs=0 ...
May 10 16:54:57 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX: local=c92f64f79f0d1ed01e6d5b314f04886c/0/1, remote=c92f64f79f0d1ed01e6d5b314f04886c/0/1: Mailboxes are equal ... May 10 16:54:57 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 10 16:54:57 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX: local=c92f64f79f0d1ed01e6d5b314f04886c/0/1, remote=c92f64f79f0d1ed01e6d5b314f04886c/0/1: Mailboxes are equal ... May 10 16:54:57 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 10 16:54:57 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Change during sync: Mailbox GUID c92f64f79f0d1ed01e6d5b314f04886c was lost
May 10 16:54:57 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: We don't have mailbox c92f64f79f0d1ed01e6d5b314f04886c
May 10 16:54:57 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Change during sync: Remote lost mailbox GUID c92f64f79f0d1ed01e6d5b314f04886c (maybe it was just deleted?) ...
May 10 16:55:33 dsync(mailto:saywhatnow@letest.tld): Warning: Mailbox changes caused a desync. You may want to run dsync again: Remote lost mailbox GUID c92f64f79f0d1ed01e6d5b314f04886c (maybe it was just deleted?)
This is odd, since that very GUID is in the uidlist file for the base folder:
# grep -R Gc92f64f79f0d1ed01e6d5b314f04886c /home/letest/mail/letest.tld/saywhatnow
/home/letest/mail/letest.tld/saywhatnow/dovecot-uidlist:3 V1 N1 Gc92f64f79f0d1ed01e6d5b314f04886c
I've tried all sorts of things to get this to work, including removing the entire /home/letest/mail/letest.tld/saywhatnow/ directory so there could be no conflicts with existing mailbox, set mailbox_list_index=no , set lda_mailbox_autocreate=no , etc.
The errors appear to originate from src/doveadm/dsync/dsync-brain-mailbox.c but it's not really telling me a lot.
I'm using dovecot version 2.3.18 (9dd8408c18) on a cPanel server.
dovecot -n
output attached.
Any help would be greatly appreciated!
Thanks, Darren
On 11. May 2022, at 1.17, Darren Mobley
mailto:decker@n3t.net> wrote: Greetings! I've been trying to sync my email to a server, however it only syncs the mail in folders other than INBOX.
For testing purposes, I've created a fake domain, "letest.tld" and a new empty user account "saywhatnow@letest.tld mailto:saywhatnow@letest.tld" to receive the copy of the mail being migrated.
What I've been trying are iterations of:
/usr/bin/doveadm -D -o mail_fsync=never -o dsync_features=empty-header-workaround -o imapc_ssl=imaps -o imapc_features=rfc822.size,fetch-headers -o dsync_commit_msgs_interval=100 -o imapc_port=993 -o imapc_host=imap.zoho.com http://imap.zoho.com/ -o imapc_password=NoNoTRe4LLyMyP4$$ -o imapc_user=decker@n3t.net mailto:decker@n3t.net -o mail_prefetch_count=20 sync -1Ru saywhatnow@letest.tld mailto:saywhatnow@letest.tld imapc:
can you record imapc rawlogs to check what the remote responds for some imap commands:
doveadm -o
Then check the saved rawlogs for hints if the remote even lists all subfolders in response.
Sami
Sure, thanks for the reply and suggestion
To make testing/debugging easier, rather than using a remote provider, I created another domain and email account on the same server with just a few mails. I sent 3 jibberish mails to this new account, from this new account, so they are showing in both INBOX and Sent, as well as 1 mail from root on the CLI (mail -v mailto:wah@hellodemo.ppl), These is also a draft mail saved in Drafts:
Source account file system layout:
# find /home/hellodemo/mail/hellodemo.ppl/wah/
/home/hellodemo/mail/hellodemo.ppl/wah/
/home/hellodemo/mail/hellodemo.ppl/wah/.Drafts
/home/hellodemo/mail/hellodemo.ppl/wah/.Drafts/cur
/home/hellodemo/mail/hellodemo.ppl/wah/.Drafts/cur/1652465670.M627726P3692.cent-7.darren.cpanel.net,S=341,W=353:2,S
/home/hellodemo/mail/hellodemo.ppl/wah/.Drafts/new
/home/hellodemo/mail/hellodemo.ppl/wah/.Drafts/tmp
/home/hellodemo/mail/hellodemo.ppl/wah/.Drafts/dovecot.index.log
/home/hellodemo/mail/hellodemo.ppl/wah/.Drafts/dovecot-uidlist
/home/hellodemo/mail/hellodemo.ppl/wah/.Drafts/dovecot.index.cache
/home/hellodemo/mail/hellodemo.ppl/wah/.Junk
/home/hellodemo/mail/hellodemo.ppl/wah/.Junk/cur
/home/hellodemo/mail/hellodemo.ppl/wah/.Junk/new
/home/hellodemo/mail/hellodemo.ppl/wah/.Junk/tmp
/home/hellodemo/mail/hellodemo.ppl/wah/.Junk/dovecot.index.log
/home/hellodemo/mail/hellodemo.ppl/wah/.Junk/dovecot-uidlist
/home/hellodemo/mail/hellodemo.ppl/wah/.Sent
/home/hellodemo/mail/hellodemo.ppl/wah/.Sent/cur
/home/hellodemo/mail/hellodemo.ppl/wah/.Sent/cur/1652465920.M799279P3808.cent-7.darren.cpanel.net,S=359,W=371:2,S
/home/hellodemo/mail/hellodemo.ppl/wah/.Sent/cur/1652465942.M469746P3832.cent-7.darren.cpanel.net,S=342,W=354:2,S
/home/hellodemo/mail/hellodemo.ppl/wah/.Sent/cur/1652465951.M751062P3906.cent-7.darren.cpanel.net,S=342,W=354:2,S
/home/hellodemo/mail/hellodemo.ppl/wah/.Sent/new
/home/hellodemo/mail/hellodemo.ppl/wah/.Sent/tmp
/home/hellodemo/mail/hellodemo.ppl/wah/.Sent/dovecot.index.log
/home/hellodemo/mail/hellodemo.ppl/wah/.Sent/dovecot-uidlist
/home/hellodemo/mail/hellodemo.ppl/wah/.Sent/dovecot.index.cache
/home/hellodemo/mail/hellodemo.ppl/wah/.Trash
/home/hellodemo/mail/hellodemo.ppl/wah/.Trash/cur
/home/hellodemo/mail/hellodemo.ppl/wah/.Trash/new
/home/hellodemo/mail/hellodemo.ppl/wah/.Trash/tmp
/home/hellodemo/mail/hellodemo.ppl/wah/.Trash/dovecot.index.log
/home/hellodemo/mail/hellodemo.ppl/wah/.Trash/dovecot-uidlist
/home/hellodemo/mail/hellodemo.ppl/wah/cur
/home/hellodemo/mail/hellodemo.ppl/wah/cur/1652465917.M799363P3797.cent-7.darren.cpanel.net,S=928,W=956:2,
/home/hellodemo/mail/hellodemo.ppl/wah/cur/1652465920.M628557P3797.cent-7.darren.cpanel.net,S=969,W=998:2,
/home/hellodemo/mail/hellodemo.ppl/wah/cur/1652465942.M304779P3797.cent-7.darren.cpanel.net,S=952,W=981:2,
/home/hellodemo/mail/hellodemo.ppl/wah/cur/1652465951.M583486P3797.cent-7.darren.cpanel.net,S=952,W=981:2,
/home/hellodemo/mail/hellodemo.ppl/wah/new
/home/hellodemo/mail/hellodemo.ppl/wah/tmp
/home/hellodemo/mail/hellodemo.ppl/wah/maildirsize
/home/hellodemo/mail/hellodemo.ppl/wah/.spam
/home/hellodemo/mail/hellodemo.ppl/wah/.spam/cur
/home/hellodemo/mail/hellodemo.ppl/wah/.spam/new
/home/hellodemo/mail/hellodemo.ppl/wah/.spam/tmp
/home/hellodemo/mail/hellodemo.ppl/wah/.spam/maildirfolder
/home/hellodemo/mail/hellodemo.ppl/wah/.spam/dovecot.index.log
/home/hellodemo/mail/hellodemo.ppl/wah/.spam/dovecot-uidlist
/home/hellodemo/mail/hellodemo.ppl/wah/dovecot.list.index.log
/home/hellodemo/mail/hellodemo.ppl/wah/dovecot.index.log
/home/hellodemo/mail/hellodemo.ppl/wah/dovecot-uidvalidity
/home/hellodemo/mail/hellodemo.ppl/wah/dovecot-uidlist
/home/hellodemo/mail/hellodemo.ppl/wah/subscriptions
/home/hellodemo/mail/hellodemo.ppl/wah/dovecot.mailbox.log
/home/hellodemo/mail/hellodemo.ppl/wah/dovecot-acl-list
/home/hellodemo/mail/hellodemo.ppl/wah/.Archive
/home/hellodemo/mail/hellodemo.ppl/wah/.Archive/cur
/home/hellodemo/mail/hellodemo.ppl/wah/.Archive/new
/home/hellodemo/mail/hellodemo.ppl/wah/.Archive/tmp
/home/hellodemo/mail/hellodemo.ppl/wah/.Archive/maildirfolder
/home/hellodemo/mail/hellodemo.ppl/wah/.Archive/dovecot.index.log
/home/hellodemo/mail/hellodemo.ppl/wah/.Archive/dovecot-uidlist
/home/hellodemo/mail/hellodemo.ppl/wah/dovecot-uidvalidity.627e9e14
/home/hellodemo/mail/hellodemo.ppl/wah/dovecot-quota
/home/hellodemo/mail/hellodemo.ppl/wah/dovecot.index.cache
I rm -rf'd /home/letest/mail/letest.tld/saywhatnow/ to be sure it was "clean" then ran the sync -1R command with the additional raw log option:
# /usr/bin/doveadm -Dv -o mail_fsync=never -o dsync_commit_msgs_interval=100 -o imapc_features=rfc822.size,fetch-headers -o dsync_features=empty-header-workaround -o imapc_port=143 -o imapc_host=127.0.0.1 -o imapc_password=redacted -o imapc_user=mailto:wah@hellodemo.ppl -o imapc_rawlog_dir=/tmp/raww -o mail_prefetch_count=20 sync -1Ru mailto:saywhatnow@letest.tld imapc:
Debug: Loading modules from directory: /usr/lib64/dovecot/doveadm
Debug: Skipping module doveadm_acl_plugin, because dlopen() failed: /usr/lib64/dovecot/doveadm/lib10_doveadm_acl_plugin.so: undefined symbol: acl_user_module (this is usually intentional, so just ignore this message)
Debug: Skipping module doveadm_quota_plugin, because dlopen() failed: /usr/lib64/dovecot/doveadm/lib10_doveadm_quota_plugin.so: undefined symbol: quota_user_module (this is usually intentional, so just ignore this message)
Debug: Skipping module doveadm_fts_plugin, because dlopen() failed: /usr/lib64/dovecot/doveadm/lib20_doveadm_fts_plugin.so: undefined symbol: fts_user_get_language_list (this is usually intentional, so just ignore this message)
Debug: Skipping module doveadm_mail_crypt_plugin, because dlopen() failed: /usr/lib64/dovecot/doveadm/libdoveadm_mail_crypt_plugin.so: undefined symbol: mail_crypt_box_get_pvt_digests (this is usually intentional, so just ignore this message)
May 13 13:28:17 Debug: Loading modules from directory: /usr/lib64/dovecot
May 13 13:28:17 Debug: Module loaded: /usr/lib64/dovecot/lib10_quota_plugin.so
May 13 13:28:17 Debug: Module loaded: /usr/lib64/dovecot/lib20_quota_clone_plugin.so
May 13 13:28:17 Debug: Module loaded: /usr/lib64/dovecot/lib20_zlib_plugin.so
May 13 13:28:17 Debug: Loading modules from directory: /usr/lib64/dovecot/doveadm
May 13 13:28:17 Debug: Skipping module doveadm_acl_plugin, because dlopen() failed: /usr/lib64/dovecot/doveadm/lib10_doveadm_acl_plugin.so: undefined symbol: acl_user_module (this is usually intentional, so just ignore this message)
May 13 13:28:17 Debug: Module loaded: /usr/lib64/dovecot/doveadm/lib10_doveadm_quota_plugin.so
May 13 13:28:17 Debug: Skipping module doveadm_fts_plugin, because dlopen() failed: /usr/lib64/dovecot/doveadm/lib20_doveadm_fts_plugin.so: undefined symbol: fts_user_get_language_list (this is usually intentional, so just ignore this message)
May 13 13:28:17 Debug: Skipping module doveadm_mail_crypt_plugin, because dlopen() failed: /usr/lib64/dovecot/doveadm/libdoveadm_mail_crypt_plugin.so: undefined symbol: mail_crypt_box_get_pvt_digests (this is usually intentional, so just ignore this message)
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: auth-master: userdb lookup(mailto:saywhatnow@letest.tld): Started userdb lookup
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: auth-master: conn unix:/var/run/dovecot/auth-userdb: Connecting
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: auth-master: conn unix:/var/run/dovecot/auth-userdb (pid=792,uid=0): Client connected (fd=10)
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: auth-master: userdb lookup(mailto:saywhatnow@letest.tld): auth USER input: mailto:saywhatnow@letest.tld quota=maildir:Mailbox:ns=INBOX. quota_rule3=INBOX.Trash:ignore userdb_home=/home/letest/mail/letest.tld/saywhatnow userdb_quota2_grace=0 userdb_user=mailto:saywhatnow@letest.tld userdb_quota_status_overquota=552 5.2.2 Mailbox is full / Blocks limit exceeded / Inode limit exceeded quota_rule=*:messages=2147483647 mail=maildir:/home/letest/mail/letest.tld/saywhatnow:UTF-8 userdb_quota_vsizes=yes gid=1003 quota_rule2=INBOX.INBOX:ignore quota_clone_dict=file:/home/letest/mail/letest.tld/saywhatnow/dovecot-quota quota2=fs:cPanel Account userdb_gid=1003 userdb_quota_rule3=INBOX.Trash:ignore quota_vsizes=yes quota2_grace=0 quota_status_overquota=552 5.2.2 Mailbox is full / Blocks limit exceeded / Inode limit exceeded lda_mailbox_autocreate=no userdb_mail=maildir:/home/letest/mail/letest.tld/saywhatnow:UTF-8 uid=1001 password=<hidden> userdb_quota_rule2=INBOX.INBOX:ignore userdb_uid=1001 userdb_password=<hidden> userdb_lda_mailbox_autocreate=no userdb_quota_clone_dict=file:/home/letest/mail/letest.tld/saywhatnow/dovecot-quota userdb_quota=maildir:Mailbox:ns=INBOX. userdb_quota_rule=*:messages=2147483647 home=/home/letest/mail/letest.tld/saywhatnow userdb_quota2=fs:cPanel Account
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: auth-master: userdb lookup(mailto:saywhatnow@letest.tld): Finished userdb lookup (username=mailto:saywhatnow@letest.tld quota=maildir:Mailbox:ns=INBOX. quota_rule3=INBOX.Trash:ignore userdb_home=/home/letest/mail/letest.tld/saywhatnow userdb_quota2_grace=0 userdb_user=mailto:saywhatnow@letest.tld userdb_quota_status_overquota=552 5.2.2 Mailbox is full / Blocks limit exceeded / Inode limit exceeded quota_rule=*:messages=2147483647 mail=maildir:/home/letest/mail/letest.tld/saywhatnow:UTF-8 userdb_quota_vsizes=yes gid=1003 quota_rule2=INBOX.INBOX:ignore quota_clone_dict=file:/home/letest/mail/letest.tld/saywhatnow/dovecot-quota quota2=fs:cPanel Account userdb_gid=1003 userdb_quota_rule3=INBOX.Trash:ignore quota_vsizes=yes quota2_grace=0 quota_status_overquota=552 5.2.2 Mailbox is full / Blocks limit exceeded / Inode limit exceeded lda_mailbox_autocreate=no userdb_mail=maildir:/home/letest/mail/letest.tld/saywhatnow:UTF-8 uid=1001 password={CRYPT}$1$mmnope userdb_quota_rule2=INBOX.INBOX:ignore userdb_uid=1001 userdb_password={CRYPT}$1$mmnope userdb_lda_mailbox_autocreate=no userdb_quota_clone_dict=file:/home/letest/mail/letest.tld/saywhatnow/dovecot-quota userdb_quota=maildir:Mailbox:ns=INBOX. userdb_quota_rule=*:messages=2147483647 home=/home/letest/mail/letest.tld/saywhatnow userdb_quota2=fs:cPanel Account)
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/lda_mailbox_autocreate=no
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: mail=maildir:/home/letest/mail/letest.tld/saywhatnow:UTF-8
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/password=<hidden>
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/quota=maildir:Mailbox:ns=INBOX.
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/quota2=fs:cPanel Account
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/quota2_grace=0
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/quota_clone_dict=file:/home/letest/mail/letest.tld/saywhatnow/dovecot-quota
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/quota_rule=*:messages=2147483647
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/quota_rule2=INBOX.INBOX:ignore
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/quota_rule3=INBOX.Trash:ignore
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/quota_status_overquota=552 5.2.2 Mailbox is full / Blocks limit exceeded / Inode limit exceeded
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/quota_vsizes=yes
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_gid=1003
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_home=/home/letest/mail/letest.tld/saywhatnow
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_lda_mailbox_autocreate=no
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_mail=maildir:/home/letest/mail/letest.tld/saywhatnow:UTF-8
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_password=<hidden>
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_quota=maildir:Mailbox:ns=INBOX.
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_quota2=fs:cPanel Account
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_quota2_grace=0
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_quota_clone_dict=file:/home/letest/mail/letest.tld/saywhatnow/dovecot-quota
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_quota_rule=*:messages=2147483647
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_quota_rule2=INBOX.INBOX:ignore
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_quota_rule3=INBOX.Trash:ignore
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_quota_status_overquota=552 5.2.2 Mailbox is full / Blocks limit exceeded / Inode limit exceeded
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_quota_vsizes=yes
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_uid=1001
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_user=mailto:saywhatnow@letest.tld
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Effective uid=1001, gid=1003, home=/home/letest/mail/letest.tld/saywhatnow
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Home dir not found: /home/letest/mail/letest.tld/saywhatnow
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Quota root: name=Mailbox backend=maildir args=ns=INBOX.
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Quota rule: root=Mailbox mailbox=* bytes=0 messages=2147483647
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Quota rule: root=Mailbox mailbox=INBOX.INBOX ignored
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Quota rule: root=Mailbox mailbox=INBOX.Trash ignored
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Quota grace: root=Mailbox bytes=0 (10%)
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Quota root: name=cPanel Account backend=fs args=
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Quota grace: root=cPanel Account bytes=0
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: dict(file): dict created (uri=file:/home/letest/mail/letest.tld/saywhatnow/dovecot-quota, base_dir=/var/run/dovecot)
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Namespace inbox: type=private, prefix=INBOX., sep=., inbox=yes, hidden=no, list=yes, subscriptions=yes location=maildir:/home/letest/mail/letest.tld/saywhatnow:UTF-8
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: maildir++: root=/home/letest/mail/letest.tld/saywhatnow, index=, indexpvt=, control=, inbox=/home/letest/mail/letest.tld/saywhatnow, alt=
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Namespace : type=private, prefix=, sep=, inbox=no, hidden=yes, list=no, subscriptions=no location=fail::LAYOUT=none
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: none: root=, index=, indexpvt=, control=, inbox=, alt=
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: quota: quota_over_flag check: quota_over_script unset - skipping
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: quota: quota_over_flag check: quota2_over_script unset - skipping
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld): Debug: brain M: Namespace INBOX. has location maildir:/home/letest/mail/letest.tld/saywhatnow:UTF-8
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld): Debug: Namespace INBOX.: /home/letest/mail/letest.tld/saywhatnow doesn't exist yet, using default permissions
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld): Debug: Namespace INBOX.: Using permissions from /home/letest/mail/letest.tld/saywhatnow: mode=0700 gid=default
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Couldn't open mailbox in list index: Mailbox not found
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Couldn't open mailbox in list index: Mailbox not found
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Couldn't open mailbox in list index: Mailbox not found
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 13 13:28:17 doveadm(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Effective uid=1001, gid=1003, home=/home/letest/mail/letest.tld/saywhatnow
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Quota root: name=Mailbox backend=maildir args=ns=INBOX.
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Quota rule: root=Mailbox mailbox=* bytes=0 messages=2147483647
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Quota rule: root=Mailbox mailbox=INBOX.INBOX ignored
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Quota rule: root=Mailbox mailbox=INBOX.Trash ignored
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Quota grace: root=Mailbox bytes=0 (10%)
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Quota root: name=cPanel Account backend=fs args=
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Quota grace: root=cPanel Account bytes=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: dict(file): dict created (uri=file:/home/letest/mail/letest.tld/saywhatnow/dovecot-quota, base_dir=/var/run/dovecot)
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Namespace inbox: type=private, prefix=INBOX., sep=., inbox=yes, hidden=no, list=yes, subscriptions=yes location=imapc:
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Created new connection
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Looking up IP address (reconnect_ok=true, last_connect=1652466497)
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Connecting to 127.0.0.1:143
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Info: imapc(127.0.0.1:143): Connected to 127.0.0.1:143 (local 127.0.0.1:53660)
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Server capabilities: IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE NAMESPACE LITERAL+ STARTTLS AUTH=PLAIN AUTH=LOGIN
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Authenticating as mailto:wah@hellodemo.ppl
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Server capabilities: IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SNIPPET=FUZZY PREVIEW=FUZZY PREVIEW STATUS=SIZE SAVEDATE NAMESPACE LITERAL+ NOTIFY SPECIAL-USE COMPRESS=DEFLATE QUOTA
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Authenticated successfully
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: imapc: root=, index=, indexpvt=, control=, inbox=, alt=
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Namespace : type=private, prefix=, sep=, inbox=no, hidden=yes, list=no, subscriptions=no location=fail::LAYOUT=none
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: none: root=, index=, indexpvt=, control=, inbox=, alt=
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: quota: quota_over_flag check: quota_over_script unset - skipping
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: quota: quota_over_flag check: quota2_over_script unset - skipping
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Namespace INBOX. has location imapc:
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX guid=980aa92b41a37e62cd0f0000537c03e1 uid_validity=1652466497 uid_next=1 subs=no last_change=0 last_subs=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX guid=c92f64f79f0d1ed01e6d5b314f04886c uid_validity=1652465166 uid_next=5 subs=no last_change=0 last_subs=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX guid=00000000000000000000000000000000 uid_validity=0 uid_next=0 subs=no last_change=0 last_subs=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Drafts guid=004ef77f6a9c3669bcb43012f3a43855 uid_validity=1652465167 uid_next=2 subs=yes last_change=0 last_subs=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX guid=c92f64f79f0d1ed01e6d5b314f04886c uid_validity=1652465166 uid_next=5 subs=no last_change=0 last_subs=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX guid=00000000000000000000000000000000 uid_validity=0 uid_next=0 subs=no last_change=0 last_subs=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Drafts guid=004ef77f6a9c3669bcb43012f3a43855 uid_validity=1652465167 uid_next=2 subs=yes last_change=0 last_subs=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Junk guid=4849549b42c9c7de02f5e49cfa8ae258 uid_validity=1652465168 uid_next=1 subs=no last_change=0 last_subs=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Junk guid=4849549b42c9c7de02f5e49cfa8ae258 uid_validity=1652465168 uid_next=1 subs=no last_change=0 last_subs=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Sent guid=7d3c7eaa71cdf47ee8a1192687cda8cd uid_validity=1652465169 uid_next=4 subs=yes last_change=0 last_subs=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Sent guid=7d3c7eaa71cdf47ee8a1192687cda8cd uid_validity=1652465169 uid_next=4 subs=yes last_change=0 last_subs=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Trash guid=b36f688eae08506001091708006abe5a uid_validity=1652465170 uid_next=1 subs=yes last_change=0 last_subs=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Trash guid=b36f688eae08506001091708006abe5a uid_validity=1652465170 uid_next=1 subs=yes last_change=0 last_subs=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.spam guid=1ec60921a9e03a229747d8dacdb97c65 uid_validity=1652465171 uid_next=1 subs=yes last_change=0 last_subs=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.spam guid=1ec60921a9e03a229747d8dacdb97c65 uid_validity=1652465171 uid_next=1 subs=yes last_change=0 last_subs=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Archive guid=e94acd62db4233e3f7add6d6159b1d11 uid_validity=1652465172 uid_next=1 subs=yes last_change=0 last_subs=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Archive guid=e94acd62db4233e3f7add6d6159b1d11 uid_validity=1652465172 uid_next=1 subs=yes last_change=0 last_subs=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX: local=980aa92b41a37e62cd0f0000537c03e1/0/1, remote=c92f64f79f0d1ed01e6d5b314f04886c/0/1: GUIDs conflict - will be merged later
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX: local=00000000000000000000000000000000/0/0, remote=00000000000000000000000000000000/0/0: Directory rename branch not found
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Archive: local=00000000000000000000000000000000/0/0, remote=e94acd62db4233e3f7add6d6159b1d11/0/1: mailbox not selectable yet
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Drafts: local=00000000000000000000000000000000/0/0, remote=004ef77f6a9c3669bcb43012f3a43855/0/1: mailbox not selectable yet
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Junk: local=00000000000000000000000000000000/0/0, remote=4849549b42c9c7de02f5e49cfa8ae258/0/1: mailbox not selectable yet
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Sent: local=00000000000000000000000000000000/0/0, remote=7d3c7eaa71cdf47ee8a1192687cda8cd/0/1: mailbox not selectable yet
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Trash: local=00000000000000000000000000000000/0/0, remote=b36f688eae08506001091708006abe5a/0/1: mailbox not selectable yet
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.spam: local=00000000000000000000000000000000/0/0, remote=1ec60921a9e03a229747d8dacdb97c65/0/1: mailbox not selectable yet
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Rotated transaction log /home/letest/mail/letest.tld/saywhatnow/dovecot.index.log (seq=3, reset=yes)
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Namespace INBOX.: /home/letest/mail/letest.tld/saywhatnow/.INBOX.Archive doesn't exist yet, using default permissions
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Archive: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Couldn't open mailbox in list index: Refresh-flag set
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Archive: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Namespace INBOX.: /home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts doesn't exist yet, using default permissions
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Couldn't open mailbox in list index: Refresh-flag set
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Namespace INBOX.: /home/letest/mail/letest.tld/saywhatnow/.INBOX.Junk doesn't exist yet, using default permissions
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Junk: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Couldn't open mailbox in list index: Refresh-flag set
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Junk: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Namespace INBOX.: /home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent doesn't exist yet, using default permissions
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Couldn't open mailbox in list index: Refresh-flag set
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Namespace INBOX.: /home/letest/mail/letest.tld/saywhatnow/.INBOX.Trash doesn't exist yet, using default permissions
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Trash: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Couldn't open mailbox in list index: Refresh-flag set
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Trash: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Namespace INBOX.: /home/letest/mail/letest.tld/saywhatnow/.INBOX.spam doesn't exist yet, using default permissions
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.spam: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Couldn't open mailbox in list index: Refresh-flag set
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.spam: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Remote mailbox tree: INBOX guid=980aa92b41a37e62cd0f0000537c03e1 uid_validity=1652466497 uid_next=1 subs=no last_change=0 last_subs=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX: local=c92f64f79f0d1ed01e6d5b314f04886c/0/1, remote=980aa92b41a37e62cd0f0000537c03e1/0/1: GUIDs conflict - will be merged later
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX: local=00000000000000000000000000000000/0/0, remote=00000000000000000000000000000000/0/0: Directory rename branch not found
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Archive: local=e94acd62db4233e3f7add6d6159b1d11/0/1, remote=00000000000000000000000000000000/0/0: mailbox not selectable yet
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Drafts: local=004ef77f6a9c3669bcb43012f3a43855/0/1, remote=00000000000000000000000000000000/0/0: mailbox not selectable yet
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Junk: local=4849549b42c9c7de02f5e49cfa8ae258/0/1, remote=00000000000000000000000000000000/0/0: mailbox not selectable yet
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Sent: local=7d3c7eaa71cdf47ee8a1192687cda8cd/0/1, remote=00000000000000000000000000000000/0/0: mailbox not selectable yet
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Trash: local=b36f688eae08506001091708006abe5a/0/1, remote=00000000000000000000000000000000/0/0: mailbox not selectable yet
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.spam: local=1ec60921a9e03a229747d8dacdb97c65/0/1, remote=00000000000000000000000000000000/0/0: mailbox not selectable yet
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Ignore nonexistent mailbox GUID c92f64f79f0d1ed01e6d5b314f04886c with -1 sync
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: We don't have mailbox c92f64f79f0d1ed01e6d5b314f04886c
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Ignoring missing remote box GUID c92f64f79f0d1ed01e6d5b314f04886c
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Archive: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Archive: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox e94acd62db4233e3f7add6d6159b1d11
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Drafts: Last common UID=0. Delayed expunges=
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Drafts: Import change type=save GUID= UID=1 hdr_hash= result=Mail's UID is above local UIDNEXT - No more local mails found
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: UID 1: Opened mail because: access
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: import mail uid 1 guid
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Drafts: Import mail body for GUID= UID=1
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: Adding field flags to cache for the first time (uid=1)
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: saving UID 1: Opened mail because: mail stream
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: Purging (new file_seq=1652466497): creating cache
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: Purging finished, file_seq changed 0 -> 1652466497, size=0 -> 388, max_uid=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Drafts: Saved UIDs: 1
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Drafts: Finish update: min_next_uid=2 min_first_recent_uid=2 min_highest_modseq=2 min_highest_pvt_modseq=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Junk: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Junk: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox 4849549b42c9c7de02f5e49cfa8ae258
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Sent: Last common UID=0. Delayed expunges=
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Sent: Import change type=save GUID= UID=1 hdr_hash= result=Mail's UID is above local UIDNEXT - No more local mails found
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Sent: Import change type=save GUID= UID=2 hdr_hash= result=New mail
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Sent: Import change type=save GUID= UID=3 hdr_hash= result=New mail
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: UID 1: Opened mail because: access
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: UID 2: Opened mail
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: UID 3: Opened mail
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: import mail uid 1 guid
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Sent: Import mail body for GUID= UID=1
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: Adding field flags to cache for the first time (uid=1)
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: saving UID 1: Opened mail because: mail stream
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: import mail uid 2 guid
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Sent: Import mail body for GUID= UID=2
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: saving UID 2: Opened mail because: mail stream
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: import mail uid 3 guid
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Sent: Import mail body for GUID= UID=3
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: saving UID 3: Opened mail because: mail stream
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: Purging (new file_seq=1652466497): creating cache
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: Purging finished, file_seq changed 0 -> 1652466497, size=0 -> 388, max_uid=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Sent: Saved UIDs: 1:3
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Sent: Finish update: min_next_uid=4 min_first_recent_uid=1 min_highest_modseq=2 min_highest_pvt_modseq=0
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Trash: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Trash: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox b36f688eae08506001091708006abe5a
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.spam: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.spam: Mailbox opened
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox 1ec60921a9e03a229747d8dacdb97c65
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: dict(file): Waiting for dict to finish pending operations
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: dict(file): Waiting for dict to finish pending operations
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: dict(file): dict destroyed
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Disconnected
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: dict(file): Waiting for dict to finish pending operations
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: dict(file): Starting transaction
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: dict(file): Setting 'priv/quota/storage' to '1420'
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: dict(file): Setting 'priv/quota/messages' to '4'
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: dict(file): Waiting for dict to finish pending operations
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: dict(file): Dict transaction finished
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: dict(file): Waiting for dict to finish pending operations
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: dict(file): dict destroyed
May 13 13:28:17 doveadm(4045): Debug: auth-master: conn unix:/var/run/dovecot/auth-userdb (pid=792,uid=0): Disconnected: Connection closed (fd=10)
This gave 2 files in /tmp/raww/ , the out file:
# cat /tmp/raww/20220513-132817.4045.1.out
1652466497.738086 1 LOGIN "mailto:wah@hellodemo.ppl" "redacted"
1652466497.747397 2 LIST "" ""
1652466497.748167 3 STATUS "INBOX" (UIDNEXT UIDVALIDITY)
1652466497.748956 4 LIST "" "*"
1652466497.749897 5 STATUS "INBOX.Archive" (UIDNEXT UIDVALIDITY)
1652466497.750201 6 STATUS "INBOX.spam" (UIDNEXT UIDVALIDITY)
1652466497.750435 7 STATUS "INBOX.Trash" (UIDNEXT UIDVALIDITY)
1652466497.750665 8 STATUS "INBOX.Sent" (UIDNEXT UIDVALIDITY)
1652466497.751762 9 STATUS "INBOX.Junk" (UIDNEXT UIDVALIDITY)
1652466497.752068 10 STATUS "INBOX.Drafts" (UIDNEXT UIDVALIDITY)
1652466497.752308 11 LSUB "" "*"
1652466497.775368 12 LIST "" "*"
1652466497.776835 13 EXAMINE "INBOX.Archive"
1652466497.778211 14 EXAMINE "INBOX.Drafts"
1652466497.779216 15 UID FETCH 1:* (FLAGS)
1652466497.781243 16 UID FETCH 1 (INTERNALDATE SAVEDATE BODY.PEEK[])
1652466497.787228 17 EXAMINE "INBOX.Junk"
1652466497.788912 18 EXAMINE "INBOX.Sent"
1652466497.789232 19 UID FETCH 1:* (FLAGS)
1652466497.789837 20 UID FETCH 1,2,3 (INTERNALDATE SAVEDATE BODY.PEEK[])
1652466497.792515 21 EXAMINE "INBOX.Trash"
1652466497.793893 22 EXAMINE "INBOX.spam"
1652466497.794723 23 LOGOUT
and the in file:
# cat /tmp/raww/20220513-132817.4045.1.in 1652466497.747116 1 OK [CAPABILITY IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SNIPPET=FUZZY PREVIEW=FUZZY PREVIEW STATUS=SIZE SAVEDATE NAMESPACE LITERAL+ NOTIFY SPECIAL-USE COMPRESS=DEFLATE QUOTA] Logged in
1652466497.747907 * LIST (\Noselect) "." ""
1652466497.747907 2 OK List completed (0.001 + 0.000 secs).
1652466497.748791 * STATUS INBOX (UIDNEXT 5 UIDVALIDITY 1652465166)
1652466497.748791 3 OK Status completed (0.001 + 0.000 secs).
1652466497.749533 * LIST (\HasChildren) "." INBOX
1652466497.749533 * LIST (\HasNoChildren \UnMarked \Archive) "." INBOX.Archive
1652466497.749533 * LIST (\HasNoChildren \UnMarked \Junk) "." INBOX.spam
1652466497.749533 * LIST (\HasNoChildren \UnMarked \Trash) "." INBOX.Trash
1652466497.749533 * LIST (\HasNoChildren \Sent) "." INBOX.Sent
1652466497.749533 * LIST (\HasNoChildren \UnMarked) "." INBOX.Junk
1652466497.749533 * LIST (\HasNoChildren \UnMarked \Drafts) "." INBOX.Drafts
1652466497.749533 4 OK List completed (0.001 + 0.000 secs).
1652466497.750045 * STATUS INBOX.Archive (UIDNEXT 1 UIDVALIDITY 1652465172)
1652466497.750045 5 OK Status completed (0.001 + 0.000 secs).
1652466497.750312 * STATUS INBOX.spam (UIDNEXT 1 UIDVALIDITY 1652465171)
1652466497.750312 6 OK Status completed (0.001 + 0.000 secs).
1652466497.750552 * STATUS INBOX.Trash (UIDNEXT 1 UIDVALIDITY 1652465170)
1652466497.750552 7 OK Status completed (0.001 + 0.000 secs).
1652466497.751510 * STATUS INBOX.Sent (UIDNEXT 4 UIDVALIDITY 1652465169)
1652466497.751510 8 OK Status completed (0.001 + 0.000 secs).
1652466497.751912 * STATUS INBOX.Junk (UIDNEXT 1 UIDVALIDITY 1652465168)
1652466497.751912 9 OK Status completed (0.001 + 0.000 secs).
1652466497.752208 * STATUS INBOX.Drafts (UIDNEXT 2 UIDVALIDITY 1652465167)
1652466497.752208 10 OK Status completed (0.001 + 0.000 secs).
1652466497.752600 * LSUB (\Junk) "." INBOX.spam
1652466497.752600 * LSUB (\Archive) "." INBOX.Archive
1652466497.752600 * LSUB (\Drafts) "." INBOX.Drafts
1652466497.752600 * LSUB (\Trash) "." INBOX.Trash
1652466497.752600 * LSUB (\Sent) "." INBOX.Sent
1652466497.752600 11 OK Lsub completed (0.001 + 0.000 secs).
1652466497.775980 * LIST (\HasChildren) "." INBOX
1652466497.775980 * LIST (\HasNoChildren \UnMarked \Archive) "." INBOX.Archive
1652466497.775980 * LIST (\HasNoChildren \UnMarked \Junk) "." INBOX.spam
1652466497.775980 * LIST (\HasNoChildren \UnMarked \Trash) "." INBOX.Trash
1652466497.775980 * LIST (\HasNoChildren \Marked \Sent) "." INBOX.Sent
1652466497.775980 * LIST (\HasNoChildren \UnMarked) "." INBOX.Junk
1652466497.775980 * LIST (\HasNoChildren \UnMarked \Drafts) "." INBOX.Drafts
1652466497.775980 12 OK List completed (0.001 + 0.000 secs).
1652466497.777411 * FLAGS (\Answered \Flagged \Deleted \Seen \Draft)
1652466497.777411 * OK [PERMANENTFLAGS ()] Read-only mailbox.
1652466497.777411 * 0 EXISTS
1652466497.777411 * 0 RECENT
1652466497.777411 * OK [UIDVALIDITY 1652465172] UIDs valid
1652466497.777411 * OK [UIDNEXT 1] Predicted next UID
1652466497.777411 13 OK [READ-ONLY] Examine completed (0.001 + 0.000 secs).
1652466497.779160 * OK [CLOSED] Previous mailbox closed.
1652466497.779160 * FLAGS (\Answered \Flagged \Deleted \Seen \Draft)
1652466497.779160 * OK [PERMANENTFLAGS ()] Read-only mailbox.
1652466497.779160 * 1 EXISTS
1652466497.779160 * 0 RECENT
1652466497.779160 * OK [UIDVALIDITY 1652465167] UIDs valid
1652466497.779160 * OK [UIDNEXT 2] Predicted next UID
1652466497.779160 * OK [HIGHESTMODSEQ 2] Highest
1652466497.779160 14 OK [READ-ONLY] Examine completed (0.001 + 0.000 secs).
1652466497.779851 * 1 FETCH (UID 1 FLAGS (\Seen))
1652466497.779851 15 OK Fetch completed (0.001 + 0.000 secs).
1652466497.782233 * 1 FETCH (UID 1 INTERNALDATE "13-May-2022 13:14:30 -0500" SAVEDATE "13-May-2022 13:14:30 -0500" BODY[] {353}
1652466497.782233 MIME-Version: 1.0
1652466497.782233 Date: Fri, 13 May 2022 13:14:30 -0500
1652466497.782233 From: mailto:wah@hellodemo.ppl
1652466497.782233 To: mailto:wah@hellodemo.ppl
1652466497.782233 Subject: awdfaw
1652466497.782233 User-Agent: Roundcube Webmail/1.5.2
1652466497.782233 Message-ID: mailto:d67b3f28d51d6810c4752b8f2ada037c@hellodemo.ppl
1652466497.782233 X-Sender: mailto:wah@hellodemo.ppl
1652466497.782233 Content-Type: text/plain; charset=US-ASCII;
1652466497.782233 format=flowed
1652466497.782233 Content-Transfer-Encoding: 7bit
1652466497.782233
1652466497.782233 awdawd)
1652466497.782233 16 OK Fetch completed (0.001 + 0.000 secs).
1652466497.787744 * OK [CLOSED] Previous mailbox closed.
1652466497.787744 * FLAGS (\Answered \Flagged \Deleted \Seen \Draft)
1652466497.787744 * OK [PERMANENTFLAGS ()] Read-only mailbox.
1652466497.787744 * 0 EXISTS
1652466497.787744 * 0 RECENT
1652466497.787744 * OK [UIDVALIDITY 1652465168] UIDs valid
1652466497.787744 * OK [UIDNEXT 1] Predicted next UID
1652466497.787744 17 OK [READ-ONLY] Examine completed (0.001 + 0.000 secs).
1652466497.789197 * OK [CLOSED] Previous mailbox closed.
1652466497.789197 * FLAGS (\Answered \Flagged \Deleted \Seen \Draft)
1652466497.789197 * OK [PERMANENTFLAGS ()] Read-only mailbox.
1652466497.789197 * 3 EXISTS
1652466497.789197 * 3 RECENT
1652466497.789197 * OK [UIDVALIDITY 1652465169] UIDs valid
1652466497.789197 * OK [UIDNEXT 4] Predicted next UID
1652466497.789197 18 OK [READ-ONLY] Examine completed (0.001 + 0.000 secs).
1652466497.789457 * 1 FETCH (UID 1 FLAGS (\Seen \Recent))
1652466497.789457 * 2 FETCH (UID 2 FLAGS (\Seen \Recent))
1652466497.789457 * 3 FETCH (UID 3 FLAGS (\Seen \Recent))
1652466497.789457 19 OK Fetch completed (0.001 + 0.000 secs).
1652466497.790590 * 1 FETCH (UID 1 INTERNALDATE "13-May-2022 13:18:40 -0500" SAVEDATE "13-May-2022 13:18:40 -0500" BODY[] {371}
1652466497.790590 MIME-Version: 1.0
1652466497.790590 Date: Fri, 13 May 2022 13:18:40 -0500
1652466497.790590 From: mailto:wah@hellodemo.ppl
1652466497.790590 To: mailto:wah@hellodemo.ppl
1652466497.790590 Subject: eswtest
1652466497.790590 User-Agent: Roundcube Webmail/1.5.2
1652466497.790590 Message-ID: mailto:adfa6752cc871c9ba5733f4e1ee1a655@hellodemo.ppl
1652466497.790590 X-Sender: mailto:wah@hellodemo.ppl
1652466497.790590 Content-Type: text/plain; charset=US-ASCII;
1652466497.790590 format=flowed
1652466497.790590 Content-Transfer-Encoding: 7bit
1652466497.790590
1652466497.790590 wadaw dwadawdaw adw adw)
1652466497.790590 * 2 FETCH (UID 2 INTERNALDATE "13-May-2022 13:19:02 -0500" SAVEDATE "13-May-2022 13:19:02 -0500" BODY[] {354}
1652466497.790590 MIME-Version: 1.0
1652466497.790590 Date: Fri, 13 May 2022 13:19:02 -0500
1652466497.790590 From: mailto:wah@hellodemo.ppl
1652466497.790590 To: mailto:wah@hellodemo.ppl
1652466497.790590 Subject: test 1
1652466497.790590 User-Agent: Roundcube Webmail/1.5.2
1652466497.790590 Message-ID: mailto:0a53e2acc3bff9e912b43eafa88502f4@hellodemo.ppl
1652466497.790590 X-Sender: mailto:wah@hellodemo.ppl
1652466497.790590 Content-Type: text/plain; charset=US-ASCII;
1652466497.790590 format=flowed
1652466497.790590 Content-Transfer-Encoding: 7bit
1652466497.790590
1652466497.790590 ersert1)
1652466497.790590 * 3 FETCH (UID 3 INTERNALDATE "13-May-2022 13:19:11 -0500" SAVEDATE "13-May-2022 13:19:11 -0500" BODY[] {354}
1652466497.790590 MIME-Version: 1.0
1652466497.790590 Date: Fri, 13 May 2022 13:19:11 -0500
1652466497.790590 From: mailto:wah@hellodemo.ppl
1652466497.790590 To: mailto:wah@hellodemo.ppl
1652466497.790590 Subject: test2
1652466497.790590 User-Agent: Roundcube Webmail/1.5.2
1652466497.790590 Message-ID: mailto:89a467688c70e06421f69a0c32cdd3cd@hellodemo.ppl
1652466497.790590 X-Sender: mailto:wah@hellodemo.ppl
1652466497.790590 Content-Type: text/plain; charset=US-ASCII;
1652466497.790590 format=flowed
1652466497.790590 Content-Transfer-Encoding: 7bit
1652466497.790590
1652466497.790590 res22222)
1652466497.790590 20 OK Fetch completed (0.001 + 0.000 secs).
1652466497.793104 * OK [CLOSED] Previous mailbox closed.
1652466497.793104 * FLAGS (\Answered \Flagged \Deleted \Seen \Draft)
1652466497.793104 * OK [PERMANENTFLAGS ()] Read-only mailbox.
1652466497.793104 * 0 EXISTS
1652466497.793104 * 0 RECENT
1652466497.793104 * OK [UIDVALIDITY 1652465170] UIDs valid
1652466497.793104 * OK [UIDNEXT 1] Predicted next UID
1652466497.793104 21 OK [READ-ONLY] Examine completed (0.001 + 0.000 secs).
1652466497.794356 * OK [CLOSED] Previous mailbox closed.
1652466497.794356 * FLAGS (\Answered \Flagged \Deleted \Seen \Draft)
1652466497.794356 * OK [PERMANENTFLAGS ()] Read-only mailbox.
1652466497.794356 * 0 EXISTS
1652466497.794356 * 0 RECENT
1652466497.794356 * OK [UIDVALIDITY 1652465171] UIDs valid
1652466497.794356 * OK [UIDNEXT 1] Predicted next UID
1652466497.794356 22 OK [READ-ONLY] Examine completed (0.001 + 0.000 secs).
1652466497.794913 * BYE Logging out
1652466497.794913 23 OK Logout completed (0.001 + 0.000 secs).
And when I look at the destination account, I see that everything got imported over EXCEPT the INBOX itself:
# find /home/letest/mail/letest.tld/saywhatnow
/home/letest/mail/letest.tld/saywhatnow
/home/letest/mail/letest.tld/saywhatnow/dovecot.list.index.log
/home/letest/mail/letest.tld/saywhatnow/cur
/home/letest/mail/letest.tld/saywhatnow/new
/home/letest/mail/letest.tld/saywhatnow/tmp
/home/letest/mail/letest.tld/saywhatnow/dovecot.index.log
/home/letest/mail/letest.tld/saywhatnow/dovecot-uidvalidity
/home/letest/mail/letest.tld/saywhatnow/dovecot-uidlist
/home/letest/mail/letest.tld/saywhatnow/maildirfolder
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Archive
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Archive/cur
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Archive/new
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Archive/tmp
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Archive/maildirfolder
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Archive/dovecot.index.log
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Archive/dovecot-uidlist
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts/cur
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts/cur/1652466497.M782233P4045.cent-7.darren.cpanel.net,S=341,W=353:2,S
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts/new
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts/tmp
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts/maildirfolder
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts/dovecot.index.log
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts/dovecot-uidlist
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts/dovecot.index.cache
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Junk
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Junk/cur
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Junk/new
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Junk/tmp
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Junk/maildirfolder
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Junk/dovecot.index.log
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Junk/dovecot-uidlist
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/cur
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/cur/1652466497.M790590P4045.cent-7.darren.cpanel.net,S=359,W=371:2,S
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/cur/1652466497.M790591P4045.cent-7.darren.cpanel.net,S=342,W=354:2,S
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/cur/1652466497.M790592P4045.cent-7.darren.cpanel.net,S=342,W=354:2,S
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/new
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/tmp
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/maildirfolder
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/dovecot.index.log
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/dovecot-uidlist
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/dovecot.index.cache
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Trash
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Trash/cur
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Trash/new
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Trash/tmp
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Trash/maildirfolder
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Trash/dovecot.index.log
/home/letest/mail/letest.tld/saywhatnow/.INBOX.Trash/dovecot-uidlist
/home/letest/mail/letest.tld/saywhatnow/.INBOX.spam
/home/letest/mail/letest.tld/saywhatnow/.INBOX.spam/cur
/home/letest/mail/letest.tld/saywhatnow/.INBOX.spam/new
/home/letest/mail/letest.tld/saywhatnow/.INBOX.spam/tmp
/home/letest/mail/letest.tld/saywhatnow/.INBOX.spam/maildirfolder
/home/letest/mail/letest.tld/saywhatnow/.INBOX.spam/dovecot.index.log
/home/letest/mail/letest.tld/saywhatnow/.INBOX.spam/dovecot-uidlist
/home/letest/mail/letest.tld/saywhatnow/dovecot-uidvalidity.627ea347
/home/letest/mail/letest.tld/saywhatnow/subscriptions
/home/letest/mail/letest.tld/saywhatnow/dovecot.mailbox.log
/home/letest/mail/letest.tld/saywhatnow/maildirsize
/home/letest/mail/letest.tld/saywhatnow/dovecot-quota
Running the same command a second time results in no changes to the destination account and the GUID issues with the inbox from my previous mail:
May 13 13:41:25 doveadm(mailto:saywhatnow@letest.tld): Debug: brain M: Namespace INBOX. has location maildir:/home/letest/mail/letest.tld/saywhatnow:UTF-8
May 13 13:41:25 doveadm(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 13 13:41:25 doveadm(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 13 13:41:25 doveadm(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.spam: Couldn't open mailbox in list index: Storage size changed 168 != 256
May 13 13:41:25 doveadm(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.spam: Mailbox opened
May 13 13:41:25 doveadm(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Trash: Couldn't open mailbox in list index: Storage size changed 168 != 256
May 13 13:41:25 doveadm(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Trash: Mailbox opened
May 13 13:41:25 doveadm(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Junk: Couldn't open mailbox in list index: Storage size changed 168 != 256
May 13 13:41:25 doveadm(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Junk: Mailbox opened
May 13 13:41:25 doveadm(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Archive: Couldn't open mailbox in list index: Storage size changed 168 != 256
May 13 13:41:25 doveadm(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Archive: Mailbox opened
May 13 13:41:25 doveadm(mailto:saywhatnow@letest.tld): Debug: Namespace INBOX.: Using permissions from /home/letest/mail/letest.tld/saywhatnow: mode=0700 gid=default
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Effective uid=1001, gid=1003, home=/home/letest/mail/letest.tld/saywhatnow
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Quota root: name=Mailbox backend=maildir args=ns=INBOX.
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Quota rule: root=Mailbox mailbox=* bytes=0 messages=2147483647
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Quota rule: root=Mailbox mailbox=INBOX.INBOX ignored
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Quota rule: root=Mailbox mailbox=INBOX.Trash ignored
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Quota grace: root=Mailbox bytes=0 (10%)
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Quota root: name=cPanel Account backend=fs args=
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Quota grace: root=cPanel Account bytes=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: dict(file): dict created (uri=file:/home/letest/mail/letest.tld/saywhatnow/dovecot-quota, base_dir=/var/run/dovecot)
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Namespace inbox: type=private, prefix=INBOX., sep=., inbox=yes, hidden=no, list=yes, subscriptions=yes location=imapc:
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Created new connection
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Looking up IP address (reconnect_ok=true, last_connect=1652467285)
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Connecting to 127.0.0.1:143
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Info: imapc(127.0.0.1:143): Connected to 127.0.0.1:143 (local 127.0.0.1:53730)
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Server capabilities: IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE NAMESPACE LITERAL+ STARTTLS AUTH=PLAIN AUTH=LOGIN
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Authenticating as mailto:wah@hellodemo.ppl
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Server capabilities: IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SNIPPET=FUZZY PREVIEW=FUZZY PREVIEW STATUS=SIZE SAVEDATE NAMESPACE LITERAL+ NOTIFY SPECIAL-USE COMPRESS=DEFLATE QUOTA
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Authenticated successfully
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: imapc: root=, index=, indexpvt=, control=, inbox=, alt=
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Namespace : type=private, prefix=, sep=, inbox=no, hidden=yes, list=no, subscriptions=no location=fail::LAYOUT=none
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: none: root=, index=, indexpvt=, control=, inbox=, alt=
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: quota: quota_over_flag check: quota_over_script unset - skipping
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: quota: quota_over_flag check: quota2_over_script unset - skipping
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Namespace INBOX. has location imapc:
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX guid=c92f64f79f0d1ed01e6d5b314f04886c uid_validity=1652465166 uid_next=1 subs=no last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX guid=c92f64f79f0d1ed01e6d5b314f04886c uid_validity=1652465166 uid_next=5 subs=no last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX.INBOX guid=00000000000000000000000000000000 uid_validity=0 uid_next=0 subs=no last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX guid=00000000000000000000000000000000 uid_validity=0 uid_next=0 subs=no last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX.INBOX.Archive guid=e94acd62db4233e3f7add6d6159b1d11 uid_validity=1652465172 uid_next=1 subs=yes last_change=0 last_subs=1652466497
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Drafts guid=004ef77f6a9c3669bcb43012f3a43855 uid_validity=1652465167 uid_next=2 subs=yes last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX.INBOX.Drafts guid=004ef77f6a9c3669bcb43012f3a43855 uid_validity=1652465167 uid_next=2 subs=yes last_change=0 last_subs=1652466497
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Junk guid=4849549b42c9c7de02f5e49cfa8ae258 uid_validity=1652465168 uid_next=1 subs=no last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX.INBOX.Junk guid=4849549b42c9c7de02f5e49cfa8ae258 uid_validity=1652465168 uid_next=1 subs=no last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Sent guid=7d3c7eaa71cdf47ee8a1192687cda8cd uid_validity=1652465169 uid_next=4 subs=yes last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX.INBOX.Sent guid=7d3c7eaa71cdf47ee8a1192687cda8cd uid_validity=1652465169 uid_next=4 subs=yes last_change=0 last_subs=1652466497
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Trash guid=b36f688eae08506001091708006abe5a uid_validity=1652465170 uid_next=1 subs=yes last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX.INBOX.Trash guid=b36f688eae08506001091708006abe5a uid_validity=1652465170 uid_next=1 subs=yes last_change=0 last_subs=1652466497
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.spam guid=1ec60921a9e03a229747d8dacdb97c65 uid_validity=1652465171 uid_next=1 subs=yes last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX.INBOX.spam guid=1ec60921a9e03a229747d8dacdb97c65 uid_validity=1652465171 uid_next=1 subs=yes last_change=0 last_subs=1652466497
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Archive guid=e94acd62db4233e3f7add6d6159b1d11 uid_validity=1652465172 uid_next=1 subs=yes last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX guid=c92f64f79f0d1ed01e6d5b314f04886c uid_validity=1652465166 uid_next=5 subs=no last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX guid=00000000000000000000000000000000 uid_validity=0 uid_next=0 subs=no last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Drafts guid=004ef77f6a9c3669bcb43012f3a43855 uid_validity=1652465167 uid_next=2 subs=yes last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Junk guid=4849549b42c9c7de02f5e49cfa8ae258 uid_validity=1652465168 uid_next=1 subs=no last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Sent guid=7d3c7eaa71cdf47ee8a1192687cda8cd uid_validity=1652465169 uid_next=4 subs=yes last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Trash guid=b36f688eae08506001091708006abe5a uid_validity=1652465170 uid_next=1 subs=yes last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.spam guid=1ec60921a9e03a229747d8dacdb97c65 uid_validity=1652465171 uid_next=1 subs=yes last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Archive guid=e94acd62db4233e3f7add6d6159b1d11 uid_validity=1652465172 uid_next=1 subs=yes last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Remote mailbox tree: INBOX guid=c92f64f79f0d1ed01e6d5b314f04886c uid_validity=1652465166 uid_next=1 subs=no last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Remote mailbox tree: INBOX.INBOX guid=00000000000000000000000000000000 uid_validity=0 uid_next=0 subs=no last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Remote mailbox tree: INBOX.INBOX.Archive guid=e94acd62db4233e3f7add6d6159b1d11 uid_validity=1652465172 uid_next=1 subs=yes last_change=0 last_subs=1652466497
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Remote mailbox tree: INBOX.INBOX.Drafts guid=004ef77f6a9c3669bcb43012f3a43855 uid_validity=1652465167 uid_next=2 subs=yes last_change=0 last_subs=1652466497
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Remote mailbox tree: INBOX.INBOX.Junk guid=4849549b42c9c7de02f5e49cfa8ae258 uid_validity=1652465168 uid_next=1 subs=no last_change=0 last_subs=0
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Remote mailbox tree: INBOX.INBOX.Sent guid=7d3c7eaa71cdf47ee8a1192687cda8cd uid_validity=1652465169 uid_next=4 subs=yes last_change=0 last_subs=1652466497
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Remote mailbox tree: INBOX.INBOX.Trash guid=b36f688eae08506001091708006abe5a uid_validity=1652465170 uid_next=1 subs=yes last_change=0 last_subs=1652466497
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Remote mailbox tree: INBOX.INBOX.spam guid=1ec60921a9e03a229747d8dacdb97c65 uid_validity=1652465171 uid_next=1 subs=yes last_change=0 last_subs=1652466497
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX: local=c92f64f79f0d1ed01e6d5b314f04886c/0/1, remote=c92f64f79f0d1ed01e6d5b314f04886c/0/1: Mailboxes are equal
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX: local=00000000000000000000000000000000/0/0, remote=00000000000000000000000000000000/0/0: Directory name paths are equal
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Archive: local=e94acd62db4233e3f7add6d6159b1d11/0/1, remote=e94acd62db4233e3f7add6d6159b1d11/0/1: Mailboxes are equal
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Drafts: local=004ef77f6a9c3669bcb43012f3a43855/0/1, remote=004ef77f6a9c3669bcb43012f3a43855/0/1: Mailboxes are equal
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Junk: local=4849549b42c9c7de02f5e49cfa8ae258/0/1, remote=4849549b42c9c7de02f5e49cfa8ae258/0/1: Mailboxes are equal
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Sent: local=7d3c7eaa71cdf47ee8a1192687cda8cd/0/1, remote=7d3c7eaa71cdf47ee8a1192687cda8cd/0/1: Mailboxes are equal
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Trash: local=b36f688eae08506001091708006abe5a/0/1, remote=b36f688eae08506001091708006abe5a/0/1: Mailboxes are equal
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.spam: local=1ec60921a9e03a229747d8dacdb97c65/0/1, remote=1ec60921a9e03a229747d8dacdb97c65/0/1: Mailboxes are equal
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX: local=c92f64f79f0d1ed01e6d5b314f04886c/0/1, remote=c92f64f79f0d1ed01e6d5b314f04886c/0/1: Mailboxes are equal
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX: local=00000000000000000000000000000000/0/0, remote=00000000000000000000000000000000/0/0: Directory name paths are equal
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Archive: local=e94acd62db4233e3f7add6d6159b1d11/0/1, remote=e94acd62db4233e3f7add6d6159b1d11/0/1: Mailboxes are equal
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Drafts: local=004ef77f6a9c3669bcb43012f3a43855/0/1, remote=004ef77f6a9c3669bcb43012f3a43855/0/1: Mailboxes are equal
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Junk: local=4849549b42c9c7de02f5e49cfa8ae258/0/1, remote=4849549b42c9c7de02f5e49cfa8ae258/0/1: Mailboxes are equal
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Sent: local=7d3c7eaa71cdf47ee8a1192687cda8cd/0/1, remote=7d3c7eaa71cdf47ee8a1192687cda8cd/0/1: Mailboxes are equal
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Trash: local=b36f688eae08506001091708006abe5a/0/1, remote=b36f688eae08506001091708006abe5a/0/1: Mailboxes are equal
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.spam: local=1ec60921a9e03a229747d8dacdb97c65/0/1, remote=1ec60921a9e03a229747d8dacdb97c65/0/1: Mailboxes are equal
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Ignore nonexistent mailbox GUID c92f64f79f0d1ed01e6d5b314f04886c with -1 sync
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: We don't have mailbox c92f64f79f0d1ed01e6d5b314f04886c
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Ignoring missing remote box GUID c92f64f79f0d1ed01e6d5b314f04886c
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Archive: Mailbox opened
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Archive: Mailbox opened
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox e94acd62db4233e3f7add6d6159b1d11
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: Mailbox opened
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: Mailbox opened
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox 004ef77f6a9c3669bcb43012f3a43855
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Junk: Mailbox opened
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Junk: Mailbox opened
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox 4849549b42c9c7de02f5e49cfa8ae258
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: Mailbox opened
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: Mailbox opened
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox 7d3c7eaa71cdf47ee8a1192687cda8cd
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Trash: Mailbox opened
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Trash: Mailbox opened
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox b36f688eae08506001091708006abe5a
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.spam: Mailbox opened
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.spam: Mailbox opened
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox 1ec60921a9e03a229747d8dacdb97c65
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: dict(file): Waiting for dict to finish pending operations
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: dict(file): Waiting for dict to finish pending operations
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: dict(file): dict destroyed
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Disconnected
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: dict(file): Waiting for dict to finish pending operations
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: dict(file): Waiting for dict to finish pending operations
May 13 13:41:25 dsync(mailto:saywhatnow@letest.tld): Debug: dict(file): dict destroyed
May 13 13:41:25 doveadm(4355): Debug: auth-master: conn unix:/var/run/dovecot/auth-userdb (pid=792,uid=0): Disconnected: Connection closed (fd=10)
It may not be relevant, but here's the source dovecot-uidlist : # cat /home/hellodemo/mail/hellodemo.ppl/wah/dovecot-uidlist
3 V1652465166 N1 Gd31223010e9e7e62410d0000537c03e1
1 :1652465917.M799363P3797.cent-7.darren.cpanel.net,S=928,W=956
2 :1652465920.M628557P3797.cent-7.darren.cpanel.net,S=969,W=998
3 :1652465942.M304779P3797.cent-7.darren.cpanel.net,S=952,W=981
4 :1652465951.M583486P3797.cent-7.darren.cpanel.net,S=952,W=981
and destination one:
# cat /home/letest/mail/letest.tld/saywhatnow/dovecot-uidlist
3 V1652465166 N1 Gc92f64f79f0d1ed01e6d5b314f04886c
Looking at the raw IMAPC logs, the main stinker I see is that output of LSUB doesn't show the INBOX, and was then skipped from the EXAMINE lines after it:
11 LSUB "" "*"
LSUB (\Junk) "." INBOX.spam
LSUB (\Archive) "." INBOX.Archive
LSUB (\Drafts) "." INBOX.Drafts
LSUB (\Trash) "." INBOX.Trash
LSUB (\Sent) "." INBOX.Sent
However just now I manually subscribed to that folder..
14 subscribe INBOX
14 OK Subscribe completed (0.012 + 0.000 + 0.011 secs).
15 LSUB "" "*"
LSUB () "." INBOX
LSUB (\Junk) "." INBOX.spam
LSUB (\Archive) "." INBOX.Archive
LSUB (\Drafts) "." INBOX.Drafts
LSUB (\Trash) "." INBOX.Trash
LSUB (\Sent) "." INBOX.Sent
15 OK Lsub completed (0.001 + 0.000 secs).
16 logout
..and re-ran the above dovecot sync command, and still didn't get new mail, with the same error about GUID not existing.
Now INBOX itself is reflected in the raw in log:
1652468207.459766 10 OK Status completed (0.001 + 0.000 secs).
1652468207.460004 * LSUB () "." INBOX
1652468207.460004 * LSUB (\Junk) "." INBOX.spam
1652468207.460004 * LSUB (\Archive) "." INBOX.Archive
1652468207.460004 * LSUB (\Drafts) "." INBOX.Drafts
1652468207.460004 * LSUB (\Trash) "." INBOX.Trash
1652468207.460004 * LSUB (\Sent) "." INBOX.Sent
1652468207.460004 11 OK Lsub completed (0.001 + 0.000 secs).
1652468207.461635 * LIST (\HasChildren) "." INBOX
1652468207.461635 * LIST (\HasNoChildren \UnMarked \Archive) "." INBOX.Archive
1652468207.461635 * LIST (\HasNoChildren \UnMarked \Junk) "." INBOX.spam
1652468207.461635 * LIST (\HasNoChildren \UnMarked \Trash) "." INBOX.Trash
1652468207.461635 * LIST (\HasNoChildren \Marked \Sent) "." INBOX.Sent
1652468207.461635 * LIST (\HasNoChildren \UnMarked) "." INBOX.Junk
1652468207.461635 * LIST (\HasNoChildren \UnMarked \Drafts) "." INBOX.Drafts
1652468207.461635 12 OK List completed (0.001 + 0.000 secs).
However the raw out log doesn't show it EXAMINE'ing the INBOX itself, just the .folders :
1652468207.459810 11 LSUB "" "*"
1652468207.461358 12 LIST "" "*"
1652468207.462263 13 EXAMINE "INBOX.Archive"
1652468207.463239 14 EXAMINE "INBOX.Drafts"
1652468207.464101 15 UID FETCH 1:* (FLAGS)
1652468207.465088 16 EXAMINE "INBOX.Junk"
1652468207.465931 17 EXAMINE "INBOX.Sent"
1652468207.466437 18 UID FETCH 1:* (FLAGS)
1652468207.467218 19 EXAMINE "INBOX.Trash"
1652468207.468146 20 EXAMINE "INBOX.spam"
1652468207.468796 21 LOGOUT
My best guess at this point is the logs showing "INBOX" and "INBOX.INBOX" , perhaps there's something about the naming scheme that is throwing it off, but the "INBOX.INBOX.Drafts" and such are still being handled.
Thanks again for any direction! Darren
---- On Fri, 13 May 2022 08:57:22 -0500 Sami Ketola sami@ketola.io wrote ----
On 11. May 2022, at 1.17, Darren Mobley mailto:decker@n3t.net wrote:
Greetings!
I've been trying to sync my email to a server, however it only syncs the mail in folders other than INBOX.
For testing purposes, I've created a fake domain, "letest.tld" and a new empty user account "mailto:saywhatnow@letest.tld" to receive the copy of the mail being migrated.
What I've been trying are iterations of:
/usr/bin/doveadm -D -o mail_fsync=never -o dsync_features=empty-header-workaround -o imapc_ssl=imaps -o imapc_features=rfc822.size,fetch-headers -o dsync_commit_msgs_interval=100 -o imapc_port=993 -o imapc_host=http://imap.zoho.com/ -o imapc_password=NoNoTRe4LLyMyP4$$ -o imapc_user=mailto:decker@n3t.net -o mail_prefetch_count=20 sync -1Ru mailto:saywhatnow@letest.tld imapc:
can you record imapc rawlogs to check what the remote responds for some imap commands:
doveadm -o
Then check the saved rawlogs for hints if the remote even lists all subfolders in response.
Sami
Assuming that the question at hand is :
My best guess at this point is the logs showing "INBOX" and "INBOX.INBOX" , perhaps there's something about the naming scheme that is throwing it off, but the "INBOX.INBOX.Drafts" and such are still being handled.
Thanks again for any direction! Darren
I went through this when migrating from syrus imap
typically when dealing with special folders, cyrus liked doing everything
INBOX.Drafts INBOX.Set
etc ....
issue is it seems dovecot (only by experience) would prefer special folders in the ROOT of the mail folder.
to acomplish this I used this in the dovecot.conf file
namespace inbox { inbox = yes location = mailbox Drafts { auto = subscribe special_use = \Drafts } mailbox Sent { auto = subscribe special_use = \Sent } mailbox Trash { auto = subscribe special_use = \Trash } prefix = separator = / }
However dovecot will pickup on the other folders which lead to updating the file subscriptions located in the mailbox folder of the user
What i had to do was add the namespaces
restart the dovecot
which will (or should) create extra special folders in the default locations
from there i had to move the emails manually from the old (INBOX.INBOX.Sent - for example) to the new folders
next issue is the mail client would not allow a delete of the old folder because it is though to be special.
in the subscriptions file (this directs what is avaliable to the client) i had to manually remove the entry and also delete the (now empty) dir for the old INBOX.INBOX.Sent (again for example)
you will probably have to do this for
Sent Trash Drafts
maybe junk??
I also noted (thunderbird for exanmple) that if you are running replication this has to be done manually on all servers.
After all is said and done trying deleting a message (should goto trash)
however note (again thunderbird) you may have to set the Trash & Sent folders to the new ones (why testing with deleting a message is nessesary to make sure stuff works correctly)
Same for the Sent
Hope this helps.
Happy Monday !!! Thanks - paul
Paul Kudla
Scom.ca Internet Services http://www.scom.ca 004-1009 Byron Street South Whitby, Ontario - Canada L1N 4S3
Toronto 416.642.7266 Main 1.866.411.7266 Fax 1.888.892.7266
On 5/13/2022 3:17 PM, Darren Mobley wrote:
Sure, thanks for the reply and suggestion [Smile]
To make testing/debugging easier, rather than using a remote provider, I created another domain and email account on the same server with just a few mails. I sent 3 jibberish mails to this new account, from this new account, so they are showing in both INBOX and Sent, as well as 1 mail from root on the CLI (mail -v wah@hellodemo.ppl mailto:wah@hellodemo.ppl), These is also a draft mail saved in Drafts:
Source account file system layout:
# find /home/hellodemo/mail/hellodemo.ppl/wah/ /home/hellodemo/mail/hellodemo.ppl/wah/ /home/hellodemo/mail/hellodemo.ppl/wah/.Drafts /home/hellodemo/mail/hellodemo.ppl/wah/.Drafts/cur /home/hellodemo/mail/hellodemo.ppl/wah/.Drafts/cur/1652465670.M627726P3692.cent-7.darren.cpanel.net,S=341,W=353:2,S /home/hellodemo/mail/hellodemo.ppl/wah/.Drafts/new /home/hellodemo/mail/hellodemo.ppl/wah/.Drafts/tmp /home/hellodemo/mail/hellodemo.ppl/wah/.Drafts/dovecot.index.log /home/hellodemo/mail/hellodemo.ppl/wah/.Drafts/dovecot-uidlist /home/hellodemo/mail/hellodemo.ppl/wah/.Drafts/dovecot.index.cache /home/hellodemo/mail/hellodemo.ppl/wah/.Junk /home/hellodemo/mail/hellodemo.ppl/wah/.Junk/cur /home/hellodemo/mail/hellodemo.ppl/wah/.Junk/new /home/hellodemo/mail/hellodemo.ppl/wah/.Junk/tmp /home/hellodemo/mail/hellodemo.ppl/wah/.Junk/dovecot.index.log /home/hellodemo/mail/hellodemo.ppl/wah/.Junk/dovecot-uidlist /home/hellodemo/mail/hellodemo.ppl/wah/.Sent /home/hellodemo/mail/hellodemo.ppl/wah/.Sent/cur /home/hellodemo/mail/hellodemo.ppl/wah/.Sent/cur/1652465920.M799279P3808.cent-7.darren.cpanel.net,S=359,W=371:2,S /home/hellodemo/mail/hellodemo.ppl/wah/.Sent/cur/1652465942.M469746P3832.cent-7.darren.cpanel.net,S=342,W=354:2,S /home/hellodemo/mail/hellodemo.ppl/wah/.Sent/cur/1652465951.M751062P3906.cent-7.darren.cpanel.net,S=342,W=354:2,S /home/hellodemo/mail/hellodemo.ppl/wah/.Sent/new /home/hellodemo/mail/hellodemo.ppl/wah/.Sent/tmp /home/hellodemo/mail/hellodemo.ppl/wah/.Sent/dovecot.index.log /home/hellodemo/mail/hellodemo.ppl/wah/.Sent/dovecot-uidlist /home/hellodemo/mail/hellodemo.ppl/wah/.Sent/dovecot.index.cache /home/hellodemo/mail/hellodemo.ppl/wah/.Trash /home/hellodemo/mail/hellodemo.ppl/wah/.Trash/cur /home/hellodemo/mail/hellodemo.ppl/wah/.Trash/new /home/hellodemo/mail/hellodemo.ppl/wah/.Trash/tmp /home/hellodemo/mail/hellodemo.ppl/wah/.Trash/dovecot.index.log /home/hellodemo/mail/hellodemo.ppl/wah/.Trash/dovecot-uidlist /home/hellodemo/mail/hellodemo.ppl/wah/cur /home/hellodemo/mail/hellodemo.ppl/wah/cur/1652465917.M799363P3797.cent-7.darren.cpanel.net,S=928,W=956:2, /home/hellodemo/mail/hellodemo.ppl/wah/cur/1652465920.M628557P3797.cent-7.darren.cpanel.net,S=969,W=998:2, /home/hellodemo/mail/hellodemo.ppl/wah/cur/1652465942.M304779P3797.cent-7.darren.cpanel.net,S=952,W=981:2, /home/hellodemo/mail/hellodemo.ppl/wah/cur/1652465951.M583486P3797.cent-7.darren.cpanel.net,S=952,W=981:2, /home/hellodemo/mail/hellodemo.ppl/wah/new /home/hellodemo/mail/hellodemo.ppl/wah/tmp /home/hellodemo/mail/hellodemo.ppl/wah/maildirsize /home/hellodemo/mail/hellodemo.ppl/wah/.spam /home/hellodemo/mail/hellodemo.ppl/wah/.spam/cur /home/hellodemo/mail/hellodemo.ppl/wah/.spam/new /home/hellodemo/mail/hellodemo.ppl/wah/.spam/tmp /home/hellodemo/mail/hellodemo.ppl/wah/.spam/maildirfolder /home/hellodemo/mail/hellodemo.ppl/wah/.spam/dovecot.index.log /home/hellodemo/mail/hellodemo.ppl/wah/.spam/dovecot-uidlist /home/hellodemo/mail/hellodemo.ppl/wah/dovecot.list.index.log /home/hellodemo/mail/hellodemo.ppl/wah/dovecot.index.log /home/hellodemo/mail/hellodemo.ppl/wah/dovecot-uidvalidity /home/hellodemo/mail/hellodemo.ppl/wah/dovecot-uidlist /home/hellodemo/mail/hellodemo.ppl/wah/subscriptions /home/hellodemo/mail/hellodemo.ppl/wah/dovecot.mailbox.log /home/hellodemo/mail/hellodemo.ppl/wah/dovecot-acl-list /home/hellodemo/mail/hellodemo.ppl/wah/.Archive /home/hellodemo/mail/hellodemo.ppl/wah/.Archive/cur /home/hellodemo/mail/hellodemo.ppl/wah/.Archive/new /home/hellodemo/mail/hellodemo.ppl/wah/.Archive/tmp /home/hellodemo/mail/hellodemo.ppl/wah/.Archive/maildirfolder /home/hellodemo/mail/hellodemo.ppl/wah/.Archive/dovecot.index.log /home/hellodemo/mail/hellodemo.ppl/wah/.Archive/dovecot-uidlist /home/hellodemo/mail/hellodemo.ppl/wah/dovecot-uidvalidity.627e9e14 /home/hellodemo/mail/hellodemo.ppl/wah/dovecot-quota /home/hellodemo/mail/hellodemo.ppl/wah/dovecot.index.cache
I rm -rf'd /home/letest/mail/letest.tld/saywhatnow/ to be sure it was "clean" then ran the sync -1R command with the additional raw log option:
# /usr/bin/doveadm -Dv -o mail_fsync=never -o dsync_commit_msgs_interval=100 -o imapc_features=rfc822.size,fetch-headers -o dsync_features=empty-header-workaround -o imapc_port=143 -o imapc_host=127.0.0.1 -o imapc_password=redacted -o imapc_user=wah@hellodemo.ppl mailto:wah@hellodemo.ppl -o imapc_rawlog_dir=/tmp/raww -o mail_prefetch_count=20 sync -1Ru saywhatnow@letest.tld mailto:saywhatnow@letest.tld imapc: Debug: Loading modules from directory: /usr/lib64/dovecot/doveadm Debug: Skipping module doveadm_acl_plugin, because dlopen() failed: /usr/lib64/dovecot/doveadm/lib10_doveadm_acl_plugin.so: undefined symbol: acl_user_module (this is usually intentional, so just ignore this message) Debug: Skipping module doveadm_quota_plugin, because dlopen() failed: /usr/lib64/dovecot/doveadm/lib10_doveadm_quota_plugin.so: undefined symbol: quota_user_module (this is usually intentional, so just ignore this message) Debug: Skipping module doveadm_fts_plugin, because dlopen() failed: /usr/lib64/dovecot/doveadm/lib20_doveadm_fts_plugin.so: undefined symbol: fts_user_get_language_list (this is usually intentional, so just ignore this message) Debug: Skipping module doveadm_mail_crypt_plugin, because dlopen() failed: /usr/lib64/dovecot/doveadm/libdoveadm_mail_crypt_plugin.so: undefined symbol: mail_crypt_box_get_pvt_digests (this is usually intentional, so just ignore this message) May 13 13:28:17 Debug: Loading modules from directory: /usr/lib64/dovecot May 13 13:28:17 Debug: Module loaded: /usr/lib64/dovecot/lib10_quota_plugin.so May 13 13:28:17 Debug: Module loaded: /usr/lib64/dovecot/lib20_quota_clone_plugin.so May 13 13:28:17 Debug: Module loaded: /usr/lib64/dovecot/lib20_zlib_plugin.so May 13 13:28:17 Debug: Loading modules from directory: /usr/lib64/dovecot/doveadm May 13 13:28:17 Debug: Skipping module doveadm_acl_plugin, because dlopen() failed: /usr/lib64/dovecot/doveadm/lib10_doveadm_acl_plugin.so: undefined symbol: acl_user_module (this is usually intentional, so just ignore this message) May 13 13:28:17 Debug: Module loaded: /usr/lib64/dovecot/doveadm/lib10_doveadm_quota_plugin.so May 13 13:28:17 Debug: Skipping module doveadm_fts_plugin, because dlopen() failed: /usr/lib64/dovecot/doveadm/lib20_doveadm_fts_plugin.so: undefined symbol: fts_user_get_language_list (this is usually intentional, so just ignore this message) May 13 13:28:17 Debug: Skipping module doveadm_mail_crypt_plugin, because dlopen() failed: /usr/lib64/dovecot/doveadm/libdoveadm_mail_crypt_plugin.so: undefined symbol: mail_crypt_box_get_pvt_digests (this is usually intentional, so just ignore this message) May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: auth-master: userdb lookup(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Started userdb lookup May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: auth-master: conn unix:/var/run/dovecot/auth-userdb: Connecting May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: auth-master: conn unix:/var/run/dovecot/auth-userdb (pid=792,uid=0): Client connected (fd=10) May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: auth-master: userdb lookup(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): auth USER input: saywhatnow@letest.tld mailto:saywhatnow@letest.tld quota=maildir:Mailbox:ns=INBOX. quota_rule3=INBOX.Trash:ignore userdb_home=/home/letest/mail/letest.tld/saywhatnow userdb_quota2_grace=0 userdb_user=saywhatnow@letest.tld mailto:saywhatnow@letest.tld userdb_quota_status_overquota=552 5.2.2 Mailbox is full / Blocks limit exceeded / Inode limit exceeded quota_rule=*:messages=2147483647 mail=maildir:/home/letest/mail/letest.tld/saywhatnow:UTF-8 userdb_quota_vsizes=yes gid=1003 quota_rule2=INBOX.INBOX:ignore quota_clone_dict=file:/home/letest/mail/letest.tld/saywhatnow/dovecot-quota quota2=fs:cPanel Account userdb_gid=1003 userdb_quota_rule3=INBOX.Trash:ignore quota_vsizes=yes quota2_grace=0 quota_status_overquota=552 5.2.2 Mailbox is full / Blocks limit exceeded / Inode limit exceeded lda_mailbox_autocreate=no userdb_mail=maildir:/home/letest/mail/letest.tld/saywhatnow:UTF-8 uid=1001 password=<hidden> userdb_quota_rule2=INBOX.INBOX:ignore userdb_uid=1001 userdb_password=<hidden> userdb_lda_mailbox_autocreate=no userdb_quota_clone_dict=file:/home/letest/mail/letest.tld/saywhatnow/dovecot-quota userdb_quota=maildir:Mailbox:ns=INBOX. userdb_quota_rule=*:messages=2147483647 home=/home/letest/mail/letest.tld/saywhatnow userdb_quota2=fs:cPanel Account May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: auth-master: userdb lookup(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Finished userdb lookup (username=saywhatnow@letest.tld mailto:saywhatnow@letest.tld quota=maildir:Mailbox:ns=INBOX. quota_rule3=INBOX.Trash:ignore userdb_home=/home/letest/mail/letest.tld/saywhatnow userdb_quota2_grace=0 userdb_user=saywhatnow@letest.tld mailto:saywhatnow@letest.tld userdb_quota_status_overquota=552 5.2.2 Mailbox is full / Blocks limit exceeded / Inode limit exceeded quota_rule=*:messages=2147483647 mail=maildir:/home/letest/mail/letest.tld/saywhatnow:UTF-8 userdb_quota_vsizes=yes gid=1003 quota_rule2=INBOX.INBOX:ignore quota_clone_dict=file:/home/letest/mail/letest.tld/saywhatnow/dovecot-quota quota2=fs:cPanel Account userdb_gid=1003 userdb_quota_rule3=INBOX.Trash:ignore quota_vsizes=yes quota2_grace=0 quota_status_overquota=552 5.2.2 Mailbox is full / Blocks limit exceeded / Inode limit exceeded lda_mailbox_autocreate=no userdb_mail=maildir:/home/letest/mail/letest.tld/saywhatnow:UTF-8 uid=1001 password={CRYPT}$1$mmnope userdb_quota_rule2=INBOX.INBOX:ignore userdb_uid=1001 userdb_password={CRYPT}$1$mmnope userdb_lda_mailbox_autocreate=no userdb_quota_clone_dict=file:/home/letest/mail/letest.tld/saywhatnow/dovecot-quota userdb_quota=maildir:Mailbox:ns=INBOX. userdb_quota_rule=*:messages=2147483647 home=/home/letest/mail/letest.tld/saywhatnow userdb_quota2=fs:cPanel Account) May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/lda_mailbox_autocreate=no May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: mail=maildir:/home/letest/mail/letest.tld/saywhatnow:UTF-8 May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/password=<hidden> May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/quota=maildir:Mailbox:ns=INBOX. May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/quota2=fs:cPanel Account May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/quota2_grace=0 May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/quota_clone_dict=file:/home/letest/mail/letest.tld/saywhatnow/dovecot-quota May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/quota_rule=*:messages=2147483647 May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/quota_rule2=INBOX.INBOX:ignore May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/quota_rule3=INBOX.Trash:ignore May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/quota_status_overquota=552 5.2.2 Mailbox is full / Blocks limit exceeded / Inode limit exceeded May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/quota_vsizes=yes May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_gid=1003 May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_home=/home/letest/mail/letest.tld/saywhatnow May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_lda_mailbox_autocreate=no May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_mail=maildir:/home/letest/mail/letest.tld/saywhatnow:UTF-8 May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_password=<hidden> May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_quota=maildir:Mailbox:ns=INBOX. May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_quota2=fs:cPanel Account May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_quota2_grace=0 May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_quota_clone_dict=file:/home/letest/mail/letest.tld/saywhatnow/dovecot-quota May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_quota_rule=*:messages=2147483647 May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_quota_rule2=INBOX.INBOX:ignore May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_quota_rule3=INBOX.Trash:ignore May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_quota_status_overquota=552 5.2.2 Mailbox is full / Blocks limit exceeded / Inode limit exceeded May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_quota_vsizes=yes May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_uid=1001 May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><>: Debug: Added userdb setting: plugin/userdb_user=saywhatnow@letest.tld mailto:saywhatnow@letest.tld May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Effective uid=1001, gid=1003, home=/home/letest/mail/letest.tld/saywhatnow May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Home dir not found: /home/letest/mail/letest.tld/saywhatnow May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Quota root: name=Mailbox backend=maildir args=ns=INBOX. May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Quota rule: root=Mailbox mailbox=* bytes=0 messages=2147483647 May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Quota rule: root=Mailbox mailbox=INBOX.INBOX ignored May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Quota rule: root=Mailbox mailbox=INBOX.Trash ignored May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Quota grace: root=Mailbox bytes=0 (10%) May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Quota root: name=cPanel Account backend=fs args= May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Quota grace: root=cPanel Account bytes=0 May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: dict(file): dict created (uri=file:/home/letest/mail/letest.tld/saywhatnow/dovecot-quota, base_dir=/var/run/dovecot) May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Namespace inbox: type=private, prefix=INBOX., sep=., inbox=yes, hidden=no, list=yes, subscriptions=yes location=maildir:/home/letest/mail/letest.tld/saywhatnow:UTF-8 May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: maildir++: root=/home/letest/mail/letest.tld/saywhatnow, index=, indexpvt=, control=, inbox=/home/letest/mail/letest.tld/saywhatnow, alt= May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: Namespace : type=private, prefix=, sep=, inbox=no, hidden=yes, list=no, subscriptions=no location=fail::LAYOUT=none May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: none: root=, index=, indexpvt=, control=, inbox=, alt= May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: quota: quota_over_flag check: quota_over_script unset - skipping May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld)<4045><lwqpK0GjfmLNDwAAU3wD4Q>: Debug: quota: quota_over_flag check: quota2_over_script unset - skipping May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Namespace INBOX. has location maildir:/home/letest/mail/letest.tld/saywhatnow:UTF-8 May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Namespace INBOX.: /home/letest/mail/letest.tld/saywhatnow doesn't exist yet, using default permissions May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Namespace INBOX.: Using permissions from /home/letest/mail/letest.tld/saywhatnow: mode=0700 gid=default May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Couldn't open mailbox in list index: Mailbox not found May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Couldn't open mailbox in list index: Mailbox not found May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Couldn't open mailbox in list index: Mailbox not found May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened May 13 13:28:17 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Effective uid=1001, gid=1003, home=/home/letest/mail/letest.tld/saywhatnow May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Quota root: name=Mailbox backend=maildir args=ns=INBOX. May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Quota rule: root=Mailbox mailbox=* bytes=0 messages=2147483647 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Quota rule: root=Mailbox mailbox=INBOX.INBOX ignored May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Quota rule: root=Mailbox mailbox=INBOX.Trash ignored May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Quota grace: root=Mailbox bytes=0 (10%) May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Quota root: name=cPanel Account backend=fs args= May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Quota grace: root=cPanel Account bytes=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: dict(file): dict created (uri=file:/home/letest/mail/letest.tld/saywhatnow/dovecot-quota, base_dir=/var/run/dovecot) May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Namespace inbox: type=private, prefix=INBOX., sep=., inbox=yes, hidden=no, list=yes, subscriptions=yes location=imapc: May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Created new connection May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Looking up IP address (reconnect_ok=true, last_connect=1652466497) May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Connecting to 127.0.0.1:143 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Info: imapc(127.0.0.1:143): Connected to 127.0.0.1:143 (local 127.0.0.1:53660) May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Server capabilities: IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE NAMESPACE LITERAL+ STARTTLS AUTH=PLAIN AUTH=LOGIN May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Authenticating as wah@hellodemo.ppl mailto:wah@hellodemo.ppl May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Server capabilities: IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SNIPPET=FUZZY PREVIEW=FUZZY PREVIEW STATUS=SIZE SAVEDATE NAMESPACE LITERAL+ NOTIFY SPECIAL-USE COMPRESS=DEFLATE QUOTA May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Authenticated successfully May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: imapc: root=, index=, indexpvt=, control=, inbox=, alt= May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Namespace : type=private, prefix=, sep=, inbox=no, hidden=yes, list=no, subscriptions=no location=fail::LAYOUT=none May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: none: root=, index=, indexpvt=, control=, inbox=, alt= May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: quota: quota_over_flag check: quota_over_script unset - skipping May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: quota: quota_over_flag check: quota2_over_script unset - skipping May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Namespace INBOX. has location imapc: May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX guid=980aa92b41a37e62cd0f0000537c03e1 uid_validity=1652466497 uid_next=1 subs=no last_change=0 last_subs=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX guid=c92f64f79f0d1ed01e6d5b314f04886c uid_validity=1652465166 uid_next=5 subs=no last_change=0 last_subs=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX guid=00000000000000000000000000000000 uid_validity=0 uid_next=0 subs=no last_change=0 last_subs=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Drafts guid=004ef77f6a9c3669bcb43012f3a43855 uid_validity=1652465167 uid_next=2 subs=yes last_change=0 last_subs=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX guid=c92f64f79f0d1ed01e6d5b314f04886c uid_validity=1652465166 uid_next=5 subs=no last_change=0 last_subs=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX guid=00000000000000000000000000000000 uid_validity=0 uid_next=0 subs=no last_change=0 last_subs=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Drafts guid=004ef77f6a9c3669bcb43012f3a43855 uid_validity=1652465167 uid_next=2 subs=yes last_change=0 last_subs=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Junk guid=4849549b42c9c7de02f5e49cfa8ae258 uid_validity=1652465168 uid_next=1 subs=no last_change=0 last_subs=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Junk guid=4849549b42c9c7de02f5e49cfa8ae258 uid_validity=1652465168 uid_next=1 subs=no last_change=0 last_subs=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Sent guid=7d3c7eaa71cdf47ee8a1192687cda8cd uid_validity=1652465169 uid_next=4 subs=yes last_change=0 last_subs=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Sent guid=7d3c7eaa71cdf47ee8a1192687cda8cd uid_validity=1652465169 uid_next=4 subs=yes last_change=0 last_subs=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Trash guid=b36f688eae08506001091708006abe5a uid_validity=1652465170 uid_next=1 subs=yes last_change=0 last_subs=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Trash guid=b36f688eae08506001091708006abe5a uid_validity=1652465170 uid_next=1 subs=yes last_change=0 last_subs=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.spam guid=1ec60921a9e03a229747d8dacdb97c65 uid_validity=1652465171 uid_next=1 subs=yes last_change=0 last_subs=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.spam guid=1ec60921a9e03a229747d8dacdb97c65 uid_validity=1652465171 uid_next=1 subs=yes last_change=0 last_subs=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Archive guid=e94acd62db4233e3f7add6d6159b1d11 uid_validity=1652465172 uid_next=1 subs=yes last_change=0 last_subs=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Archive guid=e94acd62db4233e3f7add6d6159b1d11 uid_validity=1652465172 uid_next=1 subs=yes last_change=0 last_subs=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX: local=980aa92b41a37e62cd0f0000537c03e1/0/1, remote=c92f64f79f0d1ed01e6d5b314f04886c/0/1: GUIDs conflict - will be merged later May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX: local=00000000000000000000000000000000/0/0, remote=00000000000000000000000000000000/0/0: Directory rename branch not found May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Archive: local=00000000000000000000000000000000/0/0, remote=e94acd62db4233e3f7add6d6159b1d11/0/1: mailbox not selectable yet May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Drafts: local=00000000000000000000000000000000/0/0, remote=004ef77f6a9c3669bcb43012f3a43855/0/1: mailbox not selectable yet May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Junk: local=00000000000000000000000000000000/0/0, remote=4849549b42c9c7de02f5e49cfa8ae258/0/1: mailbox not selectable yet May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Sent: local=00000000000000000000000000000000/0/0, remote=7d3c7eaa71cdf47ee8a1192687cda8cd/0/1: mailbox not selectable yet May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Trash: local=00000000000000000000000000000000/0/0, remote=b36f688eae08506001091708006abe5a/0/1: mailbox not selectable yet May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.spam: local=00000000000000000000000000000000/0/0, remote=1ec60921a9e03a229747d8dacdb97c65/0/1: mailbox not selectable yet May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Rotated transaction log /home/letest/mail/letest.tld/saywhatnow/dovecot.index.log (seq=3, reset=yes) May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Namespace INBOX.: /home/letest/mail/letest.tld/saywhatnow/.INBOX.Archive doesn't exist yet, using default permissions May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Archive: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Couldn't open mailbox in list index: Refresh-flag set May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Archive: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Namespace INBOX.: /home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts doesn't exist yet, using default permissions May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Couldn't open mailbox in list index: Refresh-flag set May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Namespace INBOX.: /home/letest/mail/letest.tld/saywhatnow/.INBOX.Junk doesn't exist yet, using default permissions May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Junk: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Couldn't open mailbox in list index: Refresh-flag set May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Junk: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Namespace INBOX.: /home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent doesn't exist yet, using default permissions May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Couldn't open mailbox in list index: Refresh-flag set May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Namespace INBOX.: /home/letest/mail/letest.tld/saywhatnow/.INBOX.Trash doesn't exist yet, using default permissions May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Trash: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Couldn't open mailbox in list index: Refresh-flag set May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Trash: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Namespace INBOX.: /home/letest/mail/letest.tld/saywhatnow/.INBOX.spam doesn't exist yet, using default permissions May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.spam: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Couldn't open mailbox in list index: Refresh-flag set May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.spam: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Remote mailbox tree: INBOX guid=980aa92b41a37e62cd0f0000537c03e1 uid_validity=1652466497 uid_next=1 subs=no last_change=0 last_subs=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX: local=c92f64f79f0d1ed01e6d5b314f04886c/0/1, remote=980aa92b41a37e62cd0f0000537c03e1/0/1: GUIDs conflict - will be merged later May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX: local=00000000000000000000000000000000/0/0, remote=00000000000000000000000000000000/0/0: Directory rename branch not found May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Archive: local=e94acd62db4233e3f7add6d6159b1d11/0/1, remote=00000000000000000000000000000000/0/0: mailbox not selectable yet May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Drafts: local=004ef77f6a9c3669bcb43012f3a43855/0/1, remote=00000000000000000000000000000000/0/0: mailbox not selectable yet May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Junk: local=4849549b42c9c7de02f5e49cfa8ae258/0/1, remote=00000000000000000000000000000000/0/0: mailbox not selectable yet May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Sent: local=7d3c7eaa71cdf47ee8a1192687cda8cd/0/1, remote=00000000000000000000000000000000/0/0: mailbox not selectable yet May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Trash: local=b36f688eae08506001091708006abe5a/0/1, remote=00000000000000000000000000000000/0/0: mailbox not selectable yet May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.spam: local=1ec60921a9e03a229747d8dacdb97c65/0/1, remote=00000000000000000000000000000000/0/0: mailbox not selectable yet May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Ignore nonexistent mailbox GUID c92f64f79f0d1ed01e6d5b314f04886c with -1 sync May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: We don't have mailbox c92f64f79f0d1ed01e6d5b314f04886c May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Ignoring missing remote box GUID c92f64f79f0d1ed01e6d5b314f04886c May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Archive: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Archive: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox e94acd62db4233e3f7add6d6159b1d11 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Drafts: Last common UID=0. Delayed expunges= May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Drafts: Import change type=save GUID= UID=1 hdr_hash= result=Mail's UID is above local UIDNEXT - No more local mails found May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: UID 1: Opened mail because: access May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: import mail uid 1 guid May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Drafts: Import mail body for GUID= UID=1 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: Adding field flags to cache for the first time (uid=1) May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: saving UID 1: Opened mail because: mail stream May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: Purging (new file_seq=1652466497): creating cache May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: Purging finished, file_seq changed 0 -> 1652466497, size=0 -> 388, max_uid=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Drafts: Saved UIDs: 1 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Drafts: Finish update: min_next_uid=2 min_first_recent_uid=2 min_highest_modseq=2 min_highest_pvt_modseq=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Junk: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Junk: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox 4849549b42c9c7de02f5e49cfa8ae258 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Sent: Last common UID=0. Delayed expunges= May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Sent: Import change type=save GUID= UID=1 hdr_hash= result=Mail's UID is above local UIDNEXT - No more local mails found May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Sent: Import change type=save GUID= UID=2 hdr_hash= result=New mail May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Sent: Import change type=save GUID= UID=3 hdr_hash= result=New mail May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: UID 1: Opened mail because: access May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: UID 2: Opened mail May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: UID 3: Opened mail May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: import mail uid 1 guid May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Sent: Import mail body for GUID= UID=1 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: Adding field flags to cache for the first time (uid=1) May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: saving UID 1: Opened mail because: mail stream May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: import mail uid 2 guid May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Sent: Import mail body for GUID= UID=2 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: saving UID 2: Opened mail because: mail stream May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: import mail uid 3 guid May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Sent: Import mail body for GUID= UID=3 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: saving UID 3: Opened mail because: mail stream May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: Purging (new file_seq=1652466497): creating cache May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: Purging finished, file_seq changed 0 -> 1652466497, size=0 -> 388, max_uid=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Sent: Saved UIDs: 1:3 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Import INBOX.INBOX.Sent: Finish update: min_next_uid=4 min_first_recent_uid=1 min_highest_modseq=2 min_highest_pvt_modseq=0 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Trash: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Trash: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox b36f688eae08506001091708006abe5a May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.spam: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.spam: Mailbox opened May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox 1ec60921a9e03a229747d8dacdb97c65 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: dict(file): Waiting for dict to finish pending operations May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: dict(file): Waiting for dict to finish pending operations May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: dict(file): dict destroyed May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Disconnected May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: dict(file): Waiting for dict to finish pending operations May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: dict(file): Starting transaction May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: dict(file): Setting 'priv/quota/storage' to '1420' May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: dict(file): Setting 'priv/quota/messages' to '4' May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: dict(file): Waiting for dict to finish pending operations May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: dict(file): Dict transaction finished May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: dict(file): Waiting for dict to finish pending operations May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: dict(file): dict destroyed May 13 13:28:17 doveadm(4045): Debug: auth-master: conn unix:/var/run/dovecot/auth-userdb (pid=792,uid=0): Disconnected: Connection closed (fd=10)
This gave 2 files in /tmp/raww/ , the out file:
# cat /tmp/raww/20220513-132817.4045.1.out 1652466497.738086 1 LOGIN "wah@hellodemo.ppl mailto:wah@hellodemo.ppl" "redacted" 1652466497.747397 2 LIST "" "" 1652466497.748167 3 STATUS "INBOX" (UIDNEXT UIDVALIDITY) 1652466497.748956 4 LIST "" "*" 1652466497.749897 5 STATUS "INBOX.Archive" (UIDNEXT UIDVALIDITY) 1652466497.750201 6 STATUS "INBOX.spam" (UIDNEXT UIDVALIDITY) 1652466497.750435 7 STATUS "INBOX.Trash" (UIDNEXT UIDVALIDITY) 1652466497.750665 8 STATUS "INBOX.Sent" (UIDNEXT UIDVALIDITY) 1652466497.751762 9 STATUS "INBOX.Junk" (UIDNEXT UIDVALIDITY) 1652466497.752068 10 STATUS "INBOX.Drafts" (UIDNEXT UIDVALIDITY) 1652466497.752308 11 LSUB "" "*" 1652466497.775368 12 LIST "" "*" 1652466497.776835 13 EXAMINE "INBOX.Archive" 1652466497.778211 14 EXAMINE "INBOX.Drafts" 1652466497.779216 15 UID FETCH 1:* (FLAGS) 1652466497.781243 16 UID FETCH 1 (INTERNALDATE SAVEDATE BODY.PEEK[]) 1652466497.787228 17 EXAMINE "INBOX.Junk" 1652466497.788912 18 EXAMINE "INBOX.Sent" 1652466497.789232 19 UID FETCH 1:* (FLAGS) 1652466497.789837 20 UID FETCH 1,2,3 (INTERNALDATE SAVEDATE BODY.PEEK[]) 1652466497.792515 21 EXAMINE "INBOX.Trash" 1652466497.793893 22 EXAMINE "INBOX.spam" 1652466497.794723 23 LOGOUT
and the in file:
# cat /tmp/raww/20220513-132817.4045.1.in 1652466497.747116 1 OK [CAPABILITY IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SNIPPET=FUZZY PREVIEW=FUZZY PREVIEW STATUS=SIZE SAVEDATE NAMESPACE LITERAL+ NOTIFY SPECIAL-USE COMPRESS=DEFLATE QUOTA] Logged in 1652466497.747907 * LIST (\Noselect) "." "" 1652466497.747907 2 OK List completed (0.001 + 0.000 secs). 1652466497.748791 * STATUS INBOX (UIDNEXT 5 UIDVALIDITY 1652465166) 1652466497.748791 3 OK Status completed (0.001 + 0.000 secs). 1652466497.749533 * LIST (\HasChildren) "." INBOX 1652466497.749533 * LIST (\HasNoChildren \UnMarked \Archive) "." INBOX.Archive 1652466497.749533 * LIST (\HasNoChildren \UnMarked \Junk) "." INBOX.spam 1652466497.749533 * LIST (\HasNoChildren \UnMarked \Trash) "." INBOX.Trash 1652466497.749533 * LIST (\HasNoChildren \Sent) "." INBOX.Sent 1652466497.749533 * LIST (\HasNoChildren \UnMarked) "." INBOX.Junk 1652466497.749533 * LIST (\HasNoChildren \UnMarked \Drafts) "." INBOX.Drafts 1652466497.749533 4 OK List completed (0.001 + 0.000 secs). 1652466497.750045 * STATUS INBOX.Archive (UIDNEXT 1 UIDVALIDITY 1652465172) 1652466497.750045 5 OK Status completed (0.001 + 0.000 secs). 1652466497.750312 * STATUS INBOX.spam (UIDNEXT 1 UIDVALIDITY 1652465171) 1652466497.750312 6 OK Status completed (0.001 + 0.000 secs). 1652466497.750552 * STATUS INBOX.Trash (UIDNEXT 1 UIDVALIDITY 1652465170) 1652466497.750552 7 OK Status completed (0.001 + 0.000 secs). 1652466497.751510 * STATUS INBOX.Sent (UIDNEXT 4 UIDVALIDITY 1652465169) 1652466497.751510 8 OK Status completed (0.001 + 0.000 secs). 1652466497.751912 * STATUS INBOX.Junk (UIDNEXT 1 UIDVALIDITY 1652465168) 1652466497.751912 9 OK Status completed (0.001 + 0.000 secs). 1652466497.752208 * STATUS INBOX.Drafts (UIDNEXT 2 UIDVALIDITY 1652465167) 1652466497.752208 10 OK Status completed (0.001 + 0.000 secs). 1652466497.752600 * LSUB (\Junk) "." INBOX.spam 1652466497.752600 * LSUB (\Archive) "." INBOX.Archive 1652466497.752600 * LSUB (\Drafts) "." INBOX.Drafts 1652466497.752600 * LSUB (\Trash) "." INBOX.Trash 1652466497.752600 * LSUB (\Sent) "." INBOX.Sent 1652466497.752600 11 OK Lsub completed (0.001 + 0.000 secs). 1652466497.775980 * LIST (\HasChildren) "." INBOX 1652466497.775980 * LIST (\HasNoChildren \UnMarked \Archive) "." INBOX.Archive 1652466497.775980 * LIST (\HasNoChildren \UnMarked \Junk) "." INBOX.spam 1652466497.775980 * LIST (\HasNoChildren \UnMarked \Trash) "." INBOX.Trash 1652466497.775980 * LIST (\HasNoChildren \Marked \Sent) "." INBOX.Sent 1652466497.775980 * LIST (\HasNoChildren \UnMarked) "." INBOX.Junk 1652466497.775980 * LIST (\HasNoChildren \UnMarked \Drafts) "." INBOX.Drafts 1652466497.775980 12 OK List completed (0.001 + 0.000 secs). 1652466497.777411 * FLAGS (\Answered \Flagged \Deleted \Seen \Draft) 1652466497.777411 * OK [PERMANENTFLAGS ()] Read-only mailbox. 1652466497.777411 * 0 EXISTS 1652466497.777411 * 0 RECENT 1652466497.777411 * OK [UIDVALIDITY 1652465172] UIDs valid 1652466497.777411 * OK [UIDNEXT 1] Predicted next UID 1652466497.777411 13 OK [READ-ONLY] Examine completed (0.001 + 0.000 secs). 1652466497.779160 * OK [CLOSED] Previous mailbox closed. 1652466497.779160 * FLAGS (\Answered \Flagged \Deleted \Seen \Draft) 1652466497.779160 * OK [PERMANENTFLAGS ()] Read-only mailbox. 1652466497.779160 * 1 EXISTS 1652466497.779160 * 0 RECENT 1652466497.779160 * OK [UIDVALIDITY 1652465167] UIDs valid 1652466497.779160 * OK [UIDNEXT 2] Predicted next UID 1652466497.779160 * OK [HIGHESTMODSEQ 2] Highest 1652466497.779160 14 OK [READ-ONLY] Examine completed (0.001 + 0.000 secs). 1652466497.779851 * 1 FETCH (UID 1 FLAGS (\Seen)) 1652466497.779851 15 OK Fetch completed (0.001 + 0.000 secs). 1652466497.782233 * 1 FETCH (UID 1 INTERNALDATE "13-May-2022 13:14:30 -0500" SAVEDATE "13-May-2022 13:14:30 -0500" BODY[] {353} 1652466497.782233 MIME-Version: 1.0 1652466497.782233 Date: Fri, 13 May 2022 13:14:30 -0500 1652466497.782233 From: wah@hellodemo.ppl mailto:wah@hellodemo.ppl 1652466497.782233 To: wah@hellodemo.ppl mailto:wah@hellodemo.ppl 1652466497.782233 Subject: awdfaw 1652466497.782233 User-Agent: Roundcube Webmail/1.5.2 1652466497.782233 Message-ID:
mailto:d67b3f28d51d6810c4752b8f2ada037c@hellodemo.ppl> 1652466497.782233 X-Sender: wah@hellodemo.ppl mailto:wah@hellodemo.ppl 1652466497.782233 Content-Type: text/plain; charset=US-ASCII; 1652466497.782233 format=flowed 1652466497.782233 Content-Transfer-Encoding: 7bit 1652466497.782233 1652466497.782233 awdawd) 1652466497.782233 16 OK Fetch completed (0.001 + 0.000 secs). 1652466497.787744 * OK [CLOSED] Previous mailbox closed. 1652466497.787744 * FLAGS (\Answered \Flagged \Deleted \Seen \Draft) 1652466497.787744 * OK [PERMANENTFLAGS ()] Read-only mailbox. 1652466497.787744 * 0 EXISTS 1652466497.787744 * 0 RECENT 1652466497.787744 * OK [UIDVALIDITY 1652465168] UIDs valid 1652466497.787744 * OK [UIDNEXT 1] Predicted next UID 1652466497.787744 17 OK [READ-ONLY] Examine completed (0.001 + 0.000 secs). 1652466497.789197 * OK [CLOSED] Previous mailbox closed. 1652466497.789197 * FLAGS (\Answered \Flagged \Deleted \Seen \Draft) 1652466497.789197 * OK [PERMANENTFLAGS ()] Read-only mailbox. 1652466497.789197 * 3 EXISTS 1652466497.789197 * 3 RECENT 1652466497.789197 * OK [UIDVALIDITY 1652465169] UIDs valid 1652466497.789197 * OK [UIDNEXT 4] Predicted next UID 1652466497.789197 18 OK [READ-ONLY] Examine completed (0.001 + 0.000 secs). 1652466497.789457 * 1 FETCH (UID 1 FLAGS (\Seen \Recent)) 1652466497.789457 * 2 FETCH (UID 2 FLAGS (\Seen \Recent)) 1652466497.789457 * 3 FETCH (UID 3 FLAGS (\Seen \Recent)) 1652466497.789457 19 OK Fetch completed (0.001 + 0.000 secs). 1652466497.790590 * 1 FETCH (UID 1 INTERNALDATE "13-May-2022 13:18:40 -0500" SAVEDATE "13-May-2022 13:18:40 -0500" BODY[] {371} 1652466497.790590 MIME-Version: 1.0 1652466497.790590 Date: Fri, 13 May 2022 13:18:40 -0500 1652466497.790590 From: wah@hellodemo.ppl mailto:wah@hellodemo.ppl 1652466497.790590 To: wah@hellodemo.ppl mailto:wah@hellodemo.ppl 1652466497.790590 Subject: eswtest 1652466497.790590 User-Agent: Roundcube Webmail/1.5.2 1652466497.790590 Message-ID: mailto:adfa6752cc871c9ba5733f4e1ee1a655@hellodemo.ppl> 1652466497.790590 X-Sender: wah@hellodemo.ppl mailto:wah@hellodemo.ppl 1652466497.790590 Content-Type: text/plain; charset=US-ASCII; 1652466497.790590 format=flowed 1652466497.790590 Content-Transfer-Encoding: 7bit 1652466497.790590 1652466497.790590 wadaw dwadawdaw adw adw) 1652466497.790590 * 2 FETCH (UID 2 INTERNALDATE "13-May-2022 13:19:02 -0500" SAVEDATE "13-May-2022 13:19:02 -0500" BODY[] {354} 1652466497.790590 MIME-Version: 1.0 1652466497.790590 Date: Fri, 13 May 2022 13:19:02 -0500 1652466497.790590 From: wah@hellodemo.ppl mailto:wah@hellodemo.ppl 1652466497.790590 To: wah@hellodemo.ppl mailto:wah@hellodemo.ppl 1652466497.790590 Subject: test 1 1652466497.790590 User-Agent: Roundcube Webmail/1.5.2 1652466497.790590 Message-ID: <0a53e2acc3bff9e912b43eafa88502f4@hellodemo.ppl mailto:0a53e2acc3bff9e912b43eafa88502f4@hellodemo.ppl> 1652466497.790590 X-Sender: wah@hellodemo.ppl mailto:wah@hellodemo.ppl 1652466497.790590 Content-Type: text/plain; charset=US-ASCII; 1652466497.790590 format=flowed 1652466497.790590 Content-Transfer-Encoding: 7bit 1652466497.790590 1652466497.790590 ersert1) 1652466497.790590 * 3 FETCH (UID 3 INTERNALDATE "13-May-2022 13:19:11 -0500" SAVEDATE "13-May-2022 13:19:11 -0500" BODY[] {354} 1652466497.790590 MIME-Version: 1.0 1652466497.790590 Date: Fri, 13 May 2022 13:19:11 -0500 1652466497.790590 From: wah@hellodemo.ppl mailto:wah@hellodemo.ppl 1652466497.790590 To: wah@hellodemo.ppl mailto:wah@hellodemo.ppl 1652466497.790590 Subject: test2 1652466497.790590 User-Agent: Roundcube Webmail/1.5.2 1652466497.790590 Message-ID: <89a467688c70e06421f69a0c32cdd3cd@hellodemo.ppl mailto:89a467688c70e06421f69a0c32cdd3cd@hellodemo.ppl> 1652466497.790590 X-Sender: wah@hellodemo.ppl mailto:wah@hellodemo.ppl 1652466497.790590 Content-Type: text/plain; charset=US-ASCII; 1652466497.790590 format=flowed 1652466497.790590 Content-Transfer-Encoding: 7bit 1652466497.790590 1652466497.790590 res22222) 1652466497.790590 20 OK Fetch completed (0.001 + 0.000 secs). 1652466497.793104 * OK [CLOSED] Previous mailbox closed. 1652466497.793104 * FLAGS (\Answered \Flagged \Deleted \Seen \Draft) 1652466497.793104 * OK [PERMANENTFLAGS ()] Read-only mailbox. 1652466497.793104 * 0 EXISTS 1652466497.793104 * 0 RECENT 1652466497.793104 * OK [UIDVALIDITY 1652465170] UIDs valid 1652466497.793104 * OK [UIDNEXT 1] Predicted next UID 1652466497.793104 21 OK [READ-ONLY] Examine completed (0.001 + 0.000 secs). 1652466497.794356 * OK [CLOSED] Previous mailbox closed. 1652466497.794356 * FLAGS (\Answered \Flagged \Deleted \Seen \Draft) 1652466497.794356 * OK [PERMANENTFLAGS ()] Read-only mailbox. 1652466497.794356 * 0 EXISTS 1652466497.794356 * 0 RECENT 1652466497.794356 * OK [UIDVALIDITY 1652465171] UIDs valid 1652466497.794356 * OK [UIDNEXT 1] Predicted next UID 1652466497.794356 22 OK [READ-ONLY] Examine completed (0.001 + 0.000 secs). 1652466497.794913 * BYE Logging out 1652466497.794913 23 OK Logout completed (0.001 + 0.000 secs). And when I look at the destination account, I see that everything got imported over EXCEPT the INBOX itself:
# find /home/letest/mail/letest.tld/saywhatnow /home/letest/mail/letest.tld/saywhatnow /home/letest/mail/letest.tld/saywhatnow/dovecot.list.index.log /home/letest/mail/letest.tld/saywhatnow/cur /home/letest/mail/letest.tld/saywhatnow/new /home/letest/mail/letest.tld/saywhatnow/tmp /home/letest/mail/letest.tld/saywhatnow/dovecot.index.log /home/letest/mail/letest.tld/saywhatnow/dovecot-uidvalidity /home/letest/mail/letest.tld/saywhatnow/dovecot-uidlist /home/letest/mail/letest.tld/saywhatnow/maildirfolder /home/letest/mail/letest.tld/saywhatnow/.INBOX.Archive /home/letest/mail/letest.tld/saywhatnow/.INBOX.Archive/cur /home/letest/mail/letest.tld/saywhatnow/.INBOX.Archive/new /home/letest/mail/letest.tld/saywhatnow/.INBOX.Archive/tmp /home/letest/mail/letest.tld/saywhatnow/.INBOX.Archive/maildirfolder /home/letest/mail/letest.tld/saywhatnow/.INBOX.Archive/dovecot.index.log /home/letest/mail/letest.tld/saywhatnow/.INBOX.Archive/dovecot-uidlist /home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts /home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts/cur /home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts/cur/1652466497.M782233P4045.cent-7.darren.cpanel.net,S=341,W=353:2,S /home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts/new /home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts/tmp /home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts/maildirfolder /home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts/dovecot.index.log /home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts/dovecot-uidlist /home/letest/mail/letest.tld/saywhatnow/.INBOX.Drafts/dovecot.index.cache /home/letest/mail/letest.tld/saywhatnow/.INBOX.Junk /home/letest/mail/letest.tld/saywhatnow/.INBOX.Junk/cur /home/letest/mail/letest.tld/saywhatnow/.INBOX.Junk/new /home/letest/mail/letest.tld/saywhatnow/.INBOX.Junk/tmp /home/letest/mail/letest.tld/saywhatnow/.INBOX.Junk/maildirfolder /home/letest/mail/letest.tld/saywhatnow/.INBOX.Junk/dovecot.index.log /home/letest/mail/letest.tld/saywhatnow/.INBOX.Junk/dovecot-uidlist /home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent /home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/cur /home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/cur/1652466497.M790590P4045.cent-7.darren.cpanel.net,S=359,W=371:2,S /home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/cur/1652466497.M790591P4045.cent-7.darren.cpanel.net,S=342,W=354:2,S /home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/cur/1652466497.M790592P4045.cent-7.darren.cpanel.net,S=342,W=354:2,S /home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/new /home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/tmp /home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/maildirfolder /home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/dovecot.index.log /home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/dovecot-uidlist /home/letest/mail/letest.tld/saywhatnow/.INBOX.Sent/dovecot.index.cache /home/letest/mail/letest.tld/saywhatnow/.INBOX.Trash /home/letest/mail/letest.tld/saywhatnow/.INBOX.Trash/cur /home/letest/mail/letest.tld/saywhatnow/.INBOX.Trash/new /home/letest/mail/letest.tld/saywhatnow/.INBOX.Trash/tmp /home/letest/mail/letest.tld/saywhatnow/.INBOX.Trash/maildirfolder /home/letest/mail/letest.tld/saywhatnow/.INBOX.Trash/dovecot.index.log /home/letest/mail/letest.tld/saywhatnow/.INBOX.Trash/dovecot-uidlist /home/letest/mail/letest.tld/saywhatnow/.INBOX.spam /home/letest/mail/letest.tld/saywhatnow/.INBOX.spam/cur /home/letest/mail/letest.tld/saywhatnow/.INBOX.spam/new /home/letest/mail/letest.tld/saywhatnow/.INBOX.spam/tmp /home/letest/mail/letest.tld/saywhatnow/.INBOX.spam/maildirfolder /home/letest/mail/letest.tld/saywhatnow/.INBOX.spam/dovecot.index.log /home/letest/mail/letest.tld/saywhatnow/.INBOX.spam/dovecot-uidlist /home/letest/mail/letest.tld/saywhatnow/dovecot-uidvalidity.627ea347 /home/letest/mail/letest.tld/saywhatnow/subscriptions /home/letest/mail/letest.tld/saywhatnow/dovecot.mailbox.log /home/letest/mail/letest.tld/saywhatnow/maildirsize /home/letest/mail/letest.tld/saywhatnow/dovecot-quota
Running the same command a second time results in no changes to the destination account and the GUID issues with the inbox from my previous mail:
May 13 13:41:25 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Namespace INBOX. has location maildir:/home/letest/mail/letest.tld/saywhatnow:UTF-8 May 13 13:41:25 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened May 13 13:41:25 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened May 13 13:41:25 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.spam: Couldn't open mailbox in list index: Storage size changed 168 != 256 May 13 13:41:25 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.spam: Mailbox opened May 13 13:41:25 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Trash: Couldn't open mailbox in list index: Storage size changed 168 != 256 May 13 13:41:25 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Trash: Mailbox opened May 13 13:41:25 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Junk: Couldn't open mailbox in list index: Storage size changed 168 != 256 May 13 13:41:25 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Junk: Mailbox opened May 13 13:41:25 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Archive: Couldn't open mailbox in list index: Storage size changed 168 != 256 May 13 13:41:25 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Archive: Mailbox opened May 13 13:41:25 doveadm(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Namespace INBOX.: Using permissions from /home/letest/mail/letest.tld/saywhatnow: mode=0700 gid=default May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Effective uid=1001, gid=1003, home=/home/letest/mail/letest.tld/saywhatnow May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Quota root: name=Mailbox backend=maildir args=ns=INBOX. May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Quota rule: root=Mailbox mailbox=* bytes=0 messages=2147483647 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Quota rule: root=Mailbox mailbox=INBOX.INBOX ignored May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Quota rule: root=Mailbox mailbox=INBOX.Trash ignored May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Quota grace: root=Mailbox bytes=0 (10%) May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Quota root: name=cPanel Account backend=fs args= May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Quota grace: root=cPanel Account bytes=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: dict(file): dict created (uri=file:/home/letest/mail/letest.tld/saywhatnow/dovecot-quota, base_dir=/var/run/dovecot) May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Namespace inbox: type=private, prefix=INBOX., sep=., inbox=yes, hidden=no, list=yes, subscriptions=yes location=imapc: May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Created new connection May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Looking up IP address (reconnect_ok=true, last_connect=1652467285) May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Connecting to 127.0.0.1:143 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Info: imapc(127.0.0.1:143): Connected to 127.0.0.1:143 (local 127.0.0.1:53730) May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Server capabilities: IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE NAMESPACE LITERAL+ STARTTLS AUTH=PLAIN AUTH=LOGIN May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Authenticating as wah@hellodemo.ppl mailto:wah@hellodemo.ppl May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Server capabilities: IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SNIPPET=FUZZY PREVIEW=FUZZY PREVIEW STATUS=SIZE SAVEDATE NAMESPACE LITERAL+ NOTIFY SPECIAL-USE COMPRESS=DEFLATE QUOTA May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Authenticated successfully May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: imapc: root=, index=, indexpvt=, control=, inbox=, alt= May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Namespace : type=private, prefix=, sep=, inbox=no, hidden=yes, list=no, subscriptions=no location=fail::LAYOUT=none May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: none: root=, index=, indexpvt=, control=, inbox=, alt= May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: quota: quota_over_flag check: quota_over_script unset - skipping May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: quota: quota_over_flag check: quota2_over_script unset - skipping May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Namespace INBOX. has location imapc: May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX guid=c92f64f79f0d1ed01e6d5b314f04886c uid_validity=1652465166 uid_next=1 subs=no last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX guid=c92f64f79f0d1ed01e6d5b314f04886c uid_validity=1652465166 uid_next=5 subs=no last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX.INBOX guid=00000000000000000000000000000000 uid_validity=0 uid_next=0 subs=no last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX guid=00000000000000000000000000000000 uid_validity=0 uid_next=0 subs=no last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX.INBOX.Archive guid=e94acd62db4233e3f7add6d6159b1d11 uid_validity=1652465172 uid_next=1 subs=yes last_change=0 last_subs=1652466497 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Drafts guid=004ef77f6a9c3669bcb43012f3a43855 uid_validity=1652465167 uid_next=2 subs=yes last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX.INBOX.Drafts guid=004ef77f6a9c3669bcb43012f3a43855 uid_validity=1652465167 uid_next=2 subs=yes last_change=0 last_subs=1652466497 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Junk guid=4849549b42c9c7de02f5e49cfa8ae258 uid_validity=1652465168 uid_next=1 subs=no last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX.INBOX.Junk guid=4849549b42c9c7de02f5e49cfa8ae258 uid_validity=1652465168 uid_next=1 subs=no last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Sent guid=7d3c7eaa71cdf47ee8a1192687cda8cd uid_validity=1652465169 uid_next=4 subs=yes last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX.INBOX.Sent guid=7d3c7eaa71cdf47ee8a1192687cda8cd uid_validity=1652465169 uid_next=4 subs=yes last_change=0 last_subs=1652466497 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Trash guid=b36f688eae08506001091708006abe5a uid_validity=1652465170 uid_next=1 subs=yes last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX.INBOX.Trash guid=b36f688eae08506001091708006abe5a uid_validity=1652465170 uid_next=1 subs=yes last_change=0 last_subs=1652466497 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.spam guid=1ec60921a9e03a229747d8dacdb97c65 uid_validity=1652465171 uid_next=1 subs=yes last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX.INBOX.spam guid=1ec60921a9e03a229747d8dacdb97c65 uid_validity=1652465171 uid_next=1 subs=yes last_change=0 last_subs=1652466497 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX.Archive guid=e94acd62db4233e3f7add6d6159b1d11 uid_validity=1652465172 uid_next=1 subs=yes last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX guid=c92f64f79f0d1ed01e6d5b314f04886c uid_validity=1652465166 uid_next=5 subs=no last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX guid=00000000000000000000000000000000 uid_validity=0 uid_next=0 subs=no last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Drafts guid=004ef77f6a9c3669bcb43012f3a43855 uid_validity=1652465167 uid_next=2 subs=yes last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Junk guid=4849549b42c9c7de02f5e49cfa8ae258 uid_validity=1652465168 uid_next=1 subs=no last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Sent guid=7d3c7eaa71cdf47ee8a1192687cda8cd uid_validity=1652465169 uid_next=4 subs=yes last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Trash guid=b36f688eae08506001091708006abe5a uid_validity=1652465170 uid_next=1 subs=yes last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.spam guid=1ec60921a9e03a229747d8dacdb97c65 uid_validity=1652465171 uid_next=1 subs=yes last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Remote mailbox tree: INBOX.INBOX.Archive guid=e94acd62db4233e3f7add6d6159b1d11 uid_validity=1652465172 uid_next=1 subs=yes last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Remote mailbox tree: INBOX guid=c92f64f79f0d1ed01e6d5b314f04886c uid_validity=1652465166 uid_next=1 subs=no last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Remote mailbox tree: INBOX.INBOX guid=00000000000000000000000000000000 uid_validity=0 uid_next=0 subs=no last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Remote mailbox tree: INBOX.INBOX.Archive guid=e94acd62db4233e3f7add6d6159b1d11 uid_validity=1652465172 uid_next=1 subs=yes last_change=0 last_subs=1652466497 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Remote mailbox tree: INBOX.INBOX.Drafts guid=004ef77f6a9c3669bcb43012f3a43855 uid_validity=1652465167 uid_next=2 subs=yes last_change=0 last_subs=1652466497 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Remote mailbox tree: INBOX.INBOX.Junk guid=4849549b42c9c7de02f5e49cfa8ae258 uid_validity=1652465168 uid_next=1 subs=no last_change=0 last_subs=0 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Remote mailbox tree: INBOX.INBOX.Sent guid=7d3c7eaa71cdf47ee8a1192687cda8cd uid_validity=1652465169 uid_next=4 subs=yes last_change=0 last_subs=1652466497 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Remote mailbox tree: INBOX.INBOX.Trash guid=b36f688eae08506001091708006abe5a uid_validity=1652465170 uid_next=1 subs=yes last_change=0 last_subs=1652466497 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Remote mailbox tree: INBOX.INBOX.spam guid=1ec60921a9e03a229747d8dacdb97c65 uid_validity=1652465171 uid_next=1 subs=yes last_change=0 last_subs=1652466497 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX: local=c92f64f79f0d1ed01e6d5b314f04886c/0/1, remote=c92f64f79f0d1ed01e6d5b314f04886c/0/1: Mailboxes are equal May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX: local=00000000000000000000000000000000/0/0, remote=00000000000000000000000000000000/0/0: Directory name paths are equal May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Archive: local=e94acd62db4233e3f7add6d6159b1d11/0/1, remote=e94acd62db4233e3f7add6d6159b1d11/0/1: Mailboxes are equal May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Drafts: local=004ef77f6a9c3669bcb43012f3a43855/0/1, remote=004ef77f6a9c3669bcb43012f3a43855/0/1: Mailboxes are equal May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Junk: local=4849549b42c9c7de02f5e49cfa8ae258/0/1, remote=4849549b42c9c7de02f5e49cfa8ae258/0/1: Mailboxes are equal May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Sent: local=7d3c7eaa71cdf47ee8a1192687cda8cd/0/1, remote=7d3c7eaa71cdf47ee8a1192687cda8cd/0/1: Mailboxes are equal May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.Trash: local=b36f688eae08506001091708006abe5a/0/1, remote=b36f688eae08506001091708006abe5a/0/1: Mailboxes are equal May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Mailbox INBOX.INBOX.spam: local=1ec60921a9e03a229747d8dacdb97c65/0/1, remote=1ec60921a9e03a229747d8dacdb97c65/0/1: Mailboxes are equal May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX: local=c92f64f79f0d1ed01e6d5b314f04886c/0/1, remote=c92f64f79f0d1ed01e6d5b314f04886c/0/1: Mailboxes are equal May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX: local=00000000000000000000000000000000/0/0, remote=00000000000000000000000000000000/0/0: Directory name paths are equal May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Archive: local=e94acd62db4233e3f7add6d6159b1d11/0/1, remote=e94acd62db4233e3f7add6d6159b1d11/0/1: Mailboxes are equal May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Drafts: local=004ef77f6a9c3669bcb43012f3a43855/0/1, remote=004ef77f6a9c3669bcb43012f3a43855/0/1: Mailboxes are equal May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Junk: local=4849549b42c9c7de02f5e49cfa8ae258/0/1, remote=4849549b42c9c7de02f5e49cfa8ae258/0/1: Mailboxes are equal May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Sent: local=7d3c7eaa71cdf47ee8a1192687cda8cd/0/1, remote=7d3c7eaa71cdf47ee8a1192687cda8cd/0/1: Mailboxes are equal May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.Trash: local=b36f688eae08506001091708006abe5a/0/1, remote=b36f688eae08506001091708006abe5a/0/1: Mailboxes are equal May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Mailbox INBOX.INBOX.spam: local=1ec60921a9e03a229747d8dacdb97c65/0/1, remote=1ec60921a9e03a229747d8dacdb97c65/0/1: Mailboxes are equal May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Ignore nonexistent mailbox GUID c92f64f79f0d1ed01e6d5b314f04886c with -1 sync May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: We don't have mailbox c92f64f79f0d1ed01e6d5b314f04886c May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Ignoring missing remote box GUID c92f64f79f0d1ed01e6d5b314f04886c May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Archive: Mailbox opened May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Archive: Mailbox opened May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox e94acd62db4233e3f7add6d6159b1d11 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: Mailbox opened May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: Mailbox opened May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox 004ef77f6a9c3669bcb43012f3a43855 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Junk: Mailbox opened May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Junk: Mailbox opened May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox 4849549b42c9c7de02f5e49cfa8ae258 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: Mailbox opened May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Sent: Mailbox opened May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox 7d3c7eaa71cdf47ee8a1192687cda8cd May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Trash: Mailbox opened May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Trash: Mailbox opened May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox b36f688eae08506001091708006abe5a May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.spam: Mailbox opened May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.spam: Mailbox opened May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox 1ec60921a9e03a229747d8dacdb97c65 May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: dict(file): Waiting for dict to finish pending operations May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: dict(file): Waiting for dict to finish pending operations May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: dict(file): dict destroyed May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: imapc(127.0.0.1:143): Disconnected May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: dict(file): Waiting for dict to finish pending operations May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: dict(file): Waiting for dict to finish pending operations May 13 13:41:25 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: dict(file): dict destroyed May 13 13:41:25 doveadm(4355): Debug: auth-master: conn unix:/var/run/dovecot/auth-userdb (pid=792,uid=0): Disconnected: Connection closed (fd=10)
It may not be relevant, but here's the source dovecot-uidlist : # cat /home/hellodemo/mail/hellodemo.ppl/wah/dovecot-uidlist 3 V1652465166 N1 Gd31223010e9e7e62410d0000537c03e1 1 :1652465917.M799363P3797.cent-7.darren.cpanel.net,S=928,W=956 2 :1652465920.M628557P3797.cent-7.darren.cpanel.net,S=969,W=998 3 :1652465942.M304779P3797.cent-7.darren.cpanel.net,S=952,W=981 4 :1652465951.M583486P3797.cent-7.darren.cpanel.net,S=952,W=981
and destination one: # cat /home/letest/mail/letest.tld/saywhatnow/dovecot-uidlist 3 V1652465166 N1 Gc92f64f79f0d1ed01e6d5b314f04886c
Looking at the raw IMAPC logs, the main stinker I see is that output of LSUB doesn't show the INBOX, and was then skipped from the EXAMINE lines after it:
11 LSUB "" "*"
- LSUB (\Junk) "." INBOX.spam
- LSUB (\Archive) "." INBOX.Archive
- LSUB (\Drafts) "." INBOX.Drafts
- LSUB (\Trash) "." INBOX.Trash
- LSUB (\Sent) "." INBOX.Sent
However just now I manually subscribed to that folder..
14 subscribe INBOX 14 OK Subscribe completed (0.012 + 0.000 + 0.011 secs). 15 LSUB "" "*"
- LSUB () "." INBOX
- LSUB (\Junk) "." INBOX.spam
- LSUB (\Archive) "." INBOX.Archive
- LSUB (\Drafts) "." INBOX.Drafts
- LSUB (\Trash) "." INBOX.Trash
- LSUB (\Sent) "." INBOX.Sent 15 OK Lsub completed (0.001 + 0.000 secs). 16 logout
..and re-ran the above dovecot sync command, and still didn't get new mail, with the same error about GUID not existing.
Now INBOX itself is reflected in the raw in log:
1652468207.459766 10 OK Status completed (0.001 + 0.000 secs). 1652468207.460004 * LSUB () "." INBOX 1652468207.460004 * LSUB (\Junk) "." INBOX.spam 1652468207.460004 * LSUB (\Archive) "." INBOX.Archive 1652468207.460004 * LSUB (\Drafts) "." INBOX.Drafts 1652468207.460004 * LSUB (\Trash) "." INBOX.Trash 1652468207.460004 * LSUB (\Sent) "." INBOX.Sent 1652468207.460004 11 OK Lsub completed (0.001 + 0.000 secs). 1652468207.461635 * LIST (\HasChildren) "." INBOX 1652468207.461635 * LIST (\HasNoChildren \UnMarked \Archive) "." INBOX.Archive 1652468207.461635 * LIST (\HasNoChildren \UnMarked \Junk) "." INBOX.spam 1652468207.461635 * LIST (\HasNoChildren \UnMarked \Trash) "." INBOX.Trash 1652468207.461635 * LIST (\HasNoChildren \Marked \Sent) "." INBOX.Sent 1652468207.461635 * LIST (\HasNoChildren \UnMarked) "." INBOX.Junk 1652468207.461635 * LIST (\HasNoChildren \UnMarked \Drafts) "." INBOX.Drafts 1652468207.461635 12 OK List completed (0.001 + 0.000 secs).
However the raw out log doesn't show it EXAMINE'ing the INBOX itself, just the .folders : 1652468207.459810 11 LSUB "" "*" 1652468207.461358 12 LIST "" "*" 1652468207.462263 13 EXAMINE "INBOX.Archive" 1652468207.463239 14 EXAMINE "INBOX.Drafts" 1652468207.464101 15 UID FETCH 1:* (FLAGS) 1652468207.465088 16 EXAMINE "INBOX.Junk" 1652468207.465931 17 EXAMINE "INBOX.Sent" 1652468207.466437 18 UID FETCH 1:* (FLAGS) 1652468207.467218 19 EXAMINE "INBOX.Trash" 1652468207.468146 20 EXAMINE "INBOX.spam" 1652468207.468796 21 LOGOUT
My best guess at this point is the logs showing "INBOX" and "INBOX.INBOX" , perhaps there's something about the naming scheme that is throwing it off, but the "INBOX.INBOX.Drafts" and such are still being handled.
Thanks again for any direction! Darren
---- On Fri, 13 May 2022 08:57:22 -0500 *Sami Ketola sami@ketola.io* wrote ----
On 11. May 2022, at 1.17, Darren Mobley <decker@n3t.net <mailto:decker@n3t.net>> wrote: Greetings! I've been trying to sync my email to a server, however it only syncs the mail in folders other than INBOX. For testing purposes, I've created a fake domain, "letest.tld" and a new empty user account "saywhatnow@letest.tld <mailto:saywhatnow@letest.tld>" to receive the copy of the mail being migrated. What I've been trying are iterations of: /usr/bin/doveadm -D -o mail_fsync=never -o dsync_features=empty-header-workaround -o imapc_ssl=imaps -o imapc_features=rfc822.size,fetch-headers -o dsync_commit_msgs_interval=100 -o imapc_port=993 -o imapc_host=imap.zoho.com <http://imap.zoho.com/> -o imapc_password=NoNoTRe4LLyMyP4$$ -o imapc_user=decker@n3t.net <mailto:decker@n3t.net> -o mail_prefetch_count=20 sync -1Ru saywhatnow@letest.tld <mailto:saywhatnow@letest.tld> imapc: can you record imapc rawlogs to check what the remote responds for some imap commands: doveadm -o <your_imapc_options...> -o imapc_rawlog_dir=/writeable_directory backup -u saywhatnow@letest.tld <mailto:saywhatnow@letest.tld> -R imapc: Then check the saved rawlogs for hints if the remote even lists all subfolders in response. Sami
-- This message has been scanned for viruses and dangerous content by *MailScanner* http://www.mailscanner.info/, and is believed to be clean.
On 13. May 2022, at 22.17, Darren Mobley decker@n3t.net wrote: May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX guid=980aa92b41a37e62cd0f0000537c03e1 uid_validity=1652466497 May 13 13:28:17 dsync(saywhatnow@letest.tld mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX guid=00000000000000000000000000000000 uid_validity=0
So your remote has INBOX and INBOX.INBOX. This is quite special case for imapc connector and cannot be solved easily. I did hit this once at a customer when I was doing migrations for them. This was few years a go and unfortunately I cannot remember how the problem was solved. I remember that it required TWO separate dsync runs to migrate INBOX separately and remaining folders in another run. I wrote a workaround to the migration framework to monitor the migration logs and then apply workarounds if end user and this strange INBOX.INBOX setup.
Unfortunately that is all I can remember about it and I've since left Open Xchange and do not have an access to my old migration toolkit bits and command line documentations.
Sami
Thanks for the replies, Paul and Sami !
So if I understand correctly, because the local server has the following config:
prefix = INBOX.
separator = .
doveadm-sync is reading the INBOX as INBOX.INBOX
1 OK [CAPABILITY IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SNIPPET=FUZZY PREVIEW=FUZZY PREVIEW STATUS=SIZE SAVEDATE NAMESPACE LITERAL+ NOTIFY SPECIAL-USE COMPRESS=DEFLATE QUOTA] Logged in
2 list "" "*"
LIST (\HasChildren) "." INBOX
LIST (\HasNoChildren \UnMarked \Junk) "." INBOX.spam
LIST (\HasNoChildren \UnMarked \Sent) "." INBOX.Sent
LIST (\HasNoChildren \UnMarked) "." "INBOX.Travel Deals"
LIST (\HasNoChildren \UnMarked) "." INBOX.Templates
LIST (\HasNoChildren \UnMarked) "." INBOX.Spam
LIST (\HasNoChildren \UnMarked) "." INBOX.Queue
LIST (\HasChildren \UnMarked) "." INBOX.Mailspring
LIST (\HasNoChildren \UnMarked) "." INBOX.Mailspring.Snoozed
LIST (\HasNoChildren \UnMarked) "." "INBOX.Commercial Spam"
LIST (\HasNoChildren \UnMarked \Archive) "." INBOX.Archive
LIST (\HasNoChildren \UnMarked \Trash) "." INBOX.Trash
LIST (\HasNoChildren \UnMarked \Drafts) "." INBOX.Drafts
2 OK List completed (0.002 + 0.000 + 0.001 secs).
3 logout
- BYE Logging out
3 OK Logout completed (0.001 + 0.000 secs).
So adding "-o imapc_list_prefix=INBOX" to the doveadm command line should fix that, I would think ?
When I tested, the version without the new args:
May 17 16:18:39 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 17 16:18:39 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Ignore nonexistent mailbox GUID c92f64f79f0d1ed01e6d5b314f04886c with -1 sync
May 17 16:18:39 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: We don't have mailbox c92f64f79f0d1ed01e6d5b314f04886c
May 17 16:18:39 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Ignoring missing remote box GUID c92f64f79f0d1ed01e6d5b314f04886c
May 17 16:18:39 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.Archive: Mailbox opened
May 17 16:18:39 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Archive: Mailbox opened
May 17 16:18:39 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox e94acd62db4233e3f7add6d6159b1d11
May 17 16:18:39 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.Drafts: Mailbox opened
May 17 16:18:39 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Drafts: Mailbox opened
May 17 16:18:39 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox 004ef77f6a9c3669bcb43012f3a43855
May 17 16:18:39 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Junk: Mailbox opened
May 17 16:18:39 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Junk: Mailbox opened
May 17 16:18:39 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox 4849549b42c9c7de02f5e49cfa8ae258
versus with the new args:
May 17 16:19:33 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX: Mailbox opened
May 17 16:19:33 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Ignore nonexistent mailbox GUID c92f64f79f0d1ed01e6d5b314f04886c with -1 sync
May 17 16:19:33 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: We don't have mailbox c92f64f79f0d1ed01e6d5b314f04886c
May 17 16:19:33 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Ignoring missing remote box GUID c92f64f79f0d1ed01e6d5b314f04886c
May 17 16:19:33 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.Archive: Mailbox opened
May 17 16:19:33 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.Archive: Mailbox opened
May 17 16:19:33 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox e94acd62db4233e3f7add6d6159b1d11
May 17 16:19:33 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.Drafts: Mailbox opened
May 17 16:19:33 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.Drafts: Mailbox opened
May 17 16:19:33 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox 004ef77f6a9c3669bcb43012f3a43855
May 17 16:19:33 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.INBOX.Junk: Mailbox opened
May 17 16:19:33 dsync(mailto:saywhatnow@letest.tld): Debug: Mailbox INBOX.Junk: Mailbox opened
May 17 16:19:33 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Skipping unchanged mailbox 4849549b42c9c7de02f5e49cfa8ae258
So it does seem to have an affect, but the INBOX is still not populated.
Since I can't change the config on these servers, and I'm running out of time, I'll probably just do something like imapsync to get the migrations going.
I appreciate the help! Thanks, Darren
---- On Tue, 17 May 2022 10:01:39 -0500 Sami Ketola sami@ketola.io wrote ----
On 13. May 2022, at 22.17, Darren Mobley mailto:decker@n3t.net wrote:
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain M: Local mailbox tree: INBOX guid=980aa92b41a37e62cd0f0000537c03e1 uid_validity=1652466497
May 13 13:28:17 dsync(mailto:saywhatnow@letest.tld): Debug: brain S: Local mailbox tree: INBOX.INBOX guid=00000000000000000000000000000000 uid_validity=0
So your remote has INBOX and INBOX.INBOX. This is quite special case for imapc connector and cannot be solved easily. I did hit this once at a customer when I was doing migrations for them.
This was few years a go and unfortunately I cannot remember how the problem was solved. I remember that it required TWO separate dsync runs to migrate INBOX separately and remaining folders in another run.
I wrote a workaround to the migration framework to monitor the migration logs and then apply workarounds if end user and this strange INBOX.INBOX setup.
Unfortunately that is all I can remember about it and I've since left Open Xchange and do not have an access to my old migration toolkit bits and command line documentations.
Sami
participants (3)
-
Darren Mobley
-
Paul Kudla (SCOM.CA Internet Services Inc.)
-
Sami Ketola