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(myu...@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=
> myu...@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(myu...@mydomain.com,95.90.233.179,<8NppU+wAq8VfWumz>):
> success
Jul 20 14:54:32 auth: Debug: master userdb out: USER 933232641
> myu...@mydomain.com quota_rule=*:bytes=0
> auth_token=ecc46a3e8110c8878e4ecc6bf3a6b0031d9d2cc4
Jul 20 14:54:32 imap-login: Info: Login: user=<myu...@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(myu...@mydomain.com)<2105><8NppU+wAq8VfWumz>: Debug:
> Loading modules from directory: /usr/lib/dovecot/modules
Jul 20 14:54:32 imap(myu...@mydomain.com)<2105><8NppU+wAq8VfWumz>: Debug:
> Module loaded: /usr/lib/dovecot/modules/lib20_zlib_plugin.so
Jul 20 14:54:32 imap(myu...@mydomain.com)<2105><8NppU+wAq8VfWumz>: Debug:
> Added userdb setting: plugin/quota_rule=*:bytes=0
Jul 20 14:54:32 imap(myu...@mydomain.com)<2105><8NppU+wAq8VfWumz>: Debug:
> Effective uid=8, gid=8, home=/mail/mydomain.com/myuser
Jul 20 14:54:32 imap(myu...@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(myu...@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(myu...@mydomain.com)<2105><8NppU+wAq8VfWumz>: Debug:
> Mailbox Drafts: Mailbox opened because: SELECT
Jul 20 14:54:32 imap(myu...@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(myu...@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=
> myu...@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(myu...@mydomain.com,95.90.233.179,<7W6sfewAb8VfWumz>):
> success
> Jul 20 15:06:21 auth: Debug: master userdb out: USER 3522953217
> myu...@mydomain.com quota_rule=*:bytes=0
> auth_token=a045a382574201aebfe9c9fa19540280369e614a
> Jul 20 15:06:21 imap-login: Info: Login: user=<myu...@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(myu...@mydomain.com)<2181><7W6sfewAb8VfWumz>: Debug:
> Loading modules from directory: /usr/lib/dovecot/modules
> Jul 20 15:06:21 imap(myu...@mydomain.com)<2181><7W6sfewAb8VfWumz>: Debug:
> Module loaded: /usr/lib/dovecot/modules/lib20_zlib_plugin.so
> Jul 20 15:06:21 imap(myu...@mydomain.com)<2181><7W6sfewAb8VfWumz>: Debug:
> Added userdb setting: plugin/quota_rule=*:bytes=0
> Jul 20 15:06:21 imap(myu...@mydomain.com)<2181><7W6sfewAb8VfWumz>: Debug:
> Effective uid=8, gid=8, home=/mail/mydomain.com/myuser
> Jul 20 15:06:21 imap(myu...@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(myu...@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(myu...@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 <wedwa...@cyberfusion.nl>
wrote:
>
> > Op 20 jul. 2023 om 14:26 heeft Chris Thomas <chris.alex.tho...@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-le...@dovecot.org
>
>
_______________________________________________
dovecot mailing list -- dovecot@dovecot.org
To unsubscribe send an email to dovecot-le...@dovecot.org
