Bug#284366: exim4: ignores the timeout_frozen_after config entry
Thomas Mueller
Thomas Mueller <tmm@tmueller.com>, 284366@bugs.debian.org
Mon, 06 Dec 2004 10:26:08 +0100
This is a multi-part message in MIME format.
--------------030106050607070208040002
Content-Type: text/plain; charset=ISO-8859-1; format=flowed
Content-Transfer-Encoding: 7bit
Hi,
>>>>Exim seems to ignore 'timeout_frozen_after = 4d' and always use the
>>>>default of 7d.
> Thanks for the quick response. Can you run
> exim4 -v -M Message-ID_of_frozen_message
Attached is one run with -v and one with -d as Marc requested.
Thanks for your help.
Thomas
--
http://www.tmueller.com for pgp key (95702B3B)
--------------030106050607070208040002
Content-Type: text/plain;
name="exim4.out"
Content-Transfer-Encoding: 7bit
Content-Disposition: inline;
filename="exim4.out"
LOG: MAIN
cwd=/root 4 args: exim4 -v -M 1CYirk-00022N-A4
R: dnslookup for evank@c-24-11-13-98.client.comcast.net
T: remote_smtp for evank@c-24-11-13-98.client.comcast.net
Connecting to c-24-11-13-98.client.comcast.net [24.11.13.98]:25 ... failed
LOG: MAIN
c-24-11-13-98.client.comcast.net [24.11.13.98]: Connection timed out
LOG: MAIN
== evank@c-24-11-13-98.client.comcast.net R=dnslookup T=remote_smtp defer (110): Connection timed out
Exim version 4.34 uid=0 gid=0 pid=25309 D=fbb95cfd
Berkeley DB: Sleepycat Software: Berkeley DB 3.2.9: (May 26, 2004)
Support for: iconv() IPv6 PAM Perl GnuTLS
Lookups: lsearch wildlsearch nwildlsearch iplsearch cdb dbm dbmnz dnsdb dsearch ldap ldapdn ldapm mysql nis nis0 passwd pgsql
Authenticators: cram_md5 plaintext spa
Routers: accept dnslookup ipliteral iplookup manualroute queryprogram redirect
Transports: appendfile/maildir/mailstore/mbx autoreply lmtp pipe smtp
Fixed never_users: 0
changed uid/gid: forcing real = effective
uid=0 gid=0 pid=25309
auxiliary group list: <none>
finduser used cached passwd data for Debian-exim
configuration file is /var/lib/exim4/config.autogenerated
log selectors = ffffffff 7fffffff
LOG: MAIN
cwd=/root 4 args: exim4 -d -M 1CYirk-00022N-A4
trusted user
admin user
skipping ACL configuration - not needed
set_process_info: 25309 delivering specified messages
set_process_info: 25309 delivering 1CYirk-00022N-A4
reading spool file 1CYirk-00022N-A4-H
user=Debian-exim uid=105 gid=105 sender=
sender_local=0 ident=Debian-exim
Non-recipients:
Empty Tree
---- End of tree ----
recipients_count=1
body_linecount=40 message_linecount=10
running system filter
rda_interpret (file): /etc/exim4/tmm_filter
expanded: /etc/exim4/tmm_filter
changed uid/gid: system filter
uid=105 gid=105 pid=25310
auxiliary group list: <none>
2055 bytes read from /etc/exim4/tmm_filter
data is an Exim filter program
Filter: start of processing
Filter: end of processing
rda_interpret: subprocess yield=1 error=NULL
system filter returned 1
Delivery address list:
evank@c-24-11-13-98.client.comcast.net
locking /var/spool/exim4/db/retry.lockfile
locked /var/spool/exim4/db/retry.lockfile
opened hints database /var/spool/exim4/db/retry: flags=0
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
Considering: evank@c-24-11-13-98.client.comcast.net
unique = evank@c-24-11-13-98.client.comcast.net
dbfn_read: key=R:c-24-11-13-98.client.comcast.net
dbfn_read: key=R:evank@c-24-11-13-98.client.comcast.net
no domain retry record
no address retry record
evank@c-24-11-13-98.client.comcast.net: queued for routing
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
routing evank@c-24-11-13-98.client.comcast.net
--------> amavis router <--------
local_part=evank domain=c-24-11-13-98.client.comcast.net
checking domains
search_open: pgsql "NULL"
search_find: file="NULL"
key="SELECT DISTINCT name FROM domains WHERE name='c-24-11-13-98.client.comcast.net'" partial=-1 affix=NULL starflags=0
LRU list:
internal_search_find: file="NULL"
type=pgsql key="SELECT DISTINCT name FROM domains WHERE name='c-24-11-13-98.client.comcast.net'"
database lookup required for SELECT DISTINCT name FROM domains WHERE name='c-24-11-13-98.client.comcast.net'
PGSQL query: SELECT DISTINCT name FROM domains WHERE name='c-24-11-13-98.client.comcast.net'
PGSQL new connection: host=localhost port= database=dbmail user=dbmailro
PGSQL: no data found
lookup failed
search_open: pgsql "NULL"
cached open
search_find: file="NULL"
key="SELECT DISTINCT name FROM records WHERE name='c-24-11-13-98.client.comcast.net'" partial=-1 affix=NULL starflags=0
LRU list:
internal_search_find: file="NULL"
type=pgsql key="SELECT DISTINCT name FROM records WHERE name='c-24-11-13-98.client.comcast.net'"
database lookup required for SELECT DISTINCT name FROM records WHERE name='c-24-11-13-98.client.comcast.net'
PGSQL query: SELECT DISTINCT name FROM records WHERE name='c-24-11-13-98.client.comcast.net'
PGSQL using cached connection for localhost/dbmail/dbmailro
PGSQL: no data found
lookup failed
c-24-11-13-98.client.comcast.net in "@ : localhost : : "? no (end of list)
c-24-11-13-98.client.comcast.net in "+local_domains"? no (end of list)
amavis router skipped: domains mismatch
--------> hubbed_hosts router <--------
local_part=evank domain=c-24-11-13-98.client.comcast.net
checking domains
expansion of "${if exists{/etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/hubbed_hosts}fail}" forced failure: assume not in this list
hubbed_hosts router skipped: domains mismatch
--------> dnslookup_relay_to_domains router <--------
local_part=evank domain=c-24-11-13-98.client.comcast.net
checking domains
search_open: pgsql "NULL"
cached open
search_find: file="NULL"
key="SELECT DISTINCT name FROM domains WHERE name='c-24-11-13-98.client.comcast.net'" partial=-1 affix=NULL starflags=0
LRU list:
internal_search_find: file="NULL"
type=pgsql key="SELECT DISTINCT name FROM domains WHERE name='c-24-11-13-98.client.comcast.net'"
database lookup required for SELECT DISTINCT name FROM domains WHERE name='c-24-11-13-98.client.comcast.net'
PGSQL query: SELECT DISTINCT name FROM domains WHERE name='c-24-11-13-98.client.comcast.net'
PGSQL using cached connection for localhost/dbmail/dbmailro
PGSQL: no data found
lookup failed
search_open: pgsql "NULL"
cached open
search_find: file="NULL"
key="SELECT DISTINCT name FROM records WHERE name='c-24-11-13-98.client.comcast.net'" partial=-1 affix=NULL starflags=0
LRU list:
internal_search_find: file="NULL"
type=pgsql key="SELECT DISTINCT name FROM records WHERE name='c-24-11-13-98.client.comcast.net'"
database lookup required for SELECT DISTINCT name FROM records WHERE name='c-24-11-13-98.client.comcast.net'
PGSQL query: SELECT DISTINCT name FROM records WHERE name='c-24-11-13-98.client.comcast.net'
PGSQL using cached connection for localhost/dbmail/dbmailro
PGSQL: no data found
lookup failed
c-24-11-13-98.client.comcast.net in "@ : localhost : : "? no (end of list)
search_open: pgsql "NULL"
cached open
search_find: file="NULL"
key="SELECT DISTINCT name FROM backupmx_domains WHERE name='c-24-11-13-98.client.comcast.net'" partial=-1 affix=NULL starflags=0
LRU list:
internal_search_find: file="NULL"
type=pgsql key="SELECT DISTINCT name FROM backupmx_domains WHERE name='c-24-11-13-98.client.comcast.net'"
database lookup required for SELECT DISTINCT name FROM backupmx_domains WHERE name='c-24-11-13-98.client.comcast.net'
PGSQL query: SELECT DISTINCT name FROM backupmx_domains WHERE name='c-24-11-13-98.client.comcast.net'
PGSQL using cached connection for localhost/dbmail/dbmailro
PGSQL: no data found
lookup failed
c-24-11-13-98.client.comcast.net in ""? no (end of list)
c-24-11-13-98.client.comcast.net in "! +local_domains : +relay_to_domains"? no (end of list)
dnslookup_relay_to_domains router skipped: domains mismatch
--------> dnslookup router <--------
local_part=evank domain=c-24-11-13-98.client.comcast.net
checking domains
search_open: pgsql "NULL"
cached open
search_find: file="NULL"
key="SELECT DISTINCT name FROM domains WHERE name='c-24-11-13-98.client.comcast.net'" partial=-1 affix=NULL starflags=0
LRU list:
internal_search_find: file="NULL"
type=pgsql key="SELECT DISTINCT name FROM domains WHERE name='c-24-11-13-98.client.comcast.net'"
database lookup required for SELECT DISTINCT name FROM domains WHERE name='c-24-11-13-98.client.comcast.net'
PGSQL query: SELECT DISTINCT name FROM domains WHERE name='c-24-11-13-98.client.comcast.net'
PGSQL using cached connection for localhost/dbmail/dbmailro
PGSQL: no data found
lookup failed
search_open: pgsql "NULL"
cached open
search_find: file="NULL"
key="SELECT DISTINCT name FROM records WHERE name='c-24-11-13-98.client.comcast.net'" partial=-1 affix=NULL starflags=0
LRU list:
internal_search_find: file="NULL"
type=pgsql key="SELECT DISTINCT name FROM records WHERE name='c-24-11-13-98.client.comcast.net'"
database lookup required for SELECT DISTINCT name FROM records WHERE name='c-24-11-13-98.client.comcast.net'
PGSQL query: SELECT DISTINCT name FROM records WHERE name='c-24-11-13-98.client.comcast.net'
PGSQL using cached connection for localhost/dbmail/dbmailro
PGSQL: no data found
lookup failed
c-24-11-13-98.client.comcast.net in "@ : localhost : : "? no (end of list)
c-24-11-13-98.client.comcast.net in "! +local_domains"? yes (end of list)
R: dnslookup for evank@c-24-11-13-98.client.comcast.net
calling dnslookup router
dnslookup router called for evank@c-24-11-13-98.client.comcast.net
domain = c-24-11-13-98.client.comcast.net
DNS lookup of c-24-11-13-98.client.comcast.net (MX) gave NO_DATA
returning DNS_NODATA
DNS lookup of c-24-11-13-98.client.comcast.net (AAAA) gave NO_DATA
returning DNS_NODATA
DNS lookup of c-24-11-13-98.client.comcast.net (A) succeeded
24.11.13.98 in "0.0.0.0 : 127.0.0.0/8 : 192.168.0.0/16 :172.16.0.0/12 : 10.0.0.0/8 : 169.254.0.0/16"? no (end of list)
fully qualified name = c-24-11-13-98.client.comcast.net
c-24-11-13-98.client.comcast.net 24.11.13.98 mx=-1 sort=-484
set transport remote_smtp
queued for remote_smtp transport: local_part = evank
domain = c-24-11-13-98.client.comcast.net
errors_to=NULL
domain_data=NULL localpart_data=NULL
routed by dnslookup router
envelope to: evank@c-24-11-13-98.client.comcast.net
transport: remote_smtp
host c-24-11-13-98.client.comcast.net [24.11.13.98]
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
After routing:
Local deliveries:
Remote deliveries:
evank@c-24-11-13-98.client.comcast.net
Failed addresses:
Deferred addresses:
search_tidyup called
close PGSQL connection: localhost/dbmail/dbmailro
>>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>>
--------> evank@c-24-11-13-98.client.comcast.net <--------
search_tidyup called
changed uid/gid: remote delivery to evank@c-24-11-13-98.client.comcast.net with transport=remote_smtp
uid=105 gid=105 pid=25312
auxiliary group list: <none>
set_process_info: 25312 delivering 1CYirk-00022N-A4 using remote_smtp
T: remote_smtp for evank@c-24-11-13-98.client.comcast.net
remote_smtp transport entered
evank@c-24-11-13-98.client.comcast.net
set_process_info: 25309 delivering 1CYirk-00022N-A4: waiting for a remote delivery subprocess to finish
selecting on subprocess pipes
checking status of c-24-11-13-98.client.comcast.net
locking /var/spool/exim4/db/retry.lockfile
locked /var/spool/exim4/db/retry.lockfile
opened hints database /var/spool/exim4/db/retry: flags=0
dbfn_read: key=T:c-24-11-13-98.client.comcast.net:24.11.13.98
dbfn_read: key=T:c-24-11-13-98.client.comcast.net:24.11.13.98:1CYirk-00022N-A4
no message retry record
c-24-11-13-98.client.comcast.net [24.11.13.98] status = usable
24.11.13.98 in serialize_hosts? no (option unset)
delivering 1CYirk-00022N-A4 to c-24-11-13-98.client.comcast.net [24.11.13.98] (evank@c-24-11-13-98.client.comcast.net)
set_process_info: 25312 delivering 1CYirk-00022N-A4 to c-24-11-13-98.client.comcast.net [24.11.13.98] (evank@c-24-11-13-98.client.comcast.net)
selecting on subprocess pipes
selecting on subprocess pipes
selecting on subprocess pipes
Connecting to c-24-11-13-98.client.comcast.net [24.11.13.98]:25 ... failed
LOG: MAIN
c-24-11-13-98.client.comcast.net [24.11.13.98]: Connection timed out
set_process_info: 25312 delivering 1CYirk-00022N-A4: just tried c-24-11-13-98.client.comcast.net [24.11.13.98] for evank@c-24-11-13-98.client.comcast.net: result DEFER
added retry item for T:c-24-11-13-98.client.comcast.net:24.11.13.98: errno=110 321 flags=2
all IP addresses skipped or deferred at least one address
locking /var/spool/exim4/db/wait-remote_smtp.lockfile
locked /var/spool/exim4/db/wait-remote_smtp.lockfile
opened hints database /var/spool/exim4/db/wait-remote_smtp: flags=2
dbfn_read: key=c-24-11-13-98.client.comcast.net
Leaving remote_smtp transport
set_process_info: 25312 delivering 1CYirk-00022N-A4 (just run remote_smtp for evank@c-24-11-13-98.client.comcast.net in subprocess)
search_tidyup called
reading pipe for subprocess 25312 (not ended)
read() yielded 96
reading retry information for T:c-24-11-13-98.client.comcast.net:24.11.13.98 from subprocess
added retry item
Z0 item read
remote delivery process 25312 ended
set_process_info: 25309 delivering 1CYirk-00022N-A4
post-process evank@c-24-11-13-98.client.comcast.net (1)
LOG: MAIN
== evank@c-24-11-13-98.client.comcast.net R=dnslookup T=remote_smtp defer (110): Connection timed out
>>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
changed uid/gid: post-delivery tidying
uid=105 gid=105 pid=25309
auxiliary group list: <none>
set_process_info: 25309 tidying up after delivering 1CYirk-00022N-A4
Processing retry items
Succeeded addresses:
Failed addresses:
Deferred addresses:
evank@c-24-11-13-98.client.comcast.net
locking /var/spool/exim4/db/retry.lockfile
locked /var/spool/exim4/db/retry.lockfile
opened hints database /var/spool/exim4/db/retry: flags=2
address match: subject=*@c-24-11-13-98.client.comcast.net pattern=*
c-24-11-13-98.client.comcast.net in "*"? yes (matched "*")
*@c-24-11-13-98.client.comcast.net in "*"? yes (matched "*")
retry for T:c-24-11-13-98.client.comcast.net:24.11.13.98 (c-24-11-13-98.client.comcast.net) = *
dbfn_read: key=T:c-24-11-13-98.client.comcast.net:24.11.13.98
Writing retry data for T:c-24-11-13-98.client.comcast.net:24.11.13.98
first failed=1101724485 last try=1102324692 next try=1102346292 expired=0
error 110 321: Connection timed out
dbfn_write: key=T:c-24-11-13-98.client.comcast.net:24.11.13.98
end of retry processing
delivery deferred: update_spool=0 header_rewritten=0
end delivery of 1CYirk-00022N-A4
search_tidyup called
search_tidyup called
>>>>>>>>>>>>>>>> Exim pid=25309 terminating with rc=0 >>>>>>>>>>>>>>>>
--------------030106050607070208040002--