Re: Dovecot 2.4 doveadm_worker_count corrupts tab-formatted output

On 26/02/2026 15:42, Philip Iezzi via dovecot wrote:
> Some more insights about this issue... It happens every time (on different users) on quota lookup for all users:
>
> $ doveadm quota get -A > /dev/null; echo $?
> doveadm([email protected]): Error: auth-master: userdb list: User listing returned failure
> doveadm: Error: cmd quota get: Failed to iterate through some users
> 75
>
> Full debug output see [1].
>
> ...
> $ doveadm -Dv quota get -A 2>&1 | tee /tmp/debug.log
> (...)
> Feb 26 13:06:17 doveadm([email protected])<358389><>: Debug: auth-master: userdb lookup([email protected]): Started userdb lookup
> Feb 26 13:06:17 doveadm([email protected])<358389><>: Debug: auth-master: request [4211869176]: Created
> Feb 26 13:06:17 doveadm([email protected])<358389><>: Debug: auth-master: userdb lookup([email protected]): request [4211869176]: Waiting for request to complete
> Feb 26 13:06:17 doveadm([email protected])<358389><>: Debug: auth-master: conn unix:/run/dovecot/auth-userdb (pid=353974,uid=0): Sending requests
> Feb 26 13:06:17 doveadm([email protected])<358389><>: Debug: auth-master: userdb lookup([email protected]): request [4211869176]: Sent
> Feb 26 13:06:17 doveadm([email protected])<358389><>: Debug: auth-master: conn unix:/run/dovecot/auth-userdb (pid=353974,uid=0): auth input: USER	4211869176	[email protected]	home=/var/vmail/example.com/demo	uid=998	gid=998	quota_storage_size=300M
> Feb 26 13:06:17 doveadm([email protected])<358389><>: Debug: auth-master: userdb lookup([email protected]): request [4211869176]: Got reply: [email protected] home=/var/vmail/example.com/demo uid=998 gid=998 quota_storage_size=300M
> Feb 26 13:06:17 doveadm([email protected])<358389><>: Debug: auth-master: userdb lookup([email protected]): auth USER input:[email protected] home=/var/vmail/example.com/demo uid=998 gid=998 quota_storage_size=300M
> Feb 26 13:06:17 doveadm([email protected])<358389><>: Debug: auth-master: userdb lookup([email protected]): Finished userdb lookup ([email protected] home=/var/vmail/example.com/demo uid=998 gid=998 quota_storage_size=300M)
> Feb 26 13:06:17 doveadm([email protected])<358389><>: Debug: auth-master: userdb lookup([email protected]): request [4211869176]: Remove
> Feb 26 13:06:17 doveadm([email protected])<358389><>: Debug: auth-master: userdb lookup([email protected]): request [4211869176]: Finished waiting for request
> Feb 26 13:06:17 doveadm([email protected])<358389><>: Debug: auth-master: userdb lookup([email protected]): request [4211869176]: Destroy
> Feb 26 13:06:17 doveadm([email protected])<358389><>: Debug: Added setting via userdb: quota_storage_size=300M
> Feb 26 13:06:17 doveadm([email protected]): Debug: Effective uid=998, gid=998, home=/var/vmail/example.com/demo
> Feb 26 13:06:17 doveadm([email protected]): Debug: acl: Shared mailbox listing disabled: dict { .. } named list filter is missing
> Feb 26 13:06:17 doveadm([email protected]): Debug: Namespace inbox: type=private, prefix=INBOX/, sep=/, inbox=yes, hidden=no, list=yes, subscriptions=yes
> Feb 26 13:06:17 doveadm([email protected]): Debug: fs: root=/var/vmail/example.com/demo/sdbox, index=, indexpvt=, control=, inbox=, alt=
> Feb 26 13:06:17 doveadm([email protected]): Debug: acl: initializing backend vfile
> Feb 26 13:06:17 doveadm([email protected]): Debug: acl: acl username [email protected]
> Feb 26 13:06:17 doveadm([email protected]): Debug: acl: owner = yes
> Feb 26 13:06:17 doveadm([email protected]): Debug: acl: ignore = no
> Feb 26 13:06:17 doveadm([email protected]): Debug: acl: vfile: Deprecated Global ACL file: /etc/dovecot/dovecot-acl
> Feb 26 13:06:17 doveadm([email protected]): Debug: Namespace : type=private, prefix=, sep=, inbox=no, hidden=yes, list=no, subscriptions=no
> Feb 26 13:06:17 doveadm([email protected]): Debug: none: root=/var/vmail/example.com/demo/sdbox, index=, indexpvt=, control=, inbox=, alt=
> Feb 26 13:06:17 doveadm([email protected]): Debug: quota-count: quota_over_status check: quota_over_mask unset - skipping
> Feb 26 13:06:17 doveadm([email protected]): Debug: Mailbox INBOX: Mailbox opened
> Feb 26 13:06:17 doveadm([email protected]): Debug: User session is finished
> Feb 26 13:06:17 doveadm([email protected]): Debug: auth-master: conn unix:/run/dovecot/auth-userdb (pid=353974,uid=0): auth input: DONE	2802712577	fail
> Feb 26 13:06:17 doveadm([email protected]): Debug: auth-master: userdb list: request [2802712577]: Got reply: DONE fail
> Feb 26 13:06:17 doveadm([email protected]): Error: auth-master: userdb list: User listing returned failure
> Feb 26 13:06:17 doveadm([email protected]): Debug: auth-master: userdb list: request [2802712577]: Remove
> Feb 26 13:06:17 doveadm([email protected]): Debug: auth-master: userdb list: request [2802712577]: Destroy
> Feb 26 13:06:17 doveadm([email protected]): Debug: auth-master: userdb list: Listing users failed
> Feb 26 13:06:17 doveadm([email protected]): Debug: auth-master: conn unix:/run/dovecot/auth-userdb (pid=353974,uid=0): Disconnected: Connection closed (fd=9)
> Feb 26 13:06:17 doveadm([email protected]): Debug: auth-master: conn unix:/run/dovecot/auth-userdb (pid=353974,uid=0): Disconnected from auth service
> Feb 26 13:06:17 doveadm: Error: cmd quota get: Failed to iterate through some users
> Feb 26 13:06:17 doveadm: Debug: auth-master: conn unix:/run/dovecot/auth-userdb (pid=353974,uid=0): Disconnected: Connection closed (fd=10)
> Feb 26 13:06:17 doveadm: Debug: auth-master: conn unix:/run/dovecot/auth-userdb (pid=353974,uid=0): Disconnected from auth service
>
>
>
Hi

I could be wrong but is this debug output complete? It looks like 
request 2802712577 is failing, but the previous logging relating to 
[email protected] seems to be from request 4211869176.

Also, though I don't believe either it is related to the issue:

What is the reason for returning quota_storage_size in the 
iterate_query? It shouldn't matter if you return extra fields, but why 
do it?

Your iterate query can potentially return a subset of the users compared 
to your user query due to differing where conditions.

John

_______________________________________________
dovecot mailing list -- [email protected]
To unsubscribe send an email to [email protected]