1 Topic by pragpot

  • pragpot
  • Member
  • Offline
  • Registered: 2016-11-18
  • Posts: 25

Topic: Anvil and quota-warning error in dovecot.log file.

==== REQUIRED BASIC INFO OF YOUR IREDMAIL SERVER ====
- iRedMail version (check /etc/iredmail-release): 0.9.9
- Deployed with iRedMail Easy or the downloadable installer? Downloadable installer
- Linux/BSD distribution name and version: Ubuntu 18.04.2 LTS
- Store mail accounts in which backend (LDAP/MySQL/PGSQL): PGSQL edition
- Web server (Apache or Nginx): Nginx
- Manage mail accounts with iRedAdmin-Pro? Yes
- [IMPORTANT] Related original log or error message is required if you're experiencing an issue.
====

Hi,
Email clients (Thunderbird and Microsoft Outlook) are  losing connection intermittently to iRedMail Server via Imap. Several errors found in dovecot.log

IredAdminPro-SQL-3.4 installed with latest patch.

Errors in /var/log/dovecot/dovecot.log

    May  8 13:59:56 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files
    May  8 14:00:01 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files
    May  8 14:00:01 imail2 dovecot: message repeated 3 times: [ anvil: Error: net_accept() failed: Too many open files]
    May  8 14:00:01 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files
    May  8 14:00:01 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files
    May  8 14:00:05 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files
    May  8 14:00:05 imail2 dovecot: message repeated 2 times: [ anvil: Error: net_accept() failed: Too many open files]
    May  8 14:00:09 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files
    May  8 14:00:19 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files
    May  8 14:00:19 imail2 dovecot: message repeated 4 times: [ anvil: Error: net_accept() failed: Too many open files]
    May  8 14:00:20 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files
    May  8 14:00:33 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files
    May  8 14:00:33 imail2 dovecot: message repeated 5 times: [ anvil: Error: net_accept() failed: Too many open files]
    May  8 14:00:39 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files
    May  8 14:00:39 imail2 dovecot: message repeated 4 times: [ anvil: Error: net_accept() failed: Too many open files]
    May  8 14:00:47 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files
    May  8 14:00:48 imail2 dovecot: message repeated 4 times: [ anvil: Error: net_accept() failed: Too many open files]
    May  8 14:00:48 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files
    May  8 14:00:48 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files
    May  8 14:00:52 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 1598 returned error 67
    May  8 14:00:58 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files
    May  8 14:00:58 imail2 dovecot: message repeated 7 times: [ anvil: Error: net_accept() failed: Too many open files]
    May  8 14:00:58 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files
    May  8 14:01:01 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files
    May  8 14:01:10 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files
    May  8 14:01:10 imail2 dovecot: message repeated 3 times: [ anvil: Error: net_accept() failed: Too many open files]
    May  8 14:01:16 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files
    May  8 14:01:16 imail2 dovecot: message repeated 6 times: [ anvil: Error: net_accept() failed: Too many open files]
    May  8 14:01:17 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files
    May  8 14:01:18 imail2 dovecot: anvil: Error: net_accept() failed: Too many open files

Extract of dovecot -a for the defined services.
    service anvil {
      chroot = empty
      client_limit = 10400
      drop_priv_before_exec = no
      executable = anvil
      extra_groups =
      group =
      idle_kill = 4294967295 secs
      privileged_group =
      process_limit = 1
      process_min_avail = 1
      protocol =
      service_count = 0
      type = anvil
      unix_listener anvil-auth-penalty {
        group =
        mode = 0600
        user =
      }
      unix_listener anvil {
        group =
        mode = 0600
        user =
      }
      user = $default_internal_user
      vsz_limit = 18446744073709551615 B
    }

    service imap-login {
      chroot = login
      client_limit = 0
      drop_priv_before_exec = no
      executable = imap-login
      extra_groups =
      group =
      idle_kill = 0
      inet_listener imap {
        address =
        haproxy = no
        port = 143
        reuse_port = no
        ssl = no
      }
      inet_listener imaps {
        address =
        haproxy = no
        port = 993
        reuse_port = no
        ssl = yes
      }
      privileged_group =
      process_limit = 5000
      process_min_avail = 0
      protocol = imap
      service_count = 1
      type = login
      user = $default_login_user
      vsz_limit = 18446744073709551615 B
    }
    service imap-urlauth-login {
      chroot = token-login
      client_limit = 0
      drop_priv_before_exec = no
      executable = imap-urlauth-login
      extra_groups =
      group =
      idle_kill = 0
      privileged_group =
      process_limit = 0
      process_min_avail = 0
      protocol = imap
      service_count = 1
      type = login
      unix_listener imap-urlauth {
        group =
        mode = 0666
        user =
      }
      user = $default_login_user
      vsz_limit = 18446744073709551615 B
    }
    service imap-urlauth-worker {
      chroot =
      client_limit = 1
      drop_priv_before_exec = no
      executable = imap-urlauth-worker
      extra_groups =
      group =
      idle_kill = 0
      privileged_group =
      process_limit = 1024
      process_min_avail = 0
      protocol = imap
      service_count = 1
      type =
      unix_listener imap-urlauth-worker {
        group =
        mode = 0600
        user = $default_internal_user
      }
      user =
      vsz_limit = 18446744073709551615 B
    }
    service imap-urlauth {
      chroot =
      client_limit = 1
      drop_priv_before_exec = no
      executable = imap-urlauth
      extra_groups =
      group =
      idle_kill = 0
      privileged_group =
      process_limit = 1024
      process_min_avail = 0
      protocol = imap
      service_count = 1
      type =
      unix_listener token-login/imap-urlauth {
        group =
        mode = 0666
        user =
      }
      user = $default_internal_user
      vsz_limit = 18446744073709551615 B
    }
    service imap {
      chroot =
      client_limit = 1
      drop_priv_before_exec = no
      executable = imap
      extra_groups =
      group =
      idle_kill = 0
      privileged_group =
      process_limit = 10000
      process_min_avail = 0
      protocol = imap
      service_count = 1
      type =
      unix_listener imap-master {
        group =
        mode = 0600
        user =
      }
      unix_listener login/imap {
        group =
        mode = 0666
        user =
      }
      user =
      vsz_limit = 18446744073709551615 B
    }

    service pop3-login {
      chroot = login
      client_limit = 0
      drop_priv_before_exec = no
      executable = pop3-login
      extra_groups =
      group =
      idle_kill = 0
      inet_listener pop3 {
        address =
        haproxy = no
        port = 110
        reuse_port = no
        ssl = no
      }
      inet_listener pop3s {
        address =
        haproxy = no
        port = 995
        reuse_port = no
        ssl = yes
      }
      privileged_group =
      process_limit = 0
      process_min_avail = 0
      protocol = pop3
      service_count = 1
      type = login
      user = $default_login_user
      vsz_limit = 18446744073709551615 B
    }
    service pop3 {
      chroot =
      client_limit = 1
      drop_priv_before_exec = no
      executable = pop3
      extra_groups =
      group =
      idle_kill = 0
      privileged_group =
      process_limit = 1024
      process_min_avail = 0
      protocol = pop3
      service_count = 1
      type =
      unix_listener login/pop3 {
        group =
        mode = 0666
        user =
      }
      user =
      vsz_limit = 18446744073709551615 B
    }
    service quota-warning {
      chroot =
      client_limit = 0
      drop_priv_before_exec = no
      executable = script /usr/local/bin/dovecot-quota-warning.sh
      extra_groups =
      group =
      idle_kill = 0
      privileged_group =
      process_limit = 0
      process_min_avail = 0
      protocol =
      service_count = 0
      type =
      unix_listener quota-warning {
        group = vmail
        mode = 0660
        user = vmail
      }
      user =
      vsz_limit = 18446744073709551615 B
    }

----

Spider Email Archiver: On-Premises, lightweight email archiving software developed by iRedMail team. Supports Amazon S3 compatible storage and custom branding.

2 Reply by ZhangHuangbin

  • ZhangHuangbin
  • ZhangHuangbin
  • iRedMail Developers
  • Offline
  • Registered: 2009-05-06
  • Posts: 31,088

Re: Anvil and quota-warning error in dovecot.log file.

Try this: Create file /etc/systemd/system/dovecot.service.d/override.conf with content below, then restart Dovecot service.

[Service]
LimitNOFILE=infinity
TasksMax=infinity

3 Reply by pragpot

  • pragpot
  • Member
  • Offline
  • Registered: 2016-11-18
  • Posts: 25

Re: Anvil and quota-warning error in dovecot.log file.

Applied the override.conf file and the "dovecot: anvil: Error: net_accept() failed: Too many open files" error has been resolved. I now have a new error in the log as per below.

May  9 14:31:44 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 3643 returned error 67
May  9 14:35:50 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 5930 returned error 67
May  9 14:42:30 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 10263 returned error 67
May  9 16:02:48 imail2 dovecot: quota-warning: Error: cat: write error: Broken pipe
May  9 16:02:48 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 22557 returned error 67
May  9 16:21:49 imail2 dovecot: quota-warning: Error: cat: write error: Broken pipe
May  9 16:21:49 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 401 returned error 67

4 Reply by ZhangHuangbin

  • ZhangHuangbin
  • ZhangHuangbin
  • iRedMail Developers
  • Offline
  • Registered: 2009-05-06
  • Posts: 31,088

Re: Anvil and quota-warning error in dovecot.log file.

pragpot wrote:

May  9 16:21:49 imail2 dovecot: quota-warning: Error: cat: write error: Broken pipe

How busy is your server?

Seems the quota warning shell script doesn't work well.

5 Reply by pragpot

  • pragpot
  • Member
  • Offline
  • Registered: 2016-11-18
  • Posts: 25

Re: Anvil and quota-warning error in dovecot.log file.

ZhangHuangbin wrote:
pragpot wrote:

May  9 16:21:49 imail2 dovecot: quota-warning: Error: cat: write error: Broken pipe

How busy is your server?

Seems the quota warning shell script doesn't work well.


Server is hosting 5 domains with arround 850 mailbox. Average server load is as per below with a few CPU peaks at 70 %


top - 08:08:13 up 23:43,  1 user,  load average: 1.67, 2.02, 1.43
Tasks: 2434 total,   1 running, 2349 sleeping,   0 stopped,   0 zombie
%Cpu(s): 20.4 us,  6.4 sy,  0.0 ni, 70.6 id,  1.3 wa,  0.0 hi,  1.3 si,  0.0 st
KiB Mem : 12297148 total,   354956 free,  4670860 used,  7271332 buff/cache
KiB Swap:  2097148 total,  2096624 free,      524 used.  7092080 avail Mem

  PID USER      PR  NI    VIRT    RES    SHR S  %CPU %MEM     TIME+ COMMAND
1281 clamav    20   0 1917712 865216  32984 S  47.8  7.0  31:58.40 clamd
4302 amavis    20   0  326372 135296   7492 S  11.4  1.1   0:00.52 /usr/sbin/amavi
4412 root      20   0   29504  29136    152 S   7.9  0.2   5:52.55 apps.plugin
1968 root      20   0   45400   6652   3408 R   4.7  0.1   0:16.09 top
32082 postfix   20   0   96800  10684   9352 S   3.2  0.1   0:00.91 smtpd
1909 root      20   0 1185516  22152   9528 S   2.5  0.2  34:53.71 fail2ban-server
2637 postfix   20   0   78616   5604   4960 S   1.6  0.0   0:00.57 cleanup
3869 postgres  20   0  413580  29236  24664 S   0.9  0.2  10:35.38 postgres
1910 vmail     20   0   40696   6288   4400 S   0.6  0.1   0:01.08 imap
2149 dovenull  20   0   21544   5628   5004 S   0.6  0.0   0:00.24 imap-login
4470 dovenull  20   0   21544   5672   5048 S   0.6  0.0   0:00.04 imap-login
4500 dovenull  20   0   21544   5624   5000 S   0.6  0.0   0:00.02 imap-login
4502 dovenull  20   0   21544   5700   5080 S   0.6  0.0   0:00.02 imap-login
4504 dovenull  20   0   21536   5648   5020 S   0.6  0.0   0:00.02 pop3-login

6 Reply by ZhangHuangbin

  • ZhangHuangbin
  • ZhangHuangbin
  • iRedMail Developers
  • Offline
  • Registered: 2009-05-06
  • Posts: 31,088

Re: Anvil and quota-warning error in dovecot.log file.

Please enable debug mode in Dovecot, try to get more detailed log lines about this error.

7 Reply by pragpot

  • pragpot
  • Member
  • Offline
  • Registered: 2016-11-18
  • Posts: 25

Re: Anvil and quota-warning error in dovecot.log file.

Hi Zhang,
I have enabled the debug mode and gathered more logs. A few log lines are below. Where can I upload the full log?

May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Loading modules from directory: /usr/lib/dovecot/modules
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Module loaded: /usr/lib/dovecot/modules/lib01_acl_plugin.so
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Module loaded: /usr/lib/dovecot/modules/lib10_quota_plugin.so
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Module loaded: /usr/lib/dovecot/modules/lib15_notify_plugin.so
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Module loaded: /usr/lib/dovecot/modules/lib20_mail_log_plugin.so
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Module loaded: /usr/lib/dovecot/modules/lib20_mailbox_alias_plugin.so
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Module loaded: /usr/lib/dovecot/modules/lib90_sieve_plugin.so
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Module loaded: /usr/lib/dovecot/modules/lib90_stats_plugin.so
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: auth USER input: user@domain.com master_user=user@domain.com home=/var/vmail/vmail1/domain.com/r/g/o/user-2017.09.18.11.00.02/ mail=maildir:~/Maildir/ quota_rule=*:bytes=314572800
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Added userdb setting: mail=maildir:~/Maildir/
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Added userdb setting: plugin/master_user=user@domain.com
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Added userdb setting: plugin/quota_rule=*:bytes=314572800
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Effective uid=2000, gid=2000, home=/var/vmail/vmail1/domain.com/r/g/o/user-2017.09.18.11.00.02/
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Quota root: name=user backend=dict args=:proxy::quotadict
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Quota rule: root=user mailbox=* bytes=314572800 messages=0
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Quota warning: bytes=314572800 (100%) messages=0 reverse=no command=quota-warning 100 user@domain.com
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Quota warning: bytes=298844160 (95%) messages=0 reverse=no command=quota-warning 95 user@domain.com
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Quota warning: bytes=283115520 (90%) messages=0 reverse=no command=quota-warning 90 user@domain.com
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Quota warning: bytes=267386880 (85%) messages=0 reverse=no command=quota-warning 85 user@domain.com
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Quota grace: root=user bytes=31457280 (10%)
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: dict quota: user=user@domain.com, uri=proxy::quotadict, noenforcing=0
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Namespace : type=private, prefix=, sep=/, inbox=yes, hidden=no, list=yes, subscriptions=yes location=maildir:~/Maildir/
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: maildir++: root=/var/vmail/vmail1/domain.com/r/g/o/user-2017.09.18.11.00.02//Maildir, index=, indexpvt=, control=, inbox=/var/vmail/vmail1/domain.com/r/g/o/user-2017.09.18.11.00.02//Maildir, alt=
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: acl: initializing backend with data: vfile
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: acl: acl username = user@domain.com
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: acl: owner = 1
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: acl vfile: Global ACLs disabled
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Namespace : type=shared, prefix=Shared/%u/, sep=/, inbox=no, hidden=no, list=children, subscriptions=yes location=maildir:%Lh/Maildir/:INDEX=%Lh/Maildir/Shared/%Ld/%Ln
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: shared: root=/var/run/dovecot, index=, indexpvt=, control=, inbox=, alt=
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: acl: initializing backend with data: vfile
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: acl: acl username = user@domain.com
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: acl: owner = 0
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: acl vfile: Global ACLs disabled
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: quota: quota_over_flag check: quota_over_script unset - skipping
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Quota rule: root=user mailbox=* bytes=1073741824 messages=0
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Quota warning: bytes=1073741824 (100%) messages=0 reverse=no command=quota-warning 100 raw mail user
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Quota warning: bytes=1020054732 (95%) messages=0 reverse=no command=quota-warning 95 raw mail user
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Quota warning: bytes=966367641 (90%) messages=0 reverse=no command=quota-warning 90 raw mail user
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Quota warning: bytes=912680550 (85%) messages=0 reverse=no command=quota-warning 85 raw mail user
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Quota grace: root=user bytes=107374182 (10%)
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: dict quota: user=raw mail user, uri=proxy::quotadict, noenforcing=0
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: none: root=, index=, indexpvt=, control=, inbox=, alt=
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: quota: quota_over_flag check: quota_over_script unset - skipping
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Destination address: user@domain.com (source: user@hostname)
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: sieve: Pigeonhole version 0.4.21 (92477967) initializing
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: sieve: file storage: Using active Sieve script path: /var/vmail/vmail1/domain.com/r/g/o/user-2017.09.18.11.00.02/sieve/dovecot.sieve
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: sieve: file storage: Using script storage path: /var/vmail/vmail1/domain.com/r/g/o/user-2017.09.18.11.00.02//sieve
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: sieve: file storage: Relative path to sieve storage in active link:
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: sieve: file storage: Using Sieve script path: /var/vmail/vmail1/domain.com/r/g/o/user-2017.09.18.11.00.02/sieve/dovecot.sieve
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: sieve: file script: Opened script `managesieve' from `/var/vmail/vmail1/domain.com/r/g/o/user-2017.09.18.11.00.02/sieve/dovecot.sieve'
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: sieve: file storage: Using Sieve script path: /var/vmail/sieve/dovecot.sieve
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: sieve: file script: Opened script `dovecot' from `/var/vmail/sieve/dovecot.sieve'
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: sieve: Executed before user's personal Sieve script(1): /var/vmail/sieve/dovecot.sieve
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: sieve: Using the following location for user's Sieve script: /var/vmail/vmail1/domain.com/r/g/o/user-2017.09.18.11.00.02/sieve/dovecot.sieve
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Mailbox stdin: Opened mail UID=1 because: header Message-ID (Cache file is unusable)
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: sieve: Opening script 1 of 2 from `/var/vmail/sieve/dovecot.sieve'
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: sieve: Loading script /var/vmail/sieve/dovecot.sieve
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: sieve: Script binary /var/vmail/sieve/dovecot.svbin successfully loaded
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: sieve: binary save: not saving binary /var/vmail/sieve/dovecot.svbin, because it is already stored
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: sieve: Executing script from `/var/vmail/sieve/dovecot.svbin'
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Mailbox stdin: Opened mail UID=1 because: header X-Spam-Flag (Cache file is unusable)
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: sieve: Opening script 2 of 2 from `/var/vmail/vmail1/domain.com/r/g/o/user-2017.09.18.11.00.02/sieve/dovecot.sieve'
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: sieve: Script binary /var/vmail/vmail1/domain.com/r/g/o/user-2017.09.18.11.00.02/sieve/dovecot.svbin successfully loaded
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: sieve: binary save: not saving binary /var/vmail/vmail1/domain.com/r/g/o/user-2017.09.18.11.00.02/sieve/dovecot.svbin, because it is already stored
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: sieve: Executing script from `/var/vmail/vmail1/domain.com/r/g/o/user-2017.09.18.11.00.02/sieve/dovecot.svbin'
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: INBOX: Mailbox opened because: lib-lda delivery
May 14 15:48:30 imail2 dovecot: lda(user@domain.com): Debug: Mailbox stdin: Opened mail UID=1 because: copying

8 Reply by ZhangHuangbin

  • ZhangHuangbin
  • ZhangHuangbin
  • iRedMail Developers
  • Offline
  • Registered: 2009-05-06
  • Posts: 31,088

Re: Anvil and quota-warning error in dovecot.log file.

I didn't see any "cat: write error:" error in pasted debug log, did you copy the wrong log lines?

pragpot wrote:

Where can I upload the full log?

Not necessary to upload full log file, just extract relevant (full + original) log and paste in forum post.

9 Reply by pragpot

  • pragpot
  • Member
  • Offline
  • Registered: 2016-11-18
  • Posts: 25

Re: Anvil and quota-warning error in dovecot.log file.

Here i sthe relevant error with the write error below.

May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: message repeated 2 times: [ imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)]
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: imap: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: anvil: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:31 imail2 dovecot: log: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 08:13:32 imail2 dovecot: master: Dovecot v2.2.33.2 (d6601f4ec) starting up for pop3, imap, sieve, lmtp (core dumps disabled)
May 13 09:43:21 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 25237 returned error 67
May 13 09:43:28 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 25316 returned error 67
May 13 09:44:35 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 25758 returned error 67
May 13 09:45:12 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 26261 returned error 67
May 13 09:45:15 imail2 dovecot: quota-warning: Error: cat: write error: Broken pipe
May 13 09:45:15 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 26367 returned error 67
May 13 09:48:12 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 27500 returned error 67
May 13 09:49:00 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 27642 returned error 67
May 13 09:53:31 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 29081 returned error 67
May 13 11:09:10 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 4321 returned error 67
May 13 11:15:40 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 9637 returned error 67
May 13 12:08:51 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 3991 returned error 67
May 13 12:10:11 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 4462 returned error 67
May 13 12:10:12 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 4472 returned error 67
May 13 14:56:30 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 10976 returned error 67
May 13 14:56:41 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 11076 returned error 67
May 13 14:56:41 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 11086 returned error 67
May 13 14:56:50 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 11121 returned error 67
May 13 14:56:55 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 11143 returned error 67
May 13 14:56:59 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 11179 returned error 67
May 13 15:10:56 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 16318 returned error 67
May 13 15:11:07 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 16716 returned error 67
May 13 15:20:31 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 20052 returned error 67
May 13 15:27:27 imail2 dovecot: master: Warning: Killed with signal 15 (by pid=22421 uid=0 code=kill)
May 13 15:27:28 imail2 dovecot: log: Warning: Killed with signal 15 (by pid=1 uid=0 code=kill)
May 13 15:27:28 imail2 dovecot: master: Dovecot v2.2.33.2 (d6601f4ec) starting up for pop3, imap, sieve, lmtp (core dumps disabled)
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Loading modules from directory: /usr/lib/dovecot/modules
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Module loaded: /usr/lib/dovecot/modules/lib01_acl_plugin.so
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Module loaded: /usr/lib/dovecot/modules/lib02_imap_acl_plugin.so
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Module loaded: /usr/lib/dovecot/modules/lib10_quota_plugin.so
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Module loaded: /usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Module loaded: /usr/lib/dovecot/modules/lib15_notify_plugin.so
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Module loaded: /usr/lib/dovecot/modules/lib20_mail_log_plugin.so
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Module loaded: /usr/lib/dovecot/modules/lib20_mailbox_alias_plugin.so
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Module loaded: /usr/lib/dovecot/modules/lib90_stats_plugin.so
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Module loaded: /usr/lib/dovecot/modules/lib95_imap_stats_plugin.so
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Added userdb setting: mail=maildir:~/Maildir/
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Added userdb setting: plugin/master_user=bbundhoo@mk.cmt.mu
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Added userdb setting: plugin/quota_rule=*:bytes=209715200
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Effective uid=2000, gid=2000, home=/var/vmail/vmail1/mk.cmt.mu/b/b/u/bbundhoo-2017.08.31.11.28.09/
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Quota root: name=user backend=dict args=:proxy::quotadict
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Quota rule: root=user mailbox=* bytes=209715200 messages=0
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Quota warning: bytes=209715200 (100%) messages=0 reverse=no command=quota-warning 100 bbundhoo@mk.cmt.mu
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Quota warning: bytes=199229440 (95%) messages=0 reverse=no command=quota-warning 95 bbundhoo@mk.cmt.mu
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Quota warning: bytes=188743680 (90%) messages=0 reverse=no command=quota-warning 90 bbundhoo@mk.cmt.mu
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Quota warning: bytes=178257920 (85%) messages=0 reverse=no command=quota-warning 85 bbundhoo@mk.cmt.mu
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Quota grace: root=user bytes=20971520 (10%)
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: dict quota: user=bbundhoo@mk.cmt.mu, uri=proxy::quotadict, noenforcing=0
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Namespace : type=private, prefix=, sep=/, inbox=yes, hidden=no, list=yes, subscriptions=yes location=maildir:~/Maildir/
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: maildir++: root=/var/vmail/vmail1/mk.cmt.mu/b/b/u/bbundhoo-2017.08.31.11.28.09//Maildir, index=, indexpvt=, control=, inbox=/var/vmail/vmail1/mk.cmt.mu/b/b/u/bbundhoo-2017.08.31.11.28.09//Maildir, alt=
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: acl: initializing backend with data: vfile
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: acl: acl username = bbundhoo@mk.cmt.mu
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: acl: owner = 1
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: acl vfile: Global ACLs disabled
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Namespace : type=shared, prefix=Shared/%u/, sep=/, inbox=no, hidden=no, list=children, subscriptions=yes location=maildir:%Lh/Maildir/:INDEX=%Lh/Maildir/Shared/%Ld/%Ln
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: shared: root=/var/run/dovecot, index=, indexpvt=, control=, inbox=, alt=
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: acl: initializing backend with data: vfile
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: acl: acl username = bbundhoo@mk.cmt.mu
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: acl: owner = 0
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: acl vfile: Global ACLs disabled
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: quota: quota_over_flag check: quota_over_script unset - skipping
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Sent: Mailbox opened because: SELECT
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: acl vfile: file /var/vmail/vmail1/mk.cmt.mu/b/b/u/bbundhoo-2017.08.31.11.28.09//Maildir/.Sent/dovecot-acl not found
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Trash: Mailbox opened because: UID MOVE
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: acl vfile: file /var/vmail/vmail1/mk.cmt.mu/b/b/u/bbundhoo-2017.08.31.11.28.09//Maildir/.Trash/dovecot-acl not found
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Trash: Mailbox opened because: STATUS
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Loading modules from directory: /usr/lib/dovecot/modules
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Module loaded: /usr/lib/dovecot/modules/lib01_acl_plugin.so
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Module loaded: /usr/lib/dovecot/modules/lib02_imap_acl_plugin.so
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Module loaded: /usr/lib/dovecot/modules/lib10_quota_plugin.so
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Module loaded: /usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Module loaded: /usr/lib/dovecot/modules/lib15_notify_plugin.so
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Module loaded: /usr/lib/dovecot/modules/lib20_mail_log_plugin.so
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Module loaded: /usr/lib/dovecot/modules/lib20_mailbox_alias_plugin.so
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Module loaded: /usr/lib/dovecot/modules/lib90_stats_plugin.so
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Module loaded: /usr/lib/dovecot/modules/lib95_imap_stats_plugin.so
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Added userdb setting: mail=maildir:~/Maildir/
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Added userdb setting: plugin/master_user=bbundhoo@mk.cmt.mu
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Added userdb setting: plugin/quota_rule=*:bytes=209715200
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Effective uid=2000, gid=2000, home=/var/vmail/vmail1/mk.cmt.mu/b/b/u/bbundhoo-2017.08.31.11.28.09/
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Quota root: name=user backend=dict args=:proxy::quotadict
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Quota rule: root=user mailbox=* bytes=209715200 messages=0
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Quota warning: bytes=209715200 (100%) messages=0 reverse=no command=quota-warning 100 bbundhoo@mk.cmt.mu
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Quota warning: bytes=199229440 (95%) messages=0 reverse=no command=quota-warning 95 bbundhoo@mk.cmt.mu
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Quota warning: bytes=188743680 (90%) messages=0 reverse=no command=quota-warning 90 bbundhoo@mk.cmt.mu
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Quota warning: bytes=178257920 (85%) messages=0 reverse=no command=quota-warning 85 bbundhoo@mk.cmt.mu
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Quota grace: root=user bytes=20971520 (10%)
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: dict quota: user=bbundhoo@mk.cmt.mu, uri=proxy::quotadict, noenforcing=0
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Namespace : type=private, prefix=, sep=/, inbox=yes, hidden=no, list=yes, subscriptions=yes location=maildir:~/Maildir/
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: maildir++: root=/var/vmail/vmail1/mk.cmt.mu/b/b/u/bbundhoo-2017.08.31.11.28.09//Maildir, index=, indexpvt=, control=, inbox=/var/vmail/vmail1/mk.cmt.mu/b/b/u/bbundhoo-2017.08.31.11.28.09//Maildir, alt=
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: acl: initializing backend with data: vfile
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: acl: acl username = bbundhoo@mk.cmt.mu
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: acl: owner = 1
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: acl vfile: Global ACLs disabled
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Namespace : type=shared, prefix=Shared/%u/, sep=/, inbox=no, hidden=no, list=children, subscriptions=yes location=maildir:%Lh/Maildir/:INDEX=%Lh/Maildir/Shared/%Ld/%Ln
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: shared: root=/var/run/dovecot, index=, indexpvt=, control=, inbox=, alt=
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: acl: initializing backend with data: vfile
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: acl: acl username = bbundhoo@mk.cmt.mu
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: acl: owner = 0
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: acl vfile: Global ACLs disabled
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: quota: quota_over_flag check: quota_over_script unset - skipping
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Sent: Mailbox opened because: SELECT
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: acl vfile: file /var/vmail/vmail1/mk.cmt.mu/b/b/u/bbundhoo-2017.08.31.11.28.09//Maildir/.Sent/dovecot-acl not found
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Mailbox Sent: Opened mail UID=2895 because: prefetch
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Mailbox Sent: Opened mail UID=2895 because: access
May 13 15:27:28 imail2 dovecot: imap(bbundhoo@mk.cmt.mu): Debug: Mailbox Sent: Opened mail UID=2895 because: MIME part
May 13 15:27:28 imail2 dovecot: imap(ltkgreywarehouse@fm.cmt.mu): Debug: Loading modules from directory: /usr/lib/dovecot/modules
May 13 15:27:28 imail2 dovecot: imap(ltkgreywarehouse@fm.cmt.mu): Debug: Module loaded: /usr/lib/dovecot/modules/lib01_acl_plugin.so

10 Reply by ZhangHuangbin

  • ZhangHuangbin
  • ZhangHuangbin
  • iRedMail Developers
  • Offline
  • Registered: 2009-05-06
  • Posts: 31,088

Re: Anvil and quota-warning error in dovecot.log file.

All log lines were logged on May 13, did you get any error AFTER created file "/etc/systemd/system/dovecot.service.d/override.conf"?

I suppose the issue was related and it's been fixed by /etc/systemd/system/dovecot.service.d/override.conf.

11 Reply by pragpot

  • pragpot
  • Member
  • Offline
  • Registered: 2016-11-18
  • Posts: 25

Re: Anvil and quota-warning error in dovecot.log file.

I Still have the below errors occasionally. (note that debug has been disabled)

May 15 12:35:42 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 9571 returned error 67
May 15 12:40:09 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 10921 returned error 67
May 15 13:56:44 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 17856 returned error 67
May 15 13:56:45 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 17868 returned error 67
May 15 13:57:04 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 18031 returned error 67
May 15 13:57:22 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 18204 returned error 67
May 15 13:57:23 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 18221 returned error 67
May 15 13:57:47 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 18273 returned error 67
May 15 13:58:10 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 18366 returned error 67
May 15 13:58:19 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 18401 returned error 67
May 15 13:58:35 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 18443 returned error 67
May 15 13:58:58 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 18519 returned error 67
May 15 13:59:09 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 18957 returned error 67
May 15 13:59:17 imail2 dovecot: quota-warning: Error: cat: write error: Broken pipe
May 15 13:59:17 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 19380 returned error 67
May 15 13:59:31 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 19633 returned error 67
May 15 13:59:32 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 19650 returned error 67
May 15 13:59:49 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 19721 returned error 67
May 15 13:59:51 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 19731 returned error 67
May 15 14:00:11 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 20360 returned error 67
May 15 14:00:30 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 20467 returned error 67
May 15 14:00:46 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 20603 returned error 67
May 15 14:01:58 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 21365 returned error 67
May 15 14:02:30 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 22174 returned error 67
May 15 14:02:53 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 22379 returned error 67
May 15 14:02:55 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 22393 returned error 67
May 15 14:02:57 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 22408 returned error 67
May 15 14:21:14 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 30845 returned error 67
May 15 14:21:25 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 30910 returned error 67
May 15 14:21:26 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 30922 returned error 67
May 15 14:21:37 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 30960 returned error 67
May 15 14:21:50 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 30996 returned error 67
May 15 14:22:08 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 31073 returned error 67
May 15 14:22:27 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 31171 returned error 67
May 15 14:25:06 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 31902 returned error 67
May 15 15:22:21 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 25220 returned error 67
May 15 15:53:08 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 3428 returned error 67
May 15 16:55:08 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 27771 returned error 67
May 15 16:56:28 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 28822 returned error 67
May 15 17:55:50 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 13755 returned error 67
May 15 18:24:50 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 19437 returned error 67
May 16 08:47:52 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 21654 returned error 67
May 16 08:47:54 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 21667 returned error 67
May 16 08:52:48 imail2 dovecot: quota-warning: Error: cat: write error: Broken pipe
May 16 08:52:48 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 23976 returned error 67
May 16 10:09:36 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 31690 returned error 67
May 16 10:46:36 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 18596 returned error 67
May 16 11:29:25 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 6974 returned error 67
May 16 14:37:06 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 19310 returned error 67
May 16 16:00:15 imail2 dovecot: imap: Logged out in=305519 out=7277
May 16 16:27:41 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 7438 returned error 67
May 16 16:27:42 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 7451 returned error 67
May 16 16:27:44 imail2 dovecot: quota-warning: Fatal: master: service(quota-warning): child 7478 returned error 67

12 Reply by ZhangHuangbin

  • ZhangHuangbin
  • ZhangHuangbin
  • iRedMail Developers
  • Offline
  • Registered: 2009-05-06
  • Posts: 31,088

Re: Anvil and quota-warning error in dovecot.log file.

According to Dovecot wiki, seems it's caused due to the recipient address doesn't exist:
https://wiki.dovecot.org/LDA#Return_values

Return values

dovecot-lda will exit with one of the following values:

...
67 (EX_NOUSER): The destination username was not found.
...

You can try to update /usr/local/bin/dovecot-quota-warning.sh, add some "echo" command to write the recipient email address in a file (e.g. /tmp/lda-users), then check whether it exists.