part of log entry too limited

[Christian Schlittchen]

Postfix (3.2.3) has a hardcoded limit in src/pipe/pipe.c:eval_command_status() that leads to truncated important information in the logs. The problem is

if (VSTRING_LEN(why->reason) > 0) {
    VSTRING_TERMINATE(why->reason);
    saved_text =
      vstring_export(vstring_sprintf(
                       vstring_alloc(VSTRING_LEN(why->reason)),
                               " (%.100s)", STR(why->reason)));
} else
    saved_text = mystrdup(""); /* uses shared R/O storage */
    dsb_update(why, "2.0.0", (attr->flags & PIPE_OPT_FINAL_DELIVERY) ?
           "delivered" : "relayed", DSB_SKIP_RMTA, DSB_SKIP_REPLY,
           "delivered via %s service%s", service, saved_text);

The (%.100s) causes log entries like this

2017-11-14T14:55:37.153642+01:00 mail-01 postfix/pipe[71318]: 193DA1AE55: to=<email address hidden>, relay=dovecot, delay=0.05, delays=0/0.01/0/0.04, dsn=2.0.0, status=sent (delivered via dovecot service (lda(ikm): Info: sieve: msgid=<email address hidden>: stored mail i))

with the information from dovecot cut off.

I have been too lazy to find out when this was introduced, but it almost certainly wasn't present in version 2. It is still there in 3.2.4 and 3.3-20171028.

[Joshua Powers (powersj)]

Thank you for taking the time to report this bug and helping to make Ubuntu
better.

The next step is to identify whether this bug is present in the upstream
project, introduced in Debian packaging, or introduced in Ubuntu's
modifications. If Ubuntu has not introduced the problem, we should get a bug
filed in the appropriate upstream bug tracker. Are you able to help with
this, please?

If you do end up filing a bug upstream, please link to it here. Thanks!

[Launchpad Janitor (janitor)]

[Expired for postfix (Ubuntu) because there has been no activity for 60 days.]