Need help finding cause of error msg

Previous Topic Next Topic
 
classic Classic list List threaded Threaded
2 messages Options
Reply | Threaded
Open this post in threaded view
|

Need help finding cause of error msg

Julian Kippels
Hi,

On my servers I get this (non-consequential) error every so often:
/var/log/maillog:Apr 12 15:01:00 postfix-test postfix/virtual[4996]: fatal: bad string length 0 < 1: virtual_mailbox_base =
/var/log/maillog:Apr 12 15:01:01 postfix-test postfix/master[4960]: warning: process /usr/libexec/postfix/virtual pid 4996 exit status 1
/var/log/maillog:Apr 12 15:01:01 postfix-test postfix/master[4960]: warning: /usr/libexec/postfix/virtual: bad command startup -- throttling

Here are postconf -n and -M:
$ postconf -M
smtp       inet  n       -       n       -       -       smtpd
pmx        unix  -       -       n       -       10      smtp
submission inet  n       -       n       -       -       smtpd -o syslog_name=postfix/submission -o smtpd_tls_security_level=none -o mynetworks=cidr:/etc/postfix/mynetworks-587.cidr -o smtpd_sender_restrictions=$spamwatch_policy -o smtpd_relay_restrictions=permit_mynetworks,permit_sasl_authenticated,reject
8025       inet  n       -       n       -       -       smtpd -o syslog_name=postfix/lsf-relay -o mynetworks=cidr:/etc/postfix/mynetworks-8025.cidr
smtp-amavis unix -       -       n       -       2       smtp -o smtp_data_done_timeout=1200 -o smtp_send_xforward_command=yes -o disable_dns_lookups=yes
127.0.0.1:10025 inet n   -       n       -       -       smtpd -o content_filter= -o local_recipient_maps= -o relay_recipient_maps= -o smtpd_restriction_classes= -o smtpd_client_restrictions= -o smtpd_helo_restrictions= -o smtpd_sender_restrictions= -o smtpd_recipient_restrictions=permit_mynetworks,reject -o mynetworks=127.0.0.0/8 -o strict_rfc821_envelopes=yes -o smtpd_error_sleep_time=0 -o smtpd_soft_error_limit=1001 -o smtpd_hard_error_limit=1000
10026      inet  n       -       n       -       10      smtpd -o content_filter= -o local_recipient_maps= -o relay_recipient_maps= -o myhostname=localhost -o smtpd_helo_restrictions= -o smtpd_client_restrictions= -o smtpd_sender_restrictions= -o smtpd_recipient_restrictions=permit_mynetworks,reject -o mynetworks=192.168.25.0/24
pickup     unix  n       -       n       60      1       pickup
cleanup    unix  n       -       n       -       0       cleanup
qmgr       unix  n       -       n       300     1       qmgr
tlsmgr     unix  -       -       n       1000?   1       tlsmgr
rewrite    unix  -       -       n       -       -       trivial-rewrite
bounce     unix  -       -       n       -       0       bounce
defer      unix  -       -       n       -       0       bounce
trace      unix  -       -       n       -       0       bounce
verify     unix  -       -       n       -       1       verify
flush      unix  n       -       n       1000?   0       flush
proxymap   unix  -       -       n       -       -       proxymap
proxywrite unix  -       -       n       -       1       proxymap
smtp       unix  -       -       n       -       -       smtp
relay      unix  -       -       n       -       -       smtp
showq      unix  n       -       n       -       -       showq
error      unix  -       -       n       -       -       error
retry      unix  -       -       n       -       -       error
discard    unix  -       -       n       -       -       discard
local      unix  -       n       n       -       -       local
virtual    unix  -       n       n       -       -       virtual
lmtp       unix  -       -       n       -       -       lmtp
anvil      unix  -       -       n       -       1       anvil
scache     unix  -       -       n       -       1       scache

$ postconf -n
alias_database = hash:/etc/aliases
alias_maps = hash:/etc/aliases
broadcaster_only = check_policy_service inet:localhost:2000
broken_sasl_auth_clients = yes
command_directory = /usr/sbin
config_directory = /etc/postfix
content_filter = smtp-amavis:[127.0.0.1]:10024
daemon_directory = /usr/libexec/postfix
data_directory = /var/lib/postfix
debug_peer_level = 2
debugger_command = PATH=/bin:/usr/bin:/usr/local/bin:/usr/X11R6/bin ddd $daemon_directory/$process_name $process_id & sleep 5
delay_warning_time = 4h
html_directory = no
inet_interfaces = all
inet_protocols = ipv4
lmtp_host_lookup = native
local_recipient_maps = $virtual_mailbox_maps
mail_owner = postfix
mailbox_size_limit = 14336000000
mailq_path = /usr/bin/mailq.postfix
manpage_directory = /usr/share/man
message_size_limit = 143360000
mydestination = $myhostname, localhost.$mydomain, localhost
mynetworks = 127.0.0.0/8 cidr:/etc/postfix/mynetworks-25.cidr
mynetworks_style = host
newaliases_path = /usr/bin/newaliases.postfix
propagate_unmatched_extensions =
queue_directory = /var/spool/postfix
readme_directory = /usr/share/doc/postfix-2.10.1/README_FILES
recipient_delimiter = +
relay_domains = ddz.uni-duesseldorf.de mail.ddz.uni-duesseldorf.de ddfi.uni-duesseldorf.de mail.ddfi.uni-duesseldorf.de dfi.uni-duesseldorf.de mail.ddfi.uni-duesseldorf.de iuf-duesseldorf.de iufduesseldorf.de iuf-duesseldorf.com iufduesseldorf.com frodo.rz.uni-duesseldorf.de
relay_recipient_maps = hash:/etc/postfix/relay_recipients
sample_directory = /usr/share/doc/postfix-2.10.1/samples
sendmail_path = /usr/sbin/sendmail.postfix
setgid_group = postdrop
smtp_tls_cert_file = /etc/postfix/cert/postfix-test-cert.pem
smtp_tls_key_file = /etc/postfix/cert/postfix-test-key.pem
smtp_tls_security_level = may
smtpd_policy_service_timeout = 200s
smtpd_recipient_restrictions = check_recipient_access ldap:/etc/postfix/test.uni-duesseldorf.de-hold.cf
smtpd_relay_restrictions = permit_mynetworks permit_sasl_authenticated reject_unauth_destination
smtpd_restriction_classes = broadcaster_only
smtpd_sasl_auth_enable = yes
smtpd_sasl_path = inet:192.168.25.212:12345
smtpd_sasl_type = dovecot
smtpd_tls_cert_file = /etc/postfix/cert/postfix-test-cert.pem
smtpd_tls_key_file = /etc/postfix/cert/postfix-test-key.pem
smtpd_tls_security_level = may
spamwatch_policy = check_policy_service inet:localhost:2001
transport_maps = ldap:/etc/postfix/test.uni-duesseldorf.de-lmtp.cf ldap:/etc/postfix/test.uni-duesseldorf.de-smtp.cf hash:/etc/postfix/relay_transport_maps
unknown_local_recipient_reject_code = 550
virtual_alias_expansion_limit = 50000
virtual_alias_maps = ldap:/etc/postfix/test.uni-duesseldorf.de.cf
virtual_mailbox_domains = hash:/etc/postfix/virtual_mailbox_domains
virtual_mailbox_maps = $virtual_alias_maps
virtual_transport = lmtp

The LDAP-Lookups in transport_maps either return lmtp:inet:localhost:2525 or smtp:otherserver.tld

I fail to see why ANYTHING should invoke virtual and run into that error. Any
help is appreciated. I use postfix 2.10.1.

Thanks in advance
Julian
Reply | Threaded
Open this post in threaded view
|

Re: Need help finding cause of error msg

Wietse Venema
Julian Kippels:
> On my servers I get this (non-consequential) error every so often:
> /var/log/maillog:Apr 12 15:01:00 postfix-test postfix/virtual[4996]: fatal: bad string length 0 < 1: virtual_mailbox_base =
> /var/log/maillog:Apr 12 15:01:01 postfix-test postfix/master[4960]: warning: process /usr/libexec/postfix/virtual pid 4996 exit status 1
> /var/log/maillog:Apr 12 15:01:01 postfix-test postfix/master[4960]: warning: /usr/libexec/postfix/virtual: bad command startup -- throttling
[master.cf]
> virtual    unix  -       n       n       -       -       virtual
[main.cf]
> virtual_transport = lmtp
>
> The LDAP-Lookups in transport_maps either return lmtp:inet:localhost:2525
> or smtp:otherserver.tld

> I fail to see why ANYTHING should invoke virtual and run into that error. Any

1) How many Postfix master daemons are running on that machine?

If there is more than one, then the error may happen in the "other"
instance than the one whose configuration you are reporting.

2) Perhaps the LDAP lookup results return other results, occasionally?

You can debug (2) by looking at Postfix logging (qmgr, lmtp, etc.)
in the minutes after the postfix/virtual fatal error.  If you're
lucky then there is only one delivery happening.

        Wietse