IMAP account can't save any email with attachment
Hi,
I'm getting a curious problem where if I write a draft without an attachment and click save. It'll work without any issue at all.
But if I do the same, then attach a file to the email, it'll sit there for a couple of minutes before timing out (I'm using thunderbird), it'll eventually give you a message saying
"Your draft message was not copied to your drafts folder (Drafts) due to network or file access errors."
I've got all of dovecots verbose logging turned on. I'm using dovecot as a submission server through to the postfix server to do the actual sending. All the logging is turned on there too. But I can't figure out what the problem is.
Is there anything I can look for in the logs that will help me out?
chris
Op 20 jul. 2023 om 14:26 heeft Chris Thomas chris.alex.thomas@gmail.com het volgende geschreven:
Hi,
I'm getting a curious problem where if I write a draft without an attachment and click save. It'll work without any issue at all.
But if I do the same, then attach a file to the email, it'll sit there for a couple of minutes before timing out (I'm using thunderbird), it'll eventually give you a message saying
"Your draft message was not copied to your drafts folder (Drafts) due to network or file access errors."
I've got all of dovecots verbose logging turned on.
Cool! So … where is it?
I'm using dovecot as a submission server through to the postfix server to do the actual sending. All the logging is turned on there too. But I can't figure out what the problem is.
Is there anything I can look for in the logs that will help me out?
chris
dovecot mailing list -- dovecot@dovecot.org To unsubscribe send an email to dovecot-leave@dovecot.org
Cool ok, so here is a log of information when I save an email to drafts that has no attachments
Jul 20 14:54:31 auth: Debug: auth client connected (pid=2104)
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x10, ret=1: before SSL
initialization
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2001, ret=1: before SSL
initialization
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2002, ret=-1: before SSL
initialization
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2002, ret=-1: before SSL
initialization
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2001, ret=1: before SSL
initialization
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS read
client hello
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS
write server hello
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS
write change cipher spec
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 write
encrypted extensions
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS
write certificate
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 write
server certificate verify
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS
write finished
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 early
data
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early
data
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early
data
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early
data
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early
data
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 early
data
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS read
finished
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x20, ret=1: SSLv3/TLS write
session ticket
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS
write session ticket
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS
write session ticket
Jul 20 14:54:31 imap-login: Debug: SSL: where=0x2002, ret=1: SSL
negotiation finished successfully
Jul 20 14:54:31 auth: Debug: client in: AUTH 1 PLAIN service=imap
secured=tls session=8NppU+wAq8VfWumz lip=207.180.242.208 rip=95.90.233.179 lport=143 rport=50603 real_lip=10.38.0.18 real_rip=10.40.0.0 real_rport=60316 local_name=imap.mydomain.com ssl_cipher=TLS_AES_128_GCM_SHA256 ssl_cipher_bits=128 ssl_pfs=KxANY ssl_protocol=TLSv1.3
Jul 20 14:54:31 auth: Debug: client passdb out: CONT 1
Jul 20 14:54:32 auth: Debug: client in: CONT 1 (SECRET BASE64 THINGY)
(previous base64 data may contain sensitive data)
Jul 20 14:54:32 auth-worker(2065): Debug: sql(myuser@mydomain.com,95.90.233.179,<8NppU+wAq8VfWumz>):
query: select u.username, d.name as domain, u.password, concat('*:bytes=', quota_limit_bytes) AS userdb_quota_rule from virtual_users as u inner join virtual_domains as d on d.id = u.domain_id where u.is_active = 'Y' and u.username='myuser' and d.name='mydomain.com'
Jul 20 14:54:32 auth: Debug: client passdb out: OK 1 user=
myuser@mydomain.com
Jul 20 14:54:32 auth: Debug: master in: REQUEST 933232641 2104 1
d92abd773ab27d7f296ca9e28d6d20c9 session_pid=2105 request_auth_token
Jul 20 14:54:32 auth: Debug: prefetch(myuser@mydomain.com,95.90.233.179,<8NppU+wAq8VfWumz>):
success
Jul 20 14:54:32 auth: Debug: master userdb out: USER 933232641
myuser@mydomain.com quota_rule=*:bytes=0 auth_token=ecc46a3e8110c8878e4ecc6bf3a6b0031d9d2cc4
Jul 20 14:54:32 imap-login: Info: Login: user=myuser@mydomain.com,
method=PLAIN, rip=95.90.233.179, lip=207.180.242.208, mpid=2105, TLS, session=<8NppU+wAq8VfWumz>
Jul 20 14:54:32 imap(myuser@mydomain.com)<2105><8NppU+wAq8VfWumz>: Debug:
Loading modules from directory: /usr/lib/dovecot/modules
Jul 20 14:54:32 imap(myuser@mydomain.com)<2105><8NppU+wAq8VfWumz>: Debug:
Module loaded: /usr/lib/dovecot/modules/lib20_zlib_plugin.so
Jul 20 14:54:32 imap(myuser@mydomain.com)<2105><8NppU+wAq8VfWumz>: Debug:
Added userdb setting: plugin/quota_rule=*:bytes=0
Jul 20 14:54:32 imap(myuser@mydomain.com)<2105><8NppU+wAq8VfWumz>: Debug:
Effective uid=8, gid=8, home=/mail/mydomain.com/myuser
Jul 20 14:54:32 imap(myuser@mydomain.com)<2105><8NppU+wAq8VfWumz>: Debug:
Namespace inbox: type=private, prefix=, sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes location=maildir:/mail/mydomain.com/myuser
Jul 20 14:54:32 imap(myuser@mydomain.com)<2105><8NppU+wAq8VfWumz>: Debug:
maildir++: root=/mail/mydomain.com/myuser, index=, indexpvt=, control=, inbox=/mail/mydomain.com/myuser, alt=
Jul 20 14:54:32 imap(myuser@mydomain.com)<2105><8NppU+wAq8VfWumz>: Debug:
Mailbox Drafts: Mailbox opened because: SELECT
Jul 20 14:54:32 imap(myuser@mydomain.com)<2105><8NppU+wAq8VfWumz>: Debug:
Mailbox Drafts: saving UID 0: Opened mail because: mail stream
and here is the log entries that are generated when I close the window, write a new email, same to address, subject=save to drafts with attachment, body=hello world. Then I hit the attach button, select a random pdf from my computer, hit the save button, just like I did with the email that had no attachments and I get this instead
Jul 20 15:06:20 auth: Debug: auth client connected (pid=2180)
Jul 20 15:06:20 imap-login: Debug: SSL: where=0x10, ret=1: before SSL initialization Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2001, ret=1: before SSL initialization Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2002, ret=-1: before SSL initialization Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2002, ret=-1: before SSL initialization Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2001, ret=1: before SSL initialization Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS read client hello Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write server hello Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write change cipher spec Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 write encrypted extensions Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write certificate Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 write server certificate verify Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write finished Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 early data Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2002, ret=-1: TLSv1.3 early data Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2001, ret=1: TLSv1.3 early data Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS read finished Jul 20 15:06:20 imap-login: Debug: SSL: where=0x20, ret=1: SSLv3/TLS write session ticket Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write session ticket Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2001, ret=1: SSLv3/TLS write session ticket Jul 20 15:06:20 imap-login: Debug: SSL: where=0x2002, ret=1: SSL negotiation finished successfully Jul 20 15:06:20 auth: Debug: client in: AUTH 1 PLAIN service=imap secured=tls session=7W6sfewAb8VfWumz lip=207.180.242.208 rip=95.90.233.179 lport=143 rport=50543 real_lip=10.38.0.18 real_rip=10.40.0.0 real_rport=40242 local_name=imap.mydomain.com ssl_cipher=TLS_AES_128_GCM_SHA256 ssl_cipher_bits=128 ssl_pfs=KxANY ssl_protocol=TLSv1.3 Jul 20 15:06:20 auth: Debug: client passdb out: CONT 1 Jul 20 15:06:21 auth: Debug: client in: CONT 1 (SECRET BASE64 THINGY) (previous base64 data may contain sensitive data) Jul 20 15:06:21 auth-worker(2161): Debug: sql(myuser@mydomain.com,95.90.233.179,<7W6sfewAb8VfWumz>): query: select u.username, d.name as domain, u.password, concat('*:bytes=', quota_limit_bytes) AS userdb_quota_rule from virtual_users as u inner join virtual_domains as d on d.id = u.domain_id where u.is_active = 'Y' and u.username='myuser' and d.name='mydomain.com' Jul 20 15:06:21 auth: Debug: client passdb out: OK 1 user= myuser@mydomain.com Jul 20 15:06:21 auth: Debug: master in: REQUEST 3522953217 2180 1 467d12a6b0e9167d87e1cb1534b7a0f7 session_pid=2181 request_auth_token Jul 20 15:06:21 auth: Debug: prefetch(myuser@mydomain.com,95.90.233.179,<7W6sfewAb8VfWumz>): success Jul 20 15:06:21 auth: Debug: master userdb out: USER 3522953217 myuser@mydomain.com quota_rule=*:bytes=0 auth_token=a045a382574201aebfe9c9fa19540280369e614a Jul 20 15:06:21 imap-login: Info: Login: user=myuser@mydomain.com, method=PLAIN, rip=95.90.233.179, lip=207.180.242.208, mpid=2181, TLS, session=<7W6sfewAb8VfWumz> Jul 20 15:06:21 imap(myuser@mydomain.com)<2181><7W6sfewAb8VfWumz>: Debug: Loading modules from directory: /usr/lib/dovecot/modules Jul 20 15:06:21 imap(myuser@mydomain.com)<2181><7W6sfewAb8VfWumz>: Debug: Module loaded: /usr/lib/dovecot/modules/lib20_zlib_plugin.so Jul 20 15:06:21 imap(myuser@mydomain.com)<2181><7W6sfewAb8VfWumz>: Debug: Added userdb setting: plugin/quota_rule=*:bytes=0 Jul 20 15:06:21 imap(myuser@mydomain.com)<2181><7W6sfewAb8VfWumz>: Debug: Effective uid=8, gid=8, home=/mail/mydomain.com/myuser Jul 20 15:06:21 imap(myuser@mydomain.com)<2181><7W6sfewAb8VfWumz>: Debug: Namespace inbox: type=private, prefix=, sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes location=maildir:/mail/mydomain.com/myuser Jul 20 15:06:21 imap(myuser@mydomain.com)<2181><7W6sfewAb8VfWumz>: Debug: maildir++: root=/mail/mydomain.com/myuser, index=, indexpvt=, control=, inbox=/mail/mydomain.com/myuser, alt= Jul 20 15:06:21 imap(myuser@mydomain.com)<2181><7W6sfewAb8VfWumz>: Debug: Mailbox Drafts: Mailbox opened because: SELECT
In the thunderbird client, I wait for ages before a popup appears saying "Your draft message was not copied to your drafts folder (Drafts) due to network or file access errors. You can retry or save the draft locally to Local Folders"
I've tried searching around for information on what the problem could be, but I've not found anything that would explain this problem. Have any ideas?
Chris
On Thu, Jul 20, 2023 at 3:20 PM William Edwards wedwards@cyberfusion.nl wrote:
Op 20 jul. 2023 om 14:26 heeft Chris Thomas chris.alex.thomas@gmail.com het volgende geschreven:
Hi,
I'm getting a curious problem where if I write a draft without an attachment and click save. It'll work without any issue at all.
But if I do the same, then attach a file to the email, it'll sit there for a couple of minutes before timing out (I'm using thunderbird), it'll eventually give you a message saying
"Your draft message was not copied to your drafts folder (Drafts) due to network or file access errors."
I've got all of dovecots verbose logging turned on.
Cool! So … where is it?
I'm using dovecot as a submission server through to the postfix server to do the actual sending. All the logging is turned on there too. But I can't figure out what the problem is.
Is there anything I can look for in the logs that will help me out?
chris
dovecot mailing list -- dovecot@dovecot.org To unsubscribe send an email to dovecot-leave@dovecot.org
Here is the info from dovecot -n
dovecot.mail-server and postfix.mail-server are valid dns entries for themselves. It's running on a kubernetes cluster so those hostnames are provided by the namespace and pod name, they work too, you can ping them and it works for everything except emails with attachments, for some reason
# 2.3.4.1 (f79e8e7e4): /etc/dovecot/dovecot.conf
# Pigeonhole version 0.5.4 ()
# OS: Linux 4.9.0-9-amd64 x86_64 Debian 10.13 ext4
# Hostname: dovecot.mail-server.svc.cluster.local
auth_debug = yes
auth_debug_passwords = yes
auth_mechanisms = plain login
auth_verbose = yes
auth_verbose_passwords = yes
disable_plaintext_auth = no
first_valid_gid = 8
first_valid_uid = 8
haproxy_timeout = 5 secs
haproxy_trusted_networks = 10.0.0.0/8
hostname = s3.mydomain.com
log_path = /dev/stderr
mail_access_groups = mail
mail_debug = yes
mail_gid = mail
mail_home = /mail/%d/%n
mail_location = maildir:/mail/%d/%n
mail_plugins = " zlib"
mail_privileged_group = mail
mail_uid = mail
maildir_stat_dirs = yes
namespace inbox {
inbox = yes
location =
mailbox Drafts {
auto = subscribe
special_use = \Drafts}
mailbox Junk {
auto = subscribe
special_use = \Junk}
mailbox Sent {
auto = subscribe
special_use = \Sent}
mailbox Trash {
auto = subscribe
special_use = \Trash}
prefix =
}
passdb {
args = /etc/dovecot/dovecot-sql.conf.ext
driver = sql
}
postmaster_address = info@mydomain.com
protocols = " imap lmtp pop3 submission"
service auth-worker {
unix_listener auth-worker {
group = mail
mode = 0660
user = $default_internal_user}
user = mail
}
service auth {
user = $default_internal_user
}
service dict {
unix_listener dict {
group = mail
mode = 0660}
}
service imap-login {
inet_listener imap {
haproxy = yes
port = 143}
inet_listener imaps {
haproxy = yes
port = 993
ssl = yes}
}
service lmtp {
inet_listener lmtp {
haproxy = no
port = 24}
}
service pop3-login {
inet_listener pop3 {
haproxy = yes
port = 110}
inet_listener pop3s {
haproxy = yes
port = 995
ssl = yes}
}
service submission-login {
inet_listener submission {
haproxy = yes
port = 587}
}
ssl_cert =
ssl_dh = # hidden, use -P to show it
ssl_key = # hidden, use -P to show it
submission_relay_host = postfix.mail-server
submission_relay_port = 587
submission_relay_ssl_verify = no
userdb {
driver = prefetch
}
userdb {
args = /etc/dovecot/dovecot-sql.conf.ext
driver = sql
}
verbose_ssl = yes
protocol !indexer-worker {
mail_vsize_bg_after_count = 100
}
protocol lda {
mail_plugins = " zlib"
}
protocol imap {
mail_max_userip_connections = 50
mail_plugins = " zlib"
}
protocol lmtp {
mail_plugins = " zlib"
recipient_delimiter = +
}
protocol pop3 {
mail_max_userip_connections = 50
mail_plugins = " zlib"
}
On Thu, Jul 20, 2023 at 3:20 PM William Edwards wedwards@cyberfusion.nl wrote:
Op 20 jul. 2023 om 14:26 heeft Chris Thomas chris.alex.thomas@gmail.com het volgende geschreven:
Hi,
I'm getting a curious problem where if I write a draft without an attachment and click save. It'll work without any issue at all.
But if I do the same, then attach a file to the email, it'll sit there for a couple of minutes before timing out (I'm using thunderbird), it'll eventually give you a message saying
"Your draft message was not copied to your drafts folder (Drafts) due to network or file access errors."
I've got all of dovecots verbose logging turned on.
Cool! So … where is it?
I'm using dovecot as a submission server through to the postfix server to do the actual sending. All the logging is turned on there too. But I can't figure out what the problem is.
Is there anything I can look for in the logs that will help me out?
chris
dovecot mailing list -- dovecot@dovecot.org To unsubscribe send an email to dovecot-leave@dovecot.org
participants (2)
-
Chris Thomas
-
William Edwards