Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Old mails deleted on other clients still show up as unread in Mail, when opened "Not found" #8223

Open
jancborchardt opened this issue Mar 14, 2023 · 130 comments · Fixed by #8575 or #8968
Assignees
Labels
3. to review bug feature:mailbox-management skill:backend Issues and PRs that require backend development skills

Comments

@jancborchardt
Copy link
Member

Steps to reproduce

  1. Use Mail a bunch as your main Mail app
  2. Also use another mail client e.g. something on mobile
  3. At some point see outdated mails in Mail, even indicated as unread

Expected behavior

No non-existent mails should show up in Mail, especially not indicated as unread. If the preview line can not be fetched, maybe it’s better to not show it in the message list to begin with? (It could still be loaded in later if the mail is retrieved.)

Actual behavior

The 3 mails of upgrade, activity, and invitation are actually deleted. They show up in the list without preview text line, and indicated as unread. When opening, they show "Not found":
image

Mail app version

Current on cloud.nc.com

Mailserver or service

No response

Operating system

No response

PHP engine version

None

Web server

None

Database

None

Additional info

No response

@jancborchardt jancborchardt added bug 1. to develop feature:mailbox-management skill:frontend Issues and PRs that require JavaScript/Vue/styling development skills labels Mar 14, 2023
@jancborchardt
Copy link
Member Author

FYI this might be related to #3049 but that issue seems broader, is old already and the discussion is too heated.

@LordSandwurm
Copy link

I have the same problem here. Running nextcloud 25.0.4 and mail app version 2.2.4

@yankees5963
Copy link

Same issue NC 26.0.0 Mail Version 3.0.2. Docker install using MYSQL backend.

@reno3131
Copy link

reno3131 commented Apr 6, 2023

Here are some info from horde.log

Good email beeing fetched :

Thu, 06 Apr 2023 09:20:00 +0000
>> Connection to: imap://mail.REDACTED.TLD/
>> Server connection took 0.0018 seconds.
S: * OK [CAPABILITY IMAP4rev1 LITERAL+ SASL-IR LOGIN-REFERRALS ID ENABLE IDLE STARTTLS LOGINDISABLED] Dovecot ready.
C: 1 STARTTLS
S: 1 OK Begin TLS negotiation now.
>> Command 1 took 0.0005 seconds.
>> Successfully completed TLS negotiation.
C: 2 CAPABILITY
S: * CAPABILITY IMAP4rev1 LITERAL+ SASL-IR LOGIN-REFERRALS ID ENABLE IDLE AUTH=PLAIN AUTH=LOGIN
S: 2 OK Pre-login capabilities listed, post-login capabilities have more.
>> Command 2 took 0.0005 seconds.
C: 3 AUTHENTICATE PLAIN [INITIAL CLIENT RESPONSE (username: [email protected])]
S: * FLAGS (\Answered \Flagged \Deleted \Seen \Draft $MDNSent $Forwarded $label1)
S: * OK [PERMANENTFLAGS ()] Read-only mailbox.
S: * 16104 EXISTS
S: * 0 RECENT
S: * OK [UNSEEN 7781] First unseen.
S: * OK [UIDVALIDITY 1357574186] UIDs valid
S: * OK [UIDNEXT 29936] Predicted next UID
S: * OK [HIGHESTMODSEQ 56757] Highest
S: 5 OK [READ-ONLY] Examine completed (0.000 + 0.000 secs).
>> Command 5 took 0.0449 seconds.
>> CACHE: Retrieved messages (HICenv,HICflags,HICdate,HICdg [INBOX; 29921])
C: 6 UID FETCH 29921 (BODY.PEEK[HEADER])
S: 3 OK [CAPABILITY IMAP4rev1 LITERAL+ 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 NOTIFY SPECIAL-USE QUOTA ACL RIGHTS=texk] Logged in
>> Command 3 took 0.006 seconds.
>> CACHE: Using the OCA\Mail\Cache\Cache storage driver.
C: 4 ENABLE QRESYNC
C: 5 EXAMINE INBOX (QRESYNC (1357574186 56757 29885:29900,29906:29918,29921,29923,29926:29930,29933:29934))
S: * ENABLED QRESYNC
S: 4 OK Enabled (0.000 + 0.000 secs).
>> Command 4 took 0.0006 seconds.
S: * 16096 FETCH (UID 29921 BODY[HEADER] {1993}
S: [LITERAL DATA: 1993 bytes]
S: )
S: 6 OK Fetch completed (0.042 + 0.000 + 0.041 secs).
>> Command 6 took 0.0426 seconds.
>> CACHE: Retrieved messages (HICenv,HICflags,HICdate,HICsize,HICstruct,HICdg [INBOX; 29921])
C: 7 UID FETCH 29921 (BODY.PEEK[HEADER])
S: * 16096 FETCH (UID 29921 BODY[HEADER] {1993}
S: [LITERAL DATA: 1993 bytes]
S: )
S: 7 OK Fetch completed (0.001 + 0.000 secs).
>> Command 7 took 0.0011 seconds.
C: 8 UID FETCH 29921 (BODY.PEEK[1] BINARY.SIZE[1] BODY.PEEK[1.MIME])
S: * 16096 FETCH (UID 29921 BODY[1] {530}
S: [LITERAL DATA: 530 bytes]
S:  BINARY.SIZE[1] 482 BODY[1.MIME] {88}
S: [LITERAL DATA: 88 bytes]
S: )
S: 8 OK Fetch completed (0.001 + 0.000 secs).
>> Command 8 took 0.001 seconds.
S: * FLAGS (\Answered \Flagged \Deleted \Seen \Draft $MDNSent $Forwarded $label1)
S: * OK [PERMANENTFLAGS ()] Read-only mailbox.
S: * 16104 EXISTS
S: * 0 RECENT
S: * OK [UNSEEN 7781] First unseen.
S: * OK [UIDVALIDITY 1357574186] UIDs valid
C: 9 UID FETCH 29921 (BODY.PEEK[2] BINARY.SIZE[2] BODY.PEEK[2.MIME])
S: * OK [UIDNEXT 29936] Predicted next UID
S: * OK [HIGHESTMODSEQ 56757] Highest
S: 5 OK [READ-ONLY] Examine completed (0.000 + 0.000 secs).
>> Command 5 took 0.0435 seconds.
S: * 16096 FETCH (UID 29921 BODY[2] {21631}
>> CACHE: Retrieved messages (HICenv,HICflags,HICdate,HICdg [INBOX; 29921])
C: 6 UID FETCH 29921 (BODY.PEEK[HEADER])
S: [LITERAL DATA: 21631 bytes]
S:  BINARY.SIZE[2] 19572 BODY[2.MIME] {87}
S: [LITERAL DATA: 87 bytes]
S: )
S: 9 OK Fetch completed (0.001 + 0.000 secs).
>> Command 9 took 0.0018 seconds.
C: 10 LOGOUT
S: * BYE Logging out
S: 10 OK Logout completed (0.000 + 0.000 secs).
>> Command 10 took 0.0007 seconds.
S: * 16096 FETCH (UID 29921 BODY[HEADER] {1993}
S: [LITERAL DATA: 1993 bytes]
S: )
S: 6 OK Fetch completed (0.042 + 0.000 + 0.041 secs).
>> Command 6 took 0.0421 seconds.
>> CACHE: Retrieved messages (HICenv,HICflags,HICdate,HICsize,HICstruct,HICdg [INBOX; 29921])
C: 7 UID FETCH 29921 (BODY.PEEK[HEADER])
S: * 16096 FETCH (UID 29921 BODY[HEADER] {1993}
S: [LITERAL DATA: 1993 bytes]
S: )
S: 7 OK Fetch completed (0.001 + 0.000 secs).
>> Command 7 took 0.0011 seconds.
C: 8 UID FETCH 29921 (BODY.PEEK[1] BINARY.SIZE[1] BODY.PEEK[1.MIME])
S: * 16096 FETCH (UID 29921 BODY[1] {530}
S: [LITERAL DATA: 530 bytes]
S:  BINARY.SIZE[1] 482 BODY[1.MIME] {88}
S: [LITERAL DATA: 88 bytes]
S: )
S: 8 OK Fetch completed (0.001 + 0.000 secs).
>> Command 8 took 0.0009 seconds.
C: 9 UID FETCH 29921 (BODY.PEEK[2] BINARY.SIZE[2] BODY.PEEK[2.MIME])
S: * 16096 FETCH (UID 29921 BODY[2] {21631}
S: [LITERAL DATA: 21631 bytes]
S:  BINARY.SIZE[2] 19572 BODY[2.MIME] {87}
S: [LITERAL DATA: 87 bytes]
S: )
S: 9 OK Fetch completed (0.001 + 0.000 secs).
>> Command 9 took 0.0019 seconds.
C: 10 LOGOUT
S: * BYE Logging out
S: 10 OK Logout completed (0.000 + 0.000 secs).
>> Command 10 took 0.0009 seconds.

Mail moved by another client on the IMAP server (unseen) :

------------------------------
>> Thu, 06 Apr 2023 09:24:09 +0000
>> Connection to: imap://mail.REDACTED.TLD/
>> Server connection took 0.0016 seconds.
S: * OK [CAPABILITY IMAP4rev1 LITERAL+ SASL-IR LOGIN-REFERRALS ID ENABLE IDLE STARTTLS LOGINDISABLED] Dovecot ready.
C: 1 STARTTLS
S: 1 OK Begin TLS negotiation now.
>> Command 1 took 0.0004 seconds.
>> Successfully completed TLS negotiation.
C: 2 CAPABILITY
S: * CAPABILITY IMAP4rev1 LITERAL+ SASL-IR LOGIN-REFERRALS ID ENABLE IDLE AUTH=PLAIN AUTH=LOGIN
S: 2 OK Pre-login capabilities listed, post-login capabilities have more.
>> Command 2 took 0.0005 seconds.
C: 3 AUTHENTICATE PLAIN [INITIAL CLIENT RESPONSE (username: [email protected])]
S: 3 OK [CAPABILITY IMAP4rev1 LITERAL+ 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 NOTIFY SPECIAL-USE QUOTA ACL RIGHTS=texk] Logged in
>> Command 3 took 0.0062 seconds.
>> CACHE: Using the OCA\Mail\Cache\Cache storage driver.
C: 4 ENABLE QRESYNC
C: 5 EXAMINE INBOX (QRESYNC (1357574186 56757 29885:29900,29906:29918,29921,29923,29926:29930,29933:29934))
S: * ENABLED QRESYNC
S: 4 OK Enabled (0.000 + 0.000 secs).
>> Command 4 took 0.0006 seconds.
S: * FLAGS (\Answered \Flagged \Deleted \Seen \Draft $MDNSent $Forwarded $label1)
S: * OK [PERMANENTFLAGS ()] Read-only mailbox.
S: * 16104 EXISTS
S: * 0 RECENT
S: * OK [UNSEEN 7781] First unseen.
S: * OK [UIDVALIDITY 1357574186] UIDs valid
S: * OK [UIDNEXT 29936] Predicted next UID
S: * OK [HIGHESTMODSEQ 56757] Highest
S: 5 OK [READ-ONLY] Examine completed (0.000 + 0.000 secs).
>> Command 5 took 0.044 seconds.
C: 6 UID FETCH 29920 (ENVELOPE FLAGS INTERNALDATE BODY.PEEK[HEADER])
S: 6 OK Fetch completed (0.001 + 0.000 secs).
>> Command 6 took 0.0007 seconds.
C: 7 LOGOUT
S: * BYE Logging out
S: 7 OK Logout completed (0.000 + 0.000 secs).
>> Command 7 took 0.0006 seconds.

There the mail is showing as describe in the initial post.

Mail moved by another client on the IMAP server (seen) :

------------------------------
>> Thu, 06 Apr 2023 09:30:19 +0000
>> Connection to: imap://mail.REDACTED.TLD/
>> Server connection took 0.0012 seconds.
S: * OK [CAPABILITY IMAP4rev1 LITERAL+ SASL-IR LOGIN-REFERRALS ID ENABLE IDLE STARTTLS LOGINDISABLED] Dovecot ready.
C: 1 STARTTLS
S: 1 OK Begin TLS negotiation now.
>> Command 1 took 0.0004 seconds.
>> Successfully completed TLS negotiation.
C: 2 CAPABILITY
S: * CAPABILITY IMAP4rev1 LITERAL+ SASL-IR LOGIN-REFERRALS ID ENABLE IDLE AUTH=PLAIN AUTH=LOGIN
S: 2 OK Pre-login capabilities listed, post-login capabilities have more.
>> Command 2 took 0.0005 seconds.
C: 3 AUTHENTICATE PLAIN [INITIAL CLIENT RESPONSE (username: [email protected])]
S: 3 OK [CAPABILITY IMAP4rev1 LITERAL+ 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 NOTIFY SPECIAL-USE QUOTA ACL RIGHTS=texk] Logged in
>> Command 3 took 0.0072 seconds.
>> CACHE: Using the OCA\Mail\Cache\Cache storage driver.
C: 4 ENABLE QRESYNC
C: 5 EXAMINE INBOX (QRESYNC (1357574186 56757 29885:29900,29906:29918,29921,29923,29926:29930,29933:29934))
S: * ENABLED QRESYNC
S: 4 OK Enabled (0.000 + 0.000 secs).
>> Command 4 took 0.0006 seconds.
S: * FLAGS (\Answered \Flagged \Deleted \Seen \Draft $MDNSent $Forwarded $label1)
S: * OK [PERMANENTFLAGS ()] Read-only mailbox.
S: * 16104 EXISTS
S: * 0 RECENT
S: * OK [UNSEEN 7781] First unseen.
S: * OK [UIDVALIDITY 1357574186] UIDs valid
S: * OK [UIDNEXT 29936] Predicted next UID
S: * OK [HIGHESTMODSEQ 56757] Highest
S: 5 OK [READ-ONLY] Examine completed (0.000 + 0.000 secs).
>> Command 5 took 0.0429 seconds.
C: 6 UID FETCH 29920 (ENVELOPE FLAGS INTERNALDATE BODY.PEEK[HEADER])
S: 6 OK Fetch completed (0.001 + 0.000 secs).
>> Command 6 took 0.0007 seconds.
C: 7 LOGOUT
S: * BYE Logging out
S: 7 OK Logout completed (0.000 + 0.000 secs).
>> Command 7 took 0.0006 seconds.

Message List

------------------------------
>> Thu, 06 Apr 2023 09:32:13 +0000
>> Connection to: imap://mail.REDACTED.TLD/
>> Server connection took 0.0015 seconds.
S: * OK [CAPABILITY IMAP4rev1 LITERAL+ SASL-IR LOGIN-REFERRALS ID ENABLE IDLE STARTTLS LOGINDISABLED] Dovecot ready.
C: 1 STARTTLS
S: 1 OK Begin TLS negotiation now.
>> Command 1 took 0.0003 seconds.
>> Successfully completed TLS negotiation.
C: 2 CAPABILITY
S: * CAPABILITY IMAP4rev1 LITERAL+ SASL-IR LOGIN-REFERRALS ID ENABLE IDLE AUTH=PLAIN AUTH=LOGIN
S: 2 OK Pre-login capabilities listed, post-login capabilities have more.
>> Command 2 took 0.0006 seconds.
C: 3 AUTHENTICATE PLAIN [INITIAL CLIENT RESPONSE (username: [email protected])]
S: 3 OK [CAPABILITY IMAP4rev1 LITERAL+ 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 NOTIFY SPECIAL-USE QUOTA ACL RIGHTS=texk] Logged in
>> Command 3 took 0.006 seconds.
>> CACHE: Using the OCA\Mail\Cache\Cache storage driver.
C: 4 ENABLE QRESYNC
C: 5 STATUS INBOX (MESSAGES RECENT UIDNEXT UIDVALIDITY UNSEEN)
S: * ENABLED QRESYNC
S: 4 OK Enabled (0.000 + 0.000 secs).
>> Command 4 took 0.0007 seconds.
S: * STATUS INBOX (MESSAGES 16104 RECENT 0 UIDNEXT 29936 UIDVALIDITY 1357574186 UNSEEN 404)
S: 5 OK Status completed (0.000 + 0.000 secs).
>> Command 5 took 0.0412 seconds.
C: 6 LOGOUT
S: * BYE Logging out
S: 6 OK Logout completed (0.000 + 0.000 secs).
>> Command 6 took 0.0006 seconds.

There are the nextcloud.log relevant part (log is the same for seen and unseen mail)

tail -f nextcloud.log | grep '"app":"mail"' | grep myself
{"reqId":"Tiy0ReFrAHuxQP9QbGPc","level":0,"time":"2023-04-06T09:39:34+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/227883/thread","message":"Password of provisioned account is up to date","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"0pkMn539ixoGV4URODCd","level":0,"time":"2023-04-06T09:39:34+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/227883/body","message":"Password of provisioned account is up to date","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"0pkMn539ixoGV4URODCd","level":0,"time":"2023-04-06T09:39:34+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/227883/body","message":"findByIds in INBOX got 1 UIDs but found none","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"0pkMn539ixoGV4URODCd","level":3,"time":"2023-04-06T09:39:34+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/227883/body","message":"Could not load message","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","exception":{"Exception":"OCA\\Mail\\Exception\\ServiceException","Message":"Could not load message","Code":0,"Trace":[{"file":"/var/www/nextcloud/apps/mail/lib/Controller/MessagesController.php","line":248,"function":"getImapMessage","class":"OCA\\Mail\\Service\\MailManager","type":"->"},{"file":"/var/www/nextcloud/lib/private/AppFramework/Http/Dispatcher.php","line":225,"function":"getBody","class":"OCA\\Mail\\Controller\\MessagesController","type":"->"},{"file":"/var/www/nextcloud/lib/private/AppFramework/Http/Dispatcher.php","line":133,"function":"executeController","class":"OC\\AppFramework\\Http\\Dispatcher","type":"->"},{"file":"/var/www/nextcloud/lib/private/AppFramework/App.php","line":172,"function":"dispatch","class":"OC\\AppFramework\\Http\\Dispatcher","type":"->"},{"file":"/var/www/nextcloud/lib/private/Route/Router.php","line":298,"function":"main","class":"OC\\AppFramework\\App","type":"::"},{"file":"/var/www/nextcloud/lib/base.php","line":1030,"function":"match","class":"OC\\Route\\Router","type":"->"},{"file":"/var/www/nextcloud/index.php","line":36,"function":"handleRequest","class":"OC","type":"::"}],"File":"/var/www/nextcloud/apps/mail/lib/Service/MailManager.php","Line":187,"Previous":{"Exception":"OCP\\AppFramework\\Db\\DoesNotExistException","Message":"Message does not exist","Code":0,"Trace":[{"file":"/var/www/nextcloud/apps/mail/lib/Service/MailManager.php","line":181,"function":"find","class":"OCA\\Mail\\IMAP\\MessageMapper","type":"->"},{"file":"/var/www/nextcloud/apps/mail/lib/Controller/MessagesController.php","line":248,"function":"getImapMessage","class":"OCA\\Mail\\Service\\MailManager","type":"->"},{"file":"/var/www/nextcloud/lib/private/AppFramework/Http/Dispatcher.php","line":225,"function":"getBody","class":"OCA\\Mail\\Controller\\MessagesController","type":"->"},{"file":"/var/www/nextcloud/lib/private/AppFramework/Http/Dispatcher.php","line":133,"function":"executeController","class":"OC\\AppFramework\\Http\\Dispatcher","type":"->"},{"file":"/var/www/nextcloud/lib/private/AppFramework/App.php","line":172,"function":"dispatch","class":"OC\\AppFramework\\Http\\Dispatcher","type":"->"},{"file":"/var/www/nextcloud/lib/private/Route/Router.php","line":298,"function":"main","class":"OC\\AppFramework\\App","type":"::"},{"file":"/var/www/nextcloud/lib/base.php","line":1030,"function":"match","class":"OC\\Route\\Router","type":"->"},{"file":"/var/www/nextcloud/index.php","line":36,"function":"handleRequest","class":"OC","type":"::"}],"File":"/var/www/nextcloud/apps/mail/lib/IMAP/MessageMapper.php","Line":75},"message":"Could not load message","exception":{},"CustomMessage":"Could not load message"}}
{"reqId":"iSeJ3vycvhBXR2iCDp9J","level":0,"time":"2023-04-06T09:39:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"Password of provisioned account is up to date","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"iSeJ3vycvhBXR2iCDp9J","level":0,"time":"2023-04-06T09:39:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"Locking mailbox 82 for new messages sync","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"iSeJ3vycvhBXR2iCDp9J","level":0,"time":"2023-04-06T09:39:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"Locking mailbox 82 for changed messages sync","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"iSeJ3vycvhBXR2iCDp9J","level":0,"time":"2023-04-06T09:39:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"Locking mailbox 82 for vanished messages sync","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"iSeJ3vycvhBXR2iCDp9J","level":0,"time":"2023-04-06T09:39:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"Running partial sync for 82","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"iSeJ3vycvhBXR2iCDp9J","level":0,"time":"2023-04-06T09:39:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"partial sync 3:INBOX - get all known UIDs took 0s. 6/6MB memory used","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"iSeJ3vycvhBXR2iCDp9J","level":0,"time":"2023-04-06T09:39:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"findByIds in INBOX got 0 UIDs but found none","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"iSeJ3vycvhBXR2iCDp9J","level":0,"time":"2023-04-06T09:39:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"findByIds in INBOX got 0 UIDs but found none","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"iSeJ3vycvhBXR2iCDp9J","level":0,"time":"2023-04-06T09:39:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"partial sync 3:INBOX - get new messages via Horde took 0s. 6/6MB memory used","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"iSeJ3vycvhBXR2iCDp9J","level":0,"time":"2023-04-06T09:39:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"partial sync 3:INBOX - persist new messages took 0s. 6/6MB memory used","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"iSeJ3vycvhBXR2iCDp9J","level":0,"time":"2023-04-06T09:39:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"findByIds in INBOX got 0 UIDs but found none","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"iSeJ3vycvhBXR2iCDp9J","level":0,"time":"2023-04-06T09:39:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"findByIds in INBOX got 1 UIDs (29936) and found 1. minFetched=29936 maxFetched=29936","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"iSeJ3vycvhBXR2iCDp9J","level":0,"time":"2023-04-06T09:39:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"partial sync 3:INBOX - get changed messages via Horde took 0s. 7/7MB memory used","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"iSeJ3vycvhBXR2iCDp9J","level":0,"time":"2023-04-06T09:39:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"partial sync 3:Surname NAME - Selected Tags for all messages took 0s. 7/7MB memory used","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"iSeJ3vycvhBXR2iCDp9J","level":0,"time":"2023-04-06T09:39:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"partial sync 3:Surname NAME - Updated message  took 0s. 7/7MB memory used","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"iSeJ3vycvhBXR2iCDp9J","level":0,"time":"2023-04-06T09:39:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"partial sync 3:Surname NAME took 0s","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"iSeJ3vycvhBXR2iCDp9J","level":0,"time":"2023-04-06T09:39:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"partial sync 3:INBOX - persist changed messages took 0s. 7/7MB memory used","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"iSeJ3vycvhBXR2iCDp9J","level":0,"time":"2023-04-06T09:39:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"findByIds in INBOX got 0 UIDs but found none","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}

Log from a working mail :

{"reqId":"YatKqJGoYoGuIeJCwfLd","level":0,"time":"2023-04-06T09:44:35+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/228210/thread","message":"Password of provisioned account is up to date","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"0j4yuN6BRRqXOhhyo7A0","level":0,"time":"2023-04-06T09:44:35+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/228210/body","message":"Password of provisioned account is up to date","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"ARhQOh3SSUojOZWpC8kD","level":0,"time":"2023-04-06T09:44:35+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/228210/itineraries","message":"Password of provisioned account is up to date","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"ldIUkAG0uDDmhiegSzSQ","level":0,"time":"2023-04-06T09:44:35+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/228210/html","message":"Password of provisioned account is up to date","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"0j4yuN6BRRqXOhhyo7A0","level":0,"time":"2023-04-06T09:44:35+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/228210/body","message":"findByIds in INBOX got 1 UIDs (29923) and found 1. minFetched=29923 maxFetched=29923","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"FEdQUOOr3rdHykbtzqEa","level":0,"time":"2023-04-06T09:44:36+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/228210/attachment/1.2","message":"Password of provisioned account is up to date","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"ldIUkAG0uDDmhiegSzSQ","level":0,"time":"2023-04-06T09:44:36+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/228210/html","message":"findByIds in INBOX got 1 UIDs (29923) and found 1. minFetched=29923 maxFetched=29923","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"FOMhMHvHA089lJVl18AG","level":0,"time":"2023-04-06T09:44:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/227944/thread","message":"Password of provisioned account is up to date","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"jdahZvjxd5mTN3SqLfNy","level":0,"time":"2023-04-06T09:44:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/227944/body","message":"Password of provisioned account is up to date","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"73JFYmAkgx6UzAkOOXKr","level":0,"time":"2023-04-06T09:44:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/227944/html","message":"Password of provisioned account is up to date","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"XT9hkwVaGj2enTZxLBkr","level":0,"time":"2023-04-06T09:44:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/227944/itineraries","message":"Password of provisioned account is up to date","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"jdahZvjxd5mTN3SqLfNy","level":0,"time":"2023-04-06T09:44:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/227944/body","message":"findByIds in INBOX got 1 UIDs (29921) and found 1. minFetched=29921 maxFetched=29921","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"73JFYmAkgx6UzAkOOXKr","level":0,"time":"2023-04-06T09:44:47+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/227944/html","message":"findByIds in INBOX got 1 UIDs (29921) and found 1. minFetched=29921 maxFetched=29921","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"E5xmC2438zvAAjIotbFs","level":0,"time":"2023-04-06T09:44:52+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/228307/thread","message":"Password of provisioned account is up to date","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"SrpT64mhmc1dGOdKzyCC","level":0,"time":"2023-04-06T09:44:52+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/avatars/url/internal%40REDACTED.TLD","message":"Password of provisioned account is up to date","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"uefOF4Fycd2Gq162KBoL","level":0,"time":"2023-04-06T09:44:52+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/228307/body","message":"Password of provisioned account is up to date","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"uefOF4Fycd2Gq162KBoL","level":0,"time":"2023-04-06T09:44:52+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/228307/body","message":"findByIds in INBOX got 1 UIDs (29926) and found 1. minFetched=29926 maxFetched=29926","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"OMGn738U9cWGYaCGRFFV","level":0,"time":"2023-04-06T09:44:52+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/228307/itineraries","message":"Password of provisioned account is up to date","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"OMGn738U9cWGYaCGRFFV","level":0,"time":"2023-04-06T09:44:52+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/228307/itineraries","message":"Message does not have an HTML body, can't extract itinerary info","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"OMGn738U9cWGYaCGRFFV","level":1,"time":"2023-04-06T09:44:52+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/228307/itineraries","message":"KItinerary binary adapter is not available, can't extract information","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"OMGn738U9cWGYaCGRFFV","level":0,"time":"2023-04-06T09:44:52+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/228307/itineraries","message":"Extracted 0 itinerary entries from an attachment","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"OMGn738U9cWGYaCGRFFV","level":1,"time":"2023-04-06T09:44:52+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/228307/itineraries","message":"KItinerary binary adapter is not available, can't extract information","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"OMGn738U9cWGYaCGRFFV","level":0,"time":"2023-04-06T09:44:52+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"GET","url":"/apps/mail/api/messages/228307/itineraries","message":"Reduced 0 itinerary entries to 0 entries","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"wVZCJaeirlRg5LfGsaiH","level":0,"time":"2023-04-06T09:44:54+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"Password of provisioned account is up to date","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"wVZCJaeirlRg5LfGsaiH","level":0,"time":"2023-04-06T09:44:54+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"Locking mailbox 82 for new messages sync","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"wVZCJaeirlRg5LfGsaiH","level":0,"time":"2023-04-06T09:44:54+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"Locking mailbox 82 for changed messages sync","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"wVZCJaeirlRg5LfGsaiH","level":0,"time":"2023-04-06T09:44:54+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"Locking mailbox 82 for vanished messages sync","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"wVZCJaeirlRg5LfGsaiH","level":0,"time":"2023-04-06T09:44:54+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"Running partial sync for 82","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"wVZCJaeirlRg5LfGsaiH","level":0,"time":"2023-04-06T09:44:54+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"partial sync 3:INBOX - get all known UIDs took 0s. 6/6MB memory used","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"wVZCJaeirlRg5LfGsaiH","level":0,"time":"2023-04-06T09:44:54+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"findByIds in INBOX got 0 UIDs but found none","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"wVZCJaeirlRg5LfGsaiH","level":0,"time":"2023-04-06T09:44:54+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"findByIds in INBOX got 0 UIDs but found none","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"wVZCJaeirlRg5LfGsaiH","level":0,"time":"2023-04-06T09:44:54+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"partial sync 3:INBOX - get new messages via Horde took 0s. 6/6MB memory used","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"wVZCJaeirlRg5LfGsaiH","level":0,"time":"2023-04-06T09:44:54+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"partial sync 3:INBOX - persist new messages took 0s. 6/6MB memory used","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"wVZCJaeirlRg5LfGsaiH","level":0,"time":"2023-04-06T09:44:54+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"findByIds in INBOX got 0 UIDs but found none","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"wVZCJaeirlRg5LfGsaiH","level":0,"time":"2023-04-06T09:44:54+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"findByIds in INBOX got 1 UIDs (29936) and found 1. minFetched=29936 maxFetched=29936","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"wVZCJaeirlRg5LfGsaiH","level":0,"time":"2023-04-06T09:44:54+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"partial sync 3:INBOX - get changed messages via Horde took 0s. 7/7MB memory used","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"wVZCJaeirlRg5LfGsaiH","level":0,"time":"2023-04-06T09:44:54+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"partial sync 3:Surname NAME - Selected Tags for all messages took 0s. 7/7MB memory used","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"wVZCJaeirlRg5LfGsaiH","level":0,"time":"2023-04-06T09:44:54+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"partial sync 3:Surname NAME - Updated message  took 0s. 7/7MB memory used","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"wVZCJaeirlRg5LfGsaiH","level":0,"time":"2023-04-06T09:44:54+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"partial sync 3:Surname NAME took 0s","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"wVZCJaeirlRg5LfGsaiH","level":0,"time":"2023-04-06T09:44:54+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"partial sync 3:INBOX - persist changed messages took 0s. 7/7MB memory used","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"wVZCJaeirlRg5LfGsaiH","level":0,"time":"2023-04-06T09:44:54+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"findByIds in INBOX got 0 UIDs but found none","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}
{"reqId":"wVZCJaeirlRg5LfGsaiH","level":0,"time":"2023-04-06T09:44:54+00:00","remoteAddr":"192.168.10.169","user":"[email protected]","app":"mail","method":"POST","url":"/apps/mail/api/mailboxes/82/sync","message":"findByIds in INBOX got 0 UIDs but found none","userAgent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/113.0","version":"24.0.7.1","data":{"app":"mail"}}

Let me know if you want more, I have tons off example.

Server configuration detail

Operating system: Linux 5.4.195-1-pve #1 SMP PVE 5.4.195-1 (Wed, 13 Jul 2022 13:19:46 +0200) i686

Webserver: nginx/1.18.0 (fpm-fcgi)

Database: mysql 10.5.18

PHP version: 7.4.33

Modules loaded: Core, date, libxml, openssl, pcre, zlib, filter, hash, Reflection, SPL, session, standard, sodium, cgi-fcgi, smbclient, mysqlnd, PDO, xml, apcu, bcmath, bz2, calendar, ctype, curl, dom, mbstring, FFI, fileinfo, ftp, gd, geoip, gettext, gmp, iconv, igbinary, imagick, imap, intl, json, ldap, exif, msgpack, mysqli, pdo_mysql, apc, posix, readline, redis, shmop, SimpleXML, sockets, sysvmsg, sysvsem, sysvshm, tokenizer, xmlreader, xmlwriter, xsl, zip, Phar, memcached, libsmbclient, Zend OPcache

Nextcloud version: 24.0.7 - 24.0.7.1

Updated from an older Nextcloud/ownCloud or fresh install:

Where did you install Nextcloud from: unknown

<details><summary>Signing status</summary>

Array ( [deckimportfromtrello] => Array ( [EXCEPTION] => Array ( [class] => OC\IntegrityCheck\Exceptions\InvalidSignatureException [message] => Certificate is not valid for required scope. (Requested: deckimportfromtrello, current: CN=APP_ID) )

    )


)

</details>

<details><summary>List of activated apps</summary>

Enabled:
 - accessibility: 1.10.0
 - admin_audit: 1.14.0
 - approval: 1.0.12
 - calendar: 3.5.5
 - circles: 24.0.1
 - cloud_federation_api: 1.7.0
 - collectives: 1.6.3
 - comments: 1.14.0
 - contacts: 4.2.4
 - contactsinteraction: 1.5.0
 - dashboard: 7.4.0
 - dav: 1.22.0
 - deck: 1.7.3
 - deckimportfromtrello: 1.0.2
 - federatedfilesharing: 1.14.0
 - federation: 1.14.0
 - files: 1.19.0
 - files_accesscontrol: 1.14.1
 - files_antivirus: 4.0.2
 - files_automatedtagging: 1.14.0
 - files_external: 1.16.1
 - files_fulltextsearch: 24.0.1
 - files_markdown: 2.3.6
 - files_pdfviewer: 2.5.0
 - files_retention: 1.13.2
 - files_rightclick: 1.3.0
 - files_sharing: 1.16.2
 - files_texteditor: 2.15.0
 - files_trashbin: 1.14.0
 - files_versions: 1.17.0
 - files_videoplayer: 1.13.0
 - firstrunwizard: 2.13.0
 - flow_notifications: 1.4.0
 - forms: 2.5.1
 - fulltextsearch: 24.0.0
 - fulltextsearch_elasticsearch: 24.0.1
 - groupfolders: 12.0.3
 - guests: 2.3.0
 - impersonate: 1.11.0
 - logreader: 2.9.0
 - lookup_server_connector: 1.12.0
 - mail: 1.15.1
 - nextcloud_announcements: 1.13.0
 - notifications: 2.12.1
 - oauth2: 1.12.0
 - password_policy: 1.14.0
 - privacy: 1.8.0
 - provisioning_api: 1.14.0
 - qownnotesapi: 22.10.0
 - recommendations: 1.3.0
 - richdocuments: 6.3.4
 - serverinfo: 1.14.0
 - settings: 1.6.0
 - sharebymail: 1.14.0
 - spreed: 14.0.8
 - support: 1.7.0
 - survey_client: 1.12.0
 - systemtags: 1.14.0
 - tasks: 0.14.5
 - text: 3.5.1
 - theming: 1.15.0
 - twofactor_backupcodes: 1.13.0
 - updatenotification: 1.14.0
 - user_ldap: 1.14.1
 - user_sql: 4.7.1
 - user_status: 1.4.0
 - viewer: 1.8.0
 - weather_status: 1.4.0
 - workflow_ocr: 1.24.6
 - workflowengine: 2.6.0
Disabled:
 - activity: 2.16.0
 - carnet: 0.24.6
 - encryption
 - photos: 1.6.0



</details>

<details><summary>Configuration (config/config.php)</summary>

{
    "instanceid": "***REMOVED SENSITIVE VALUE***",
    "passwordsalt": "***REMOVED SENSITIVE VALUE***",
    "secret": "***REMOVED SENSITIVE VALUE***",
    "trusted_domains": [
        "web.REDACTED.TLD",
        "up.REDACTED.TLD"
    ],
    "datadirectory": "***REMOVED SENSITIVE VALUE***",
    "overwrite.cli.url": "https:\/\/web.REDACTED.TLD\/nextcloud",
    "dbtype": "mysql",
    "version": "24.0.7.1",
    "dbname": "***REMOVED SENSITIVE VALUE***",
    "dbhost": "***REMOVED SENSITIVE VALUE***",
    "dbport": "",
    "dbtableprefix": "oc_",
    "dbuser": "***REMOVED SENSITIVE VALUE***",
    "dbpassword": "***REMOVED SENSITIVE VALUE***",
    "installed": true,
    "ldapIgnoreNamingRules": false,
    "ldapProviderFactory": "\\OCA\\User_LDAP\\LDAPProviderFactory",
    "memcache.local": "\\OC\\Memcache\\APCu",
    "memcache.distributed": "\\OC\\Memcache\\Memcached",
    "memcached_servers": [
        [
            "localhost",
            11211
        ]
    ],
    "mail_smtpmode": "smtp",
    "mail_smtpauthtype": "LOGIN",
    "mail_from_address": "***REMOVED SENSITIVE VALUE***",
    "mail_domain": "***REMOVED SENSITIVE VALUE***",
    "mail_smtpauth": 1,
    "mail_smtphost": "***REMOVED SENSITIVE VALUE***",
    "mail_smtpport": "587",
    "mail_smtpname": "***REMOVED SENSITIVE VALUE***",
    "mail_smtppassword": "***REMOVED SENSITIVE VALUE***",
    "mail_smtpsecure": "tls",
    "updater.release.channel": "stable",
    "maintenance": false,
    "theme": "",
    "loglevel": 0,
    "debug": true,
    "default_phone_region": "FR",
    "default_locale": "fr_FR",
    "trashbin_retention_obligation": "30, auto",
    "versions_retention_obligation": "auto, 30",
    "mysql.utf8mb4": true,
    "app_install_overwrite": [
        "workflow_ocr",
        "user_sql"
    ],
    "allow_local_remote_servers": true,
    "has_rebuilt_cache": true,
    "filelocking.enabled": true,
    "memcache.locking": "\\OC\\Memcache\\Redis",
    "redis": {
        "host": "***REMOVED SENSITIVE VALUE***",
        "port": 0,
        "timeout": 0
    }
}


</details>

Cron Configuration: Array ( [backgroundjobs_mode] => cron [lastcron] => 1680774606 )

External storages: yes

REDACTED PART

Encryption: no

User-backends:

OCA\Guests\UserBackend

OC\User\Database

OCA\UserSQL\Backend\UserBackend

Talk configuration:

STUN servers

stun.nextcloud.com:443

TURN servers

no custom server configured

Signaling servers (mode: default):

no custom server configured

IMAP server is Dovecot, and it's in the same LAN.

@meichthys
Copy link

I'm also seeing this when connecting to a PurelyMail account via imap.
If i archive an email in PurelyMail webmail, then refresh in nextcloud, the email remains in the inbox and cannot be opened for viewing:
image

Relevant nextcloud log. It's likely failing since it's looking for the message in the inbox but it has already been moved to Archive.

[mail] Error: OCA\Mail\Exception\ServiceException: Could not load message at <<closure>>

0. /var/www/nextcloud/apps/mail/lib/Controller/MessagesController.php line 220
   OCA\Mail\Service\MailManager->getImapMessage()
1. /var/www/nextcloud/lib/private/AppFramework/Http/Dispatcher.php line 230
   OCA\Mail\Controller\MessagesController->getBody()
2. /var/www/nextcloud/lib/private/AppFramework/Http/Dispatcher.php line 137
   OC\AppFramework\Http\Dispatcher->executeController()
3. /var/www/nextcloud/lib/private/AppFramework/App.php line 183
   OC\AppFramework\Http\Dispatcher->dispatch()
4. /var/www/nextcloud/lib/private/Route/Router.php line 315
   OC\AppFramework\App::main()
5. /var/www/nextcloud/lib/base.php line 1056
   OC\Route\Router->match()
6. /var/www/nextcloud/index.php line 36
   OC::handleRequest()

Caused by:

OCP\AppFramework\Db\DoesNotExistException: Mail body for this mail(308) could not be loaded at <<closure>>

 0. /var/www/nextcloud/apps/mail/lib/IMAP/ImapMessageFetcher.php line 401
    OCA\Mail\IMAP\ImapMessageFetcher->loadBodyData()
 1. /var/www/nextcloud/apps/mail/lib/IMAP/ImapMessageFetcher.php line 352
    OCA\Mail\IMAP\ImapMessageFetcher->handleTextMessage()
 2. /var/www/nextcloud/apps/mail/lib/IMAP/ImapMessageFetcher.php line 205
    OCA\Mail\IMAP\ImapMessageFetcher->getPart()
 3. /var/www/nextcloud/apps/mail/lib/IMAP/MessageMapper.php line 314
    OCA\Mail\IMAP\ImapMessageFetcher->fetchMessage()
 4. <<closure>>
    OCA\Mail\IMAP\MessageMapper->OCA\Mail\IMAP\{closure}("*** sensitive parameters replaced ***")
 5. /var/www/nextcloud/apps/mail/lib/IMAP/MessageMapper.php line 315
    array_map()
 6. /var/www/nextcloud/apps/mail/lib/IMAP/MessageMapper.php line 87
    OCA\Mail\IMAP\MessageMapper->findByIds()
 7. /var/www/nextcloud/apps/mail/lib/Service/MailManager.php line 193
    OCA\Mail\IMAP\MessageMapper->find()
 8. /var/www/nextcloud/apps/mail/lib/Controller/MessagesController.php line 220
    OCA\Mail\Service\MailManager->getImapMessage()
 9. /var/www/nextcloud/lib/private/AppFramework/Http/Dispatcher.php line 230
    OCA\Mail\Controller\MessagesController->getBody()
10. /var/www/nextcloud/lib/private/AppFramework/Http/Dispatcher.php line 137
    OC\AppFramework\Http\Dispatcher->executeController()
11. /var/www/nextcloud/lib/private/AppFramework/App.php line 183
    OC\AppFramework\Http\Dispatcher->dispatch()
12. /var/www/nextcloud/lib/private/Route/Router.php line 315
    OC\AppFramework\App::main()
13. /var/www/nextcloud/lib/base.php line 1056
    OC\Route\Router->match()
14. /var/www/nextcloud/index.php line 36
    OC::handleRequest()

GET /apps/mail/api/messages/472789/body

@meichthys
Copy link

I've been using NC Mail for a few years now and have learned to deal with most of the issues, but this one has me temporarily using something else. The issue results in many console logs, and an inability to archive messages that show in the NC inbox but are really not there because they have already been archived by my mobile client:
image

It also sometimes results in an endless flurry of desktop notifications saying there are new messages in my inbox:
image

This was referenced Jun 16, 2023
@st3iny st3iny added skill:backend Issues and PRs that require backend development skills 2. developing and removed skill:frontend Issues and PRs that require JavaScript/Vue/styling development skills 1. to develop labels Jun 20, 2023
@GretaD
Copy link
Contributor

GretaD commented Jun 20, 2023

I have the same scenario but i can still interact with some of the messages that got deleted

@meichthys
Copy link

@GretaD Yes, this is what i'm seeing. I'm able to interact with the message although the content is not visible:
image

@GretaD
Copy link
Contributor

GretaD commented Jun 20, 2023

For me in same cases, the content of the message is also visible

@rakekniven
Copy link
Member

Not found it says in german for all of them:

grafik

@meichthys
Copy link

I'm really not trying to be annoying - I promise!
Just reporting that this issue is still relevant in v3.2.3

@ChristophWurst
Copy link
Member

Try #8575. We think the issue has been identified.

@meichthys
Copy link

meichthys commented Jun 28, 2023

@ChristophWurst I patched the changes into my instance but it doesn't seem to have fixed it for old or new emails despite reloading the page and rebooting nextcloud:
image

Here's the updated code in my own instance:
/var/www/nextcloud/apps/mail/lib/Service/Sync/ImapToDbSynchronizer.php
image

@ChristophWurst
Copy link
Member

@meichthys check again tomorrow. The background sync (cron) has to run.

@meichthys
Copy link

Ok, Thanks. I did try to manually run the cron job via sudo -u www-data php /var/www/nextcloud/cron.php but maybe there's a different cron script that needs to run.

I'll check again tomorrow.

@meichthys
Copy link

This still seems to be an issue in v3.3.0-alpha.1

@powerpaul17
Copy link

This PR has not been merged yet, which means it is not included in any release. You have to apply the patch manually and don't update because it will get overwritten again.

@Chartman123
Copy link

@st3iny I did a reset in debug mode before the update, then updated the app and deleted a mail in K-9 on my mobile. After that the mail was still present in Mail and couldn't be viewed/deleted there.

@st3iny
Copy link
Member

st3iny commented Dec 9, 2023

@Chartman123 Thanks for clarifying. I'll install the app and see if I can get it to break, too.

@bovender
Copy link

bovender commented Dec 9, 2023

I did more tests today. First I enabled debug mode and deleted the local caches for my two IMAP accounts. Then I sent mails to both accounts and deleted them with KMail and with K-9. To my surprise and great delight, all deleted mails properly disappeared from Nextcloud Mail, regardless whether debug mode was still on or after I had turned it off.

😁

@Chartman123
Copy link

So it might perhaps also be related to the used server for the mailbox?

@st3iny
Copy link
Member

st3iny commented Dec 9, 2023

@Chartman123 I also get the impression that it depends on the server. I just tried to reproduce your case with K-9 and a server that showed the issues before the patch. With the latest version of Mail it works fine.

So, in summary there are still some issues left. I vaguely remember that there might be some problems on our side around the \Deleted flag some clients use. Your issue could be triggered by running into a specific edge case were we sync after the flag was set but before the email is actually removed from the mailbox.

@Chartman123
Copy link

@st3iny would it help you if I created a mailbox for you on our server?

@st3iny
Copy link
Member

st3iny commented Dec 10, 2023

@Chartman123 Yeah, that would be great. You can send the details to [email protected]. (Have a look at my profile here for the names).

@pneumokoniose
Copy link

On my server it is completely crazy:

I have two mailboxes in Nextcloud Mail. Both mailboxes show emails that have already been deleted. After I deleted the cache, all emails disappeared with the error message "not found". But now it's getting crazy:

Other deleted emails are still displayed. But only those that have been marked as deleted on my mail server. There I don't get a "not found" error message.

If I delete the cache from mailbox 1 again, mailbox 2 is displayed correctly. But not mailbox 1.

And if I then delete the cache from mailbox 2, mailbox 2 is displayed incorrectly again, but mailbox 1 correctly.

Nextcloud 27.1.4
Mail 3.4.6
Mailserver: Postfix/dovecot

@hartigdan
Copy link

It seems like the Problem wasn't fixed completely. I've updated to v3.4.6 and can confirm that mails that I delete on my phone (iOS Mail App) disappear shorty after that in the Inbox of Nextcloud Mail. However, that's only the case if I have Nextcloud Mail open in the Browser. I.e. Everything that I delete while I'm not logged in to Nextcloud will still be showing up in the Inbox of Nextcloud Mail next time I log in.

@bovender
Copy link

that's only the case if I have Nextcloud Mail open in the Browser. I.e. Everything that I delete while I'm not logged in to Nextcloud will still be showing up in the Inbox of Nextcloud Mail next time I log in.

Same here. My experiments described above worked well because I had opened Nextcloud in the browser. In real life, I delete mails on the phone while on the go when there is no active browser window, and those deleted mails keep showing up in Nextcloud.

@Githopp192
Copy link

nextcloud: 27.1.5.1

PHP 8.2.13 (fpm-fcgi) (built: Nov 21 2023 09:55:59)
Copyright (c) The PHP Group
Zend Engine v4.2.13, Copyright (c) Zend Technologies
with Zend OPcache v8.2.13, Copyright (c), by Zend Technologies

Server version: Apache/2.4.37 (Red Hat Enterprise Linux)

mail: 3.5.0

image

@jancborchardt
Copy link
Member Author

@st3iny since the issue scenario described by @hartigdan and @bovender can be reproduced, should we reopen this issue? Or rather new follow-up, cc @ChristophWurst

@jiriks74
Copy link

jiriks74 commented Jan 23, 2024

IDK why this is closed. I sill have the issue. I've archived some emails on my phone and they're still in my inbox in Nextcloud. Snappymail is without any issues. I tried to archive them again. click the button to refresh, refreshed the site itself, refreshed it without chache, cleared cache and data and opened it on another device. The stupid emails just won't disappear making my inbox utterly unusable (it was about 20-30 emails I archived).

I'd love to use this app's cool functionality (the ai tagging) but the app is slow and unusable due to phantom emails.

PS: Some emails also don't load at all. Sometimes they're blank, sometimes it says "not found", sometimes they're rendered too large and cut off. It's been like this for like 4 years.

@ChristophWurst
Copy link
Member

IDK why this is closed

because there is #9168

@jiriks74
Copy link

IDK why this is closed

because there is #9168

THX. I haven't found that and AFAIK it wasn't mentioned here (or is burried in the conversation).

@Githopp192
Copy link

now on Nextcloud 29.0.4 - Mail app Version 3.7.6

some deleted mail from other mail applications are not removed in Mail app Version 3.7.6.

Still showing "not found"

@st3iny st3iny reopened this Aug 4, 2024
@Githopp192

This comment was marked as duplicate.

@st3iny
Copy link
Member

st3iny commented Aug 20, 2024

I was able to reproduce it locally on Dovecot. Here are some (hacky) steps to trigger the issue:

Preparations

  1. Set up a local imap dev instance.
  2. Disable Nextcloud cron jobs (to make it consistent).
  3. Disable background sync in mail (to make it consistent) [see patch below].
  4. Set up your dev mail account in Mail.
  5. Set up your dev mail account in another client, e.g. Thunderbird.
  6. Have some mails in your inbox.

Repro

  1. Delete the most recent email in your INBOX from the external client.
  2. Stop the Dovecot container.
  3. Delete Dovecot's index, log and cache files, e.g. navigate to the imap docker volume and run rm domain.tld/user/dovecot.index*
  4. Start the Dovecot container again.
  5. Open the inbox in your browser in Mail and press the sync button.
  6. Observe that the most recent email will not vanish.
  7. Click on it and observe the Could not load message error.

Running step 3 ensures that the server "forgets" the HIGHESTMODSEQ token cached by Mail. This emulates an outdated client state.

Disable background sync

diff --git a/src/components/Mailbox.vue b/src/components/Mailbox.vue
index efa8b7320..7742b5b01 100644
--- a/src/components/Mailbox.vue
+++ b/src/components/Mailbox.vue
@@ -142,7 +142,7 @@ export default {
                this.bus.on('delete', this.onDelete)
                this.bus.on('archive', this.onArchive)
                this.bus.on('shortcut', this.handleShortcut)
-               this.loadMailboxInterval = setInterval(this.loadMailbox, 60000)
+               //this.loadMailboxInterval = setInterval(this.loadMailbox, 60000)
        },
        async mounted() {
                if (this.$store.getters.hasFetchedInitialEnvelopes) {

@st3iny
Copy link
Member

st3iny commented Aug 21, 2024

Two more PRs to improve the situation:

  1. fix(imap): do a single full sync when QRESYNC is enabled #10035
  2. fix(imap): persist vanished messages immediately on EXAMINE commands #10036

@Githopp192

This comment was marked as duplicate.

@ChristophWurst

This comment was marked as resolved.

@SebastianKrupinski
Copy link
Contributor

@st3iny can this be closed with the new changes you made? The ghost messages problem seems to be fixed now.

@meichthys
Copy link

meichthys commented Nov 8, 2024

This does not seem to be entirely fixed for me. The repair button does indeed repair the mailbox, but I need to repair it every time I archive or move an item in a different email client.

@SebastianKrupinski
Copy link
Contributor

@meichthys the changes have been applied to our development/testing version 31 and probably have not been back ported yet to your version.

@meichthys
Copy link

OK thanks! I'm on 4.0.2

@SebastianKrupinski
Copy link
Contributor

Sorry, I forgot we are talking about the Mail app, the current development/testing version is 4.2, so you will most likely get the update when the new version is released.

@jiriks74
Copy link

jiriks74 commented Nov 8, 2024

The issues seem to be fixed for me. I still get the occasional ghost message but that gets fixed if I wait. The wait can still be quite long as Mail can be insanely slow (faster than it used to be but it can still take solid 20 seconds until the email list is refreshed). But since this seems to be fixed it's in a usable state (unless you have a large inbox like one of my friends has).

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
3. to review bug feature:mailbox-management skill:backend Issues and PRs that require backend development skills
Projects
Status: 🧭 Planning evaluation
Status: 🏗️ At engineering