Dependency Graph

Dependency Graph
related to related to child of child of duplicate of duplicate of

View Issue Details

IDProjectCategoryView StatusLast Update
0005769SOGoBackend Mailpublic2023-12-18 15:46
Reporterxblax Assigned Toqhivert  
PrioritynormalSeveritymajorReproducibilityrandom
Status closedResolutionduplicate 
OSDebianOS VersionBuster 
Product Version5.8.2 
Summary0005769: SOGo messes up IMAP subscriptions when randomly fails to open folder
Description

I have a problem that SOGo randomly messes up my IMAP subscriptions - this then negatively affects other mail clients, because the folders "disappear" until manually subscribed again.

I enabled SOGo debug logging for requests and mail to track down what happens (see log in additional information). When I click on folders in the web interface at some random points SOGo fails to open the folder.

The problem appears to be-in the back-end. When the web-interface requests to open folder "INBOX.Foo.Bar" on the IMAP side SOGo tries to select folder "INBOXFooBar" which obviously fails due to the missing dots. But as a result of this failure SOGo then unsubscribes from "INBOX.Foo.Bar". I think the automatic unsubscribe isn't a good idea, but not the root cause here.

I have no idea why this happens - it seems to be totally random. When I try to open the same folder a second time it usually works, but then it's already unsubscribed.

This commit https://github.com/Alinto/sogo/commit/373ac51e62b8d50b9a8aa938c048dbf53bdbb992 sounds related, but obviously isn't helping in my case. I believe I first noticed the missing folder subscription after I upgraded SOGo from 5.4 to 5.8. There is no improvement with 5.8.2.

Additional Information

May 17 09:51:48 sogod [7172]: |SOGo| starting method 'POST' on uri '/SOGo/so/example@example.com/Mail/0/folderINBOX/folderFoo/folderBar/view'
May 17 09:51:48 sogod [7172]: [ERROR] <0x0x561e31739270[NGImap4Connection]> could not select URL: imap://example%40example.com@localhost/INBOX/Foo/Bar/?tls=NO&tlsVerifyMode=default: {RawResponse = "{ResponseResult = {description = \"Mailbox doesn't exist: INBOXFooBar (0.002 + 0.044 + 0.044 secs).\"; result = no; tagId = 4; }; }"; reason = "Mailbox doesn't exist: INBOXFooBar (0.002 + 0.044 + 0.044 secs)."; result = 0; }
May 17 09:51:48 sogod [7172]: |SOGo| request took 0.249417 seconds to execute
May 17 09:51:48 sogod [7172]: localhost "POST /SOGo/so/example@example.com/Mail/0/folderINBOX/folderFoo/folderBar/view HTTP/1.0" 500 71/58

S[0x561e30b7cd00]: OK [CAPABILITY IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE LITERAL+ STARTTLS AUTH=PLAIN] Dovecot (Debian) ready.
C[0x561e3058bc30]: 1 login "example@example.com" "password"
S[0x561e30b7cd00]: 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 LITERAL+ NOTIFY SPECIAL-USE QUOTA] Logged in
C[0x561e3058bc30]: 2 ID ("x-originating-ip" "localhost")
S[0x561e30b7cd00]:
ID ("name" "Dovecot")
S[0x561e30b7cd00]: 2 OK ID completed (0.001 + 0.043 + 0.042 secs).
C[0x561e3058bc30]: 3 LIST "" ""
S[0x561e30b7cd00]: LIST (\Noselect) "." ""
S[0x561e30b7cd00]: 3 OK List completed (0.001 + 0.041 + 0.040 secs).
C[0x561e3058bc30]: 4 select "INBOXFooBar"
S[0x561e30b7cd00]: 4 NO Mailbox doesn't exist: INBOXFooBar (0.002 + 0.044 + 0.044 secs).
C[0x561e3058bc30]: 5 unsubscribe "INBOX.Foo.Bar"
S[0x561e30b7cd00]: 5 OK Unsubscribe completed (0.025 + 0.000 + 0.024 secs).
C[0x561e3058bc30]: 6 logout
S[0x561e30b7cd00]:

TagsNo tags attached.

Relationships

related to 0005900 closedqhivert Mails get sent via SMTP but not stored in Sent-Folder 

Activities

qhivert

qhivert

2023-12-18 15:45

administrator   ~0017509

Hello I close this one, refer to the https://bugs.sogo.nu/view.php?id=5900 which have the same problem

Issue History

Date Modified Username Field Change
2023-05-17 08:42 xblax New Issue
2023-12-18 15:45 qhivert Relationship added related to 0005900
2023-12-18 15:45 qhivert Note Added: 0017509
2023-12-18 15:46 qhivert Assigned To => qhivert
2023-12-18 15:46 qhivert Status new => closed
2023-12-18 15:46 qhivert Resolution open => duplicate