Command time limit exceeded

[John Fawcett]

In the past few days I have had several incoming messages bounced due to
Command time limit exceeded in /usr/lib/cyrus/bin/deliver.

I have a Postfix -> Amavis-new -> Postfix -> Cyrus configuration.

I know what triggered the problem, I just don't know why this should be the
case. This error happens when at the same time as postfix receives
incoming mail I am connected to imap via a GPRS connection (high latency)
and am
moving many large messages from one folder to another, which takes several
minutes.

During this interval, deliver does not deposit messages handed to it by
postfix and once the preset time limit is up (command_time_limit = 180s in
postfix main.cf), postfix bounces message. In fact the postfix/pipe log line
indicates 181s delay at the time of bouncing.

The obvious solution is to increase the command_time_limit, but it's always
going to be an arbitrary choice. Any other ideas about how to avoid this
problem? Is this issue intrinsic in the mechanism cyrus uses to deposit
messages?


Sep  5 10:11:39 romolo postfix/smtpd[20884]: connect from
mmx.engelschall.com[195.27.130.252]
Sep  5 10:11:39 romolo postfix/smtpd[20884]: 677572C049:
client=mmx.engelschall.com[195.27.130.252]
Sep  5 10:11:41 romolo postfix/cleanup[20886]: 677572C049:
message-id=<60DAA6E9-DF78-11D7-B1AF-000393744734 at arcor.de>
Sep  5 10:11:41 romolo postfix/qmgr[1708]: 677572C049:
from=<owner-mmx-openssl-users at mmx.engelschall.com>, size=4199, nrcpt=1
(queue active)
Sep  5 10:11:41 romolo postfix/smtpd[20884]: disconnect from
mmx.engelschall.com[195.27.130.252]
Sep  5 10:11:42 romolo postfix/smtpd[20899]: connect from
localhost.localdomain[127.0.0.1]
Sep  5 10:11:42 romolo postfix/smtpd[20899]: AF5732BEC4:
client=localhost.localdomain[127.0.0.1]
Sep  5 10:11:42 romolo postfix/cleanup[20886]: AF5732BEC4:
message-id=<60DAA6E9-DF78-11D7-B1AF-000393744734 at arcor.de>
Sep  5 10:11:42 romolo postfix/qmgr[1708]: AF5732BEC4:
from=<owner-mmx-openssl-users at mmx.engelschall.com>, size=4651, nrcpt=1
(queue active)
Sep  5 10:11:42 romolo amavis[12306]: (12306-08) Passed,
<owner-mmx-openssl-users at mmx.engelschall.com> ->
<john+openssl at michaweb.net>, Message-ID:
<60DAA6E9-DF78-11D7-B1AF-000393744734 at arcor.de>
Sep  5 10:11:42 romolo postfix/smtp[20896]: 677572C049:
to=<john+openssl at michaweb.net>, relay=127.0.0.1[127.0.0.1], delay=3,
status=sent (250 2.6.0 Ok, id=12306-08, from MTA: 250 Ok: queued as
AF5732BEC4)
Sep  5 10:11:42 romolo postfix/smtpd[20899]: disconnect from
localhost.localdomain[127.0.0.1]
Sep  5 10:14:43 romolo postfix/pipe[20902]: AF5732BEC4:
to=<john at michaweb.net>, orig_to=<john+openssl at michaweb.net>, relay=cyrus,
delay=181, status=bounced (Command time limit exceeded:
"/usr/lib/cyrus/bin/deliver")

John