diff options
| author | Jeremy Harris <jgh146exb@wizmail.org> | 2020-03-18 13:47:42 +0000 |
|---|---|---|
| committer | Jeremy Harris <jgh146exb@wizmail.org> | 2020-03-20 01:15:12 +0000 |
| commit | 568092148bf6ade68174fa1ccf34b8c37d9064e9 (patch) | |
| tree | b57958756160f60d9858759b0ba3945cb181ab60 | |
| parent | 3a2adc82d165fccae92f6a693ce5ddba10d371d4 (diff) | |
| download | exim4-568092148bf6ade68174fa1ccf34b8c37d9064e9.tar.gz | |
consistent fork-time debug
Testcase issues: 0366 2035
90 files changed, 1942 insertions, 29 deletions
diff --git a/src/src/deliver.c b/src/src/deliver.c index 5d825cd66..88fe2f9bf 100644 --- a/src/src/deliver.c +++ b/src/src/deliver.c @@ -7918,10 +7918,6 @@ wording. */ (void)fclose(fp); rc = child_close(pid, 0); /* Waits for child to close, no timeout */ - /* In the test harness, let the child do it's thing first. */ - - testharness_pause_ms(500); - /* If the process failed, there was some disaster in setting up the error message. Unless the message is very old, ensure that addr_defer is non-null, which will have the effect of leaving the message on the @@ -8583,15 +8579,15 @@ if (cutthrough.cctx.sock >= 0 && cutthrough.callout_hold_only) goto fail; where = US"fork"; + testharness_pause_ms(150); if ((pid = exim_fork(US"tls-proxy interproc")) < 0) goto fail; - else if (pid == 0) /* child: fork again to totally disconnect */ + if (pid == 0) /* child: will fork again to totally disconnect */ { - testharness_pause_ms(100); /* let parent debug out */ - /* does not return */ smtp_proxy_tls(cutthrough.cctx.tls_ctx, big_buffer, big_buffer_size, pfd, 5*60); + /* does not return */ } DEBUG(D_transport) debug_printf("proxy-proc inter-pid %d\n", pid); diff --git a/src/src/functions.h b/src/src/functions.h index 9e71d0c20..a44e7a873 100644 --- a/src/src/functions.h +++ b/src/src/functions.h @@ -1117,13 +1117,31 @@ return NULL; static inline pid_t exim_fork(const unsigned char * purpose) { -pid_t pid = fork(); -if (pid == 0) process_purpose = purpose; +pid_t pid; +DEBUG(D_any) debug_printf("%s forking for %s\n", process_purpose, purpose); +if ((pid = fork()) == 0) + { + process_purpose = purpose; + DEBUG(D_any) debug_printf("postfork: %s\n", purpose); + } +else + { + testharness_pause_ms(100); /* let child work */ + DEBUG(D_any) debug_printf("%s forked for %s: %d\n", process_purpose, purpose, (int)pid); + } return pid; } -#define child_open_exim(p, r) child_open_exim_function((p), (r)) -#define child_open_exim2(p, s, a, r) child_open_exim2_function((p), (s), (a), (r)) + +static inline pid_t +child_open_exim(int * fdptr, const uschar * purpose) +{ return child_open_exim_function(fdptr, purpose); } + +static inline pid_t +child_open_exim2(int * fdptr, uschar * sender, + uschar * sender_auth, const uschar * purpose) +{ return child_open_exim2_function(fdptr, sender, sender_auth, purpose); } + /******************************************************************************/ #endif /* !MACRO_PREDEF */ diff --git a/src/src/globals.c b/src/src/globals.c index 28e78d4d6..57f857e5a 100644 --- a/src/src/globals.c +++ b/src/src/globals.c @@ -1188,7 +1188,7 @@ uschar *primary_hostname = NULL; uschar *process_info; int process_info_len = 0; uschar *process_log_path = NULL; -const uschar *process_purpose = US"fresh exec"; +const uschar *process_purpose = US"fresh-exec"; #if defined(SUPPORT_PROXY) || defined(SUPPORT_SOCKS) uschar *hosts_proxy = NULL; diff --git a/src/src/queue.c b/src/src/queue.c index 2b64f5229..211349047 100644 --- a/src/src/queue.c +++ b/src/src/queue.c @@ -654,7 +654,6 @@ single_item_retry: if ((pid = exim_fork(US"qrun delivery")) == 0) { int rc; - testharness_pause_ms(100); (void)close(pfd[pipe_read]); rc = deliver_message(fq->text, force_delivery, FALSE); exim_underbar_exit(rc == DELIVER_NOT_ATTEMPTED, US"qrun-delivery"); diff --git a/src/src/transport.c b/src/src/transport.c index cd5e8d319..e5a7385b4 100644 --- a/src/src/transport.c +++ b/src/src/transport.c @@ -1970,7 +1970,7 @@ if ((pid = exim_fork(US"continued-transport interproc")) == 0) DEBUG(D_transport) debug_printf("transport_pass_socket succeeded (final-pid %d)\n", pid); _exit(EXIT_SUCCESS); } - testharness_pause_ms(1000); + testharness_pause_ms(1000); /*TTT*/ transport_do_pass_socket(transport_name, hostname, hostaddress, id, socket_fd); diff --git a/src/src/transports/smtp.c b/src/src/transports/smtp.c index 7be9e8e66..2216ff853 100644 --- a/src/src/transports/smtp.c +++ b/src/src/transports/smtp.c @@ -3290,7 +3290,6 @@ if ((rc = exim_fork(US"tls proxy"))) _exit(rc < 0 ? EXIT_FAILURE : EXIT_SUCCESS); } -testharness_pause_ms(100); /* let parent debug out */ set_process_info("proxying TLS connection for continued transport"); FD_ZERO(&rfds); FD_SET(tls_out.active.sock, &rfds); @@ -4282,7 +4281,6 @@ propagate it from the initial int pid = exim_fork(US"tls proxy interproc"); if (pid == 0) /* child; fork again to disconnect totally */ { - testharness_pause_ms(100); /* let parent debug out */ /* does not return */ smtp_proxy_tls(sx->cctx.tls_ctx, sx->buffer, sizeof(sx->buffer), pfd, ob->command_timeout); diff --git a/test/runtest b/test/runtest index 3f37311b1..c381d6d68 100755 --- a/test/runtest +++ b/test/runtest @@ -1047,6 +1047,8 @@ RESET_AFTER_EXTRA_LINE_READ: s/(?<=^>>>>>>>>>>>>>>>> Exim pid=)\d+(?= terminating)/pppp/; s/^(proxy-proc \w{5}-pid) \d+$/$1 pppp/; s/^(?:\s*\d+ )(exec .* -oPX)$/pppp $1/; + s/^(?:\s*\d+ )(postfork: )/pppp $1/; + s/ forked for [^:]+: \K\d+/npppp/; # IP address lookups use gethostbyname() when IPv6 is not supported, # and gethostbyname2() or getipnodebyname() when it is. diff --git a/test/stderr/0002 b/test/stderr/0002 index 8f85e7146..665a7624e 100644 --- a/test/stderr/0002 +++ b/test/stderr/0002 @@ -255,7 +255,16 @@ dropping to exim gid; retaining priv uid ╰─────result: ----> No lookup yet: No ╭considering: -oMs sender_host_name = $sender_host_name looking up host name for V4NET.0.0.1 +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp IP address lookup yielded "ten-1.test.ex" +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp ten-1.test.ex V4NET.0.0.1 mx=-1 sort=xx checking addresses for ten-1.test.ex V4NET.0.0.1 OK @@ -296,9 +305,18 @@ check hosts = <\n partial-lsearch;TESTSUITE/aux-fixed/0002.lsearch \n 1.2.3.4 sender host name required, to match against partial-lsearch;TESTSUITE/aux-fixed/0002.lsearch looking up host name for V4NET.0.0.1 DNS lookup of 1.0.0.V4NET.in-addr.arpa (PTR) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of 1.0.0.V4NET.in-addr.arpa (PTR) succeeded IP address lookup yielded "ten-1.test.ex" +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ten-1.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ten-1.test.ex (A) succeeded ten-1.test.ex V4NET.0.0.1 mx=-1 sort=xx checking addresses for ten-1.test.ex diff --git a/test/stderr/0021 b/test/stderr/0021 index 6a8a501b7..e7f64144a 100644 --- a/test/stderr/0021 +++ b/test/stderr/0021 @@ -186,12 +186,18 @@ end of ACL "rcpt": ACCEPT >> LOG: MAIN <= ok@test3 H=[10.9.8.8] U=CALLER P=smtp S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user admin user dropping to exim gid; retaining priv uid x in "!bad"? yes (end of list) +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => x <x@y> R=accept T=appendfile LOG: MAIN diff --git a/test/stderr/0037 b/test/stderr/0037 index 098227cd6..7a3b56c2c 100644 --- a/test/stderr/0037 +++ b/test/stderr/0037 @@ -4,6 +4,9 @@ trusted user admin user LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -41,11 +44,14 @@ $home = >/usr< calling userfilter router rda_interpret (file): 'TESTSUITE/aux-var/0037.f-user' expanded: 'TESTSUITE/aux-var/0037.f-user' +fresh-exec forking for router interpret +postfork: router interpret ssss bytes read from TESTSUITE/aux-var/0037.f-user data is an Exim filter program Filter: start of processing Filter: end of processing >>>>>>>>>>>>>>>> Exim pid=pppp (rda) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forked for router interpret: npppp rda_interpret: subprocess yield=0 error=NULL userfilter router generated userx@test.ex errors_to=NULL transport=NULL @@ -102,6 +108,9 @@ After routing: Failed addresses: Deferred addresses: locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => userx <filter-userx@test.ex> R=user_accept2 T=appendfile LOG: MAIN diff --git a/test/stderr/0044 b/test/stderr/0044 index 0de971e4a..d52e76ecc 100644 --- a/test/stderr/0044 +++ b/test/stderr/0044 @@ -78,10 +78,16 @@ check dnslists = rbl.test.ex dnslists check: rbl.test.ex new DNS lookup for 13.12.11.V4NET.rbl.test.ex DNS lookup of 13.12.11.V4NET.rbl.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of 13.12.11.V4NET.rbl.test.ex (A) succeeded dnslists: wrote cache entry, ttl=3 DNS lookup for 13.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2) DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) succeeded => that means V4NET.11.12.13 is listed at rbl.test.ex deny: condition test succeeded in ACL "check_recipient" @@ -238,6 +244,9 @@ check dnslists = rbl.test.ex dnslists check: rbl.test.ex new DNS lookup for 99.99.99.V4NET.rbl.test.ex DNS lookup of 99.99.99.V4NET.rbl.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of 99.99.99.V4NET.rbl.test.ex (A) gave HOST_NOT_FOUND returning DNS_NOMATCH faking res_search(A) response length as 65535 diff --git a/test/stderr/0078 b/test/stderr/0078 index 42092c03d..26e6cfc9a 100644 --- a/test/stderr/0078 +++ b/test/stderr/0078 @@ -10,6 +10,27 @@ checking domains calling lookuphost router lookuphost router called for xx@mxt6.test.ex domain = mxt6.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp set transport remote_smtp queued for remote_smtp transport: local_part = xx domain = mxt6.test.ex @@ -32,6 +53,15 @@ checking domains calling lookuphost router lookuphost router called for myhost.test.ex@mxt1.test.ex domain = mxt1.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp lowest numbered MX record points to local host: mxt1.test.ex: passed to next router (self = pass) lookuphost router passed for myhost.test.ex@mxt1.test.ex --------> self router <-------- @@ -47,6 +77,12 @@ expanded list of hosts = 'myhost.test.ex' options = 'byname' set transport remote_smtp finding IP address for myhost.test.ex calling host_find_byname +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp queued for remote_smtp transport: local_part = myhost.test.ex domain = mxt1.test.ex errors_to=NULL @@ -68,6 +104,15 @@ checking domains calling lookuphost router lookuphost router called for xx@mxt1.test.ex domain = mxt1.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp lowest numbered MX record points to local host: mxt1.test.ex: passed to next router (self = pass) lookuphost router passed for xx@mxt1.test.ex --------> self router <-------- @@ -83,6 +128,12 @@ expanded list of hosts = 'xx' options = 'byname' set transport remote_smtp finding IP address for xx calling host_find_byname +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp self router passed for xx@mxt1.test.ex --------> self2 router <-------- local_part=xx domain=mxt1.test.ex @@ -97,6 +148,12 @@ expanded list of hosts = 'myhost.test.ex' options = 'byname' set transport remote_smtp finding IP address for myhost.test.ex calling host_find_byname +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp queued for remote_smtp transport: local_part = xx domain = mxt1.test.ex errors_to=NULL @@ -118,6 +175,9 @@ checking domains calling lookuphost router lookuphost router called for xx@not.exist domain = not.exist +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp lookuphost router declined for xx@not.exist "more" is false: skipping remaining routers no more routers diff --git a/test/stderr/0094 b/test/stderr/0094 index 26cf91605..abf4258f5 100644 --- a/test/stderr/0094 +++ b/test/stderr/0094 @@ -80,16 +80,31 @@ LOG: smtp_connection MAIN host in host_lookup? yes (matched "0.0.0.0/0") looking up host name for V4NET.99.99.90 DNS lookup of 90.99.99.V4NET.in-addr.arpa (PTR) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of 90.99.99.V4NET.in-addr.arpa (PTR) succeeded IP address lookup yielded "oneback.test.ex" alias "host1.masq.test.ex" +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of oneback.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of oneback.test.ex (A) succeeded oneback.test.ex V4NET.99.99.90 mx=-1 sort=xx checking addresses for oneback.test.ex Forward DNS security status: unverified V4NET.99.99.90 OK +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of host1.masq.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of host1.masq.test.ex (A) succeeded host1.masq.test.ex V4NET.90.90.90 mx=-1 sort=xx checking addresses for host1.masq.test.ex diff --git a/test/stderr/0117 b/test/stderr/0117 index ad17fd9c1..7e1735a41 100644 --- a/test/stderr/0117 +++ b/test/stderr/0117 @@ -8,6 +8,27 @@ local_part=xxx domain=mxt9.test.ex calling lookuphost router lookuphost router called for xxx@mxt9.test.ex domain = mxt9.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp queued for <unset> transport: local_part = xxx domain = mxt9.test.ex errors_to=NULL @@ -29,6 +50,27 @@ local_part=xxx domain=mxt9a.test.ex calling lookuphost router lookuphost router called for xxx@mxt9a.test.ex domain = mxt9a.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp queued for <unset> transport: local_part = xxx domain = mxt9a.test.ex errors_to=NULL @@ -50,6 +92,27 @@ local_part=xxx domain=mxt9b.test.ex calling lookuphost router lookuphost router called for xxx@mxt9b.test.ex domain = mxt9b.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp queued for <unset> transport: local_part = xxx domain = mxt9b.test.ex errors_to=NULL diff --git a/test/stderr/0143 b/test/stderr/0143 index 483248639..94717046f 100644 --- a/test/stderr/0143 +++ b/test/stderr/0143 @@ -4,6 +4,9 @@ admin user LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -12,6 +15,8 @@ dropping to exim gid; retaining priv uid router_name <my_main_router> >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>> --------> userx@domain.com <-------- +fresh-exec forking for transport +postfork: transport transport_name <my_smtp> my_smtp transport entered userx@domain.com @@ -51,6 +56,7 @@ no messages waiting for 127.0.0.1 SMTP>> QUIT cmd buf flush ddd bytes SMTP(close)>> +fresh-exec forked for transport: npppp Leaving my_smtp transport LOG: MAIN => userx@domain.com R=my_main_router T=my_smtp H=127.0.0.1 [127.0.0.1] C="250 OK" diff --git a/test/stderr/0161 b/test/stderr/0161 index d4a6676eb..5cc392abd 100644 --- a/test/stderr/0161 +++ b/test/stderr/0161 @@ -15,6 +15,27 @@ checking domains calling lookuphost router lookuphost router called for xx@mxt6.test.ex domain = mxt6.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp set transport remote_smtp queued for remote_smtp transport: local_part = xx domain = mxt6.test.ex @@ -42,6 +63,15 @@ checking domains calling lookuphost router lookuphost router called for myhost.test.ex@mxt1.test.ex domain = mxt1.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp lowest numbered MX record points to local host: mxt1.test.ex: passed to next router (self = pass) lookuphost router passed for myhost.test.ex@mxt1.test.ex --------> fail router <-------- @@ -62,6 +92,12 @@ expanded list of hosts = 'myhost.test.ex' options = 'byname' set transport remote_smtp finding IP address for myhost.test.ex calling host_find_byname +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp queued for remote_smtp transport: local_part = myhost.test.ex domain = mxt1.test.ex errors_to=NULL @@ -88,6 +124,15 @@ checking domains calling lookuphost router lookuphost router called for xx@mxt1.test.ex domain = mxt1.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp lowest numbered MX record points to local host: mxt1.test.ex: passed to next router (self = pass) lookuphost router passed for xx@mxt1.test.ex --------> fail router <-------- @@ -108,6 +153,12 @@ expanded list of hosts = 'xx' options = 'byname' set transport remote_smtp finding IP address for xx calling host_find_byname +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp self router passed for xx@mxt1.test.ex --------> self2 router <-------- local_part=xx domain=mxt1.test.ex @@ -122,6 +173,12 @@ expanded list of hosts = 'myhost.test.ex' options = 'byname' set transport remote_smtp finding IP address for myhost.test.ex calling host_find_byname +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp queued for remote_smtp transport: local_part = xx domain = mxt1.test.ex errors_to=NULL @@ -148,6 +205,9 @@ checking domains calling lookuphost router lookuphost router called for xx@not.exist domain = not.exist +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp lookuphost router declined for xx@not.exist "more" is false: skipping remaining routers no more routers @@ -165,6 +225,15 @@ checking local_parts calling failuphost router failuphost router called for ff@mxt1.test.ex domain = mxt1.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp lowest numbered MX record points to local host: mxt1.test.ex: address failed (self = fail) failuphost router forced address failure >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=2 >>>>>>>>>>>>>>>> @@ -185,6 +254,15 @@ checking domains calling lookuphost router lookuphost router called for fff@mxt1.test.ex domain = mxt1.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp lowest numbered MX record points to local host: mxt1.test.ex: passed to next router (self = pass) lookuphost router passed for fff@mxt1.test.ex --------> fail router <-------- @@ -201,5 +279,11 @@ expanded list of hosts = 'fff' options = 'byname' set transport remote_smtp finding IP address for fff calling host_find_byname +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp fail router forced address failure >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=2 >>>>>>>>>>>>>>>> diff --git a/test/stderr/0169 b/test/stderr/0169 index f67292edc..d8ab0efb3 100644 --- a/test/stderr/0169 +++ b/test/stderr/0169 @@ -3,6 +3,9 @@ configuration file is TESTSUITE/test-config admin user LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -10,6 +13,8 @@ admin user dropping to exim gid; retaining priv uid >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>> --------> userx@myhost.test.ex <-------- +fresh-exec forking for delivery (local) +postfork: delivery (local) appendfile transport entered appendfile: mode=600 notify_comsat=0 quota=52428800 warning=41% file=TESTSUITE/test-mail/userx format=unix @@ -30,6 +35,7 @@ writing data block fd=dddd size=sss timeout=0 writing data block fd=dddd size=sss timeout=0 quota = 52428800 threshold = 21495808 old size = sssss message size = sss appendfile yields 0 with errno=dd more_errno=dd +fresh-exec forked for delivery (local): npppp appendfile transport returned OK for userx@myhost.test.ex added retry item for T:userx@myhost.test.ex: errno=dd more_errno=dd flags=1 LOG: MAIN diff --git a/test/stderr/0183 b/test/stderr/0183 index 98d82f8e8..0de70e79b 100644 --- a/test/stderr/0183 +++ b/test/stderr/0183 @@ -32,6 +32,9 @@ lookuphost router called for userx@test.again.dns domain = test.again.dns test.again.dns in "*"? yes (matched "*") DNS lookup of test.again.dns (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of test.again.dns (MX) gave TRY_AGAIN test.again.dns in dns_again_means_nonexist? no (option unset) returning DNS_AGAIN @@ -90,12 +93,18 @@ lookuphost router called for abcd@ten-1.test.ex domain = ten-1.test.ex ten-1.test.ex in "*"? yes (matched "*") DNS lookup of ten-1.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ten-1.test.ex (MX) gave NO_DATA returning DNS_NODATA faking res_search(MX) response length as 65535 writing neg-cache entry for ten-1.test.ex-MX-xxxx, ttl 3000 ten-1.test.ex (MX resp) DNSSEC DNS lookup of ten-1.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ten-1.test.ex (A) succeeded fully qualified name = ten-1.test.ex ten-1.test.ex V4NET.0.0.1 mx=-1 sort=xx @@ -135,6 +144,9 @@ finding IP address for test.again.dns doing DNS lookup test.again.dns in "*"? yes (matched "*") DNS lookup of test.again.dns (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of test.again.dns (A) gave TRY_AGAIN test.again.dns in dns_again_means_nonexist? no (option unset) returning DNS_AGAIN @@ -195,6 +207,9 @@ lookuphost router called for xyz@ten-1.test.ex ten-1.test.ex in "*"? yes (matched "*") DNS lookup of ten-1.test.ex-MX: using cached value DNS_NODATA DNS lookup of ten-1.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ten-1.test.ex (A) succeeded fully qualified name = ten-1.test.ex ten-1.test.ex V4NET.0.0.1 mx=-1 sort=xx @@ -242,6 +257,9 @@ lookuphost router called for userx@test.fail.dns domain = test.fail.dns test.fail.dns in "*"? yes (matched "*") DNS lookup of test.fail.dns (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of test.fail.dns (MX) gave NO_RECOVERY returning DNS_FAIL writing neg-cache entry for test.fail.dns-MX-xxxx, ttl -1 @@ -299,12 +317,18 @@ lookuphost router called for abcd@ten-1.test.ex domain = ten-1.test.ex ten-1.test.ex in "*"? yes (matched "*") DNS lookup of ten-1.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ten-1.test.ex (MX) gave NO_DATA returning DNS_NODATA faking res_search(MX) response length as 65535 writing neg-cache entry for ten-1.test.ex-MX-xxxx, ttl 3000 ten-1.test.ex (MX resp) DNSSEC DNS lookup of ten-1.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ten-1.test.ex (A) succeeded fully qualified name = ten-1.test.ex ten-1.test.ex V4NET.0.0.1 mx=-1 sort=xx @@ -344,6 +368,9 @@ finding IP address for test.fail.dns doing DNS lookup test.fail.dns in "*"? yes (matched "*") DNS lookup of test.fail.dns (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of test.fail.dns (A) gave NO_RECOVERY returning DNS_FAIL writing neg-cache entry for test.fail.dns-A-xxxx, ttl -1 @@ -403,6 +430,9 @@ lookuphost router called for xyz@ten-1.test.ex ten-1.test.ex in "*"? yes (matched "*") DNS lookup of ten-1.test.ex-MX: using cached value DNS_NODATA DNS lookup of ten-1.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ten-1.test.ex (A) succeeded fully qualified name = ten-1.test.ex ten-1.test.ex V4NET.0.0.1 mx=-1 sort=xx @@ -450,6 +480,9 @@ lookuphost router called for userx@nonexist.test.ex domain = nonexist.test.ex nonexist.test.ex in "*"? yes (matched "*") DNS lookup of nonexist.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of nonexist.test.ex (MX) gave HOST_NOT_FOUND returning DNS_NOMATCH faking res_search(MX) response length as 65535 @@ -510,12 +543,18 @@ lookuphost router called for abcd@ten-1.test.ex domain = ten-1.test.ex ten-1.test.ex in "*"? yes (matched "*") DNS lookup of ten-1.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ten-1.test.ex (MX) gave NO_DATA returning DNS_NODATA faking res_search(MX) response length as 65535 writing neg-cache entry for ten-1.test.ex-MX-xxxx, ttl 3000 ten-1.test.ex (MX resp) DNSSEC DNS lookup of ten-1.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ten-1.test.ex (A) succeeded fully qualified name = ten-1.test.ex ten-1.test.ex V4NET.0.0.1 mx=-1 sort=xx @@ -555,6 +594,9 @@ finding IP address for nonexist.test.ex doing DNS lookup nonexist.test.ex in "*"? yes (matched "*") DNS lookup of nonexist.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of nonexist.test.ex (A) gave HOST_NOT_FOUND returning DNS_NOMATCH faking res_search(A) response length as 65535 @@ -615,6 +657,9 @@ lookuphost router called for xyz@ten-1.test.ex ten-1.test.ex in "*"? yes (matched "*") DNS lookup of ten-1.test.ex-MX: using cached value DNS_NODATA DNS lookup of ten-1.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ten-1.test.ex (A) succeeded fully qualified name = ten-1.test.ex ten-1.test.ex V4NET.0.0.1 mx=-1 sort=xx @@ -652,6 +697,9 @@ srv router called for srv@test.again.dns domain = test.again.dns test.again.dns in "*"? yes (matched "*") DNS lookup of _smtp._tcp.test.again.dns (SRV) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of _smtp._tcp.test.again.dns (SRV) gave TRY_AGAIN _smtp._tcp.test.again.dns in dns_again_means_nonexist? no (option unset) returning DNS_AGAIN @@ -674,18 +722,27 @@ srv router called for srv@test.fail.dns domain = test.fail.dns test.fail.dns in "*"? yes (matched "*") DNS lookup of _smtp._tcp.test.fail.dns (SRV) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of _smtp._tcp.test.fail.dns (SRV) gave NO_RECOVERY returning DNS_FAIL writing neg-cache entry for _smtp._tcp.test.fail.dns-SRV-xxxx, ttl -1 test.fail.dns in "test.fail.dns"? yes (matched "test.fail.dns") DNS_FAIL treated as DNS_NODATA (domain in srv_fail_domains) DNS lookup of test.fail.dns (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of test.fail.dns (MX) gave NO_RECOVERY returning DNS_FAIL writing neg-cache entry for test.fail.dns-MX-xxxx, ttl -1 test.fail.dns in "test.fail.dns"? yes (matched "test.fail.dns") DNS_FAIL treated as DNS_NODATA (domain in mx_fail_domains) DNS lookup of test.fail.dns (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of test.fail.dns (A) gave NO_RECOVERY returning DNS_FAIL writing neg-cache entry for test.fail.dns-A-xxxx, ttl -1 @@ -727,6 +784,9 @@ lookuphost router called for userx@nonexist.example.com domain = nonexist.example.com nonexist.example.com in "*"? yes (matched "*") DNS lookup of nonexist.example.com (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of nonexist.example.com (MX) gave HOST_NOT_FOUND returning DNS_NOMATCH faking res_search(MX) response length as 65535 @@ -771,6 +831,9 @@ delay router called for userd@nonexist.example.com nonexist.example.com in "*"? yes (matched "*") DNS lookup of nonexist.example.com-MX: cached value DNS_NOMATCH past valid time DNS lookup of nonexist.example.com (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of nonexist.example.com (MX) gave HOST_NOT_FOUND returning DNS_NOMATCH faking res_search(MX) response length as 65535 diff --git a/test/stderr/0218 b/test/stderr/0218 index 5d7c1d843..d77509027 100644 --- a/test/stderr/0218 +++ b/test/stderr/0218 @@ -7,18 +7,34 @@ LOG: queue_run MAIN Start queue run: pid=pppp -qq queue running combined directories looking in TESTSUITE/spool//input +fresh-exec forking for qrun delivery +postfork: qrun delivery delivering 10HmaX-0005vi-00 (queue run pid ppppp) R: client (ACL) +qrun delivery forking for transport +postfork: transport T: send_to_server (ACL) +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery delivering 10HmaY-0005vi-00 (queue run pid ppppp) R: client (ACL) +qrun delivery forking for transport +postfork: transport T: send_to_server (ACL) +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> queue running combined directories looking in TESTSUITE/spool//input +fresh-exec forking for qrun delivery +postfork: qrun delivery delivering 10HmaX-0005vi-00 (queue run pid ppppp) R: client (ACL) +qrun delivery forking for transport +postfork: transport T: send_to_server (ACL) Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP<< 220 Server ready @@ -33,6 +49,14 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP<< 351 Send more SMTP>> writing message and terminating "." SMTP<< 250 OK +transport forking for continued-transport interproc +postfork: continued-transport interproc +continued-transport interproc forking for continued-transport +postfork: continued-transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp +transport forked for continued-transport interproc: npppp +continued-transport interproc forked for continued-transport: npppp SMTP(close)>> LOG: MAIN => a@test.ex F=<CALLER@test.ex> R=client T=send_to_server H=127.0.0.1 [127.0.0.1] L C="250 OK" @@ -46,10 +70,13 @@ admin user dropping to exim gid; retaining priv uid delivering 10HmaY-0005vi-00 (queue run pid ppppp) R: client (ACL) +fresh-exec forking for transport +postfork: transport T: send_to_server (ACL) SMTP>> MAIL FROM:<CALLER@test.ex> SMTP>> RCPT TO:<b@test.ex> SMTP>> DATA +fresh-exec forked for transport: npppp SMTP<< 250 OK SMTP<< 250 OK SMTP<< 351 Send more @@ -74,18 +101,34 @@ LOG: queue_run MAIN Start queue run: pid=pppp -qq queue running combined directories looking in TESTSUITE/spool//input +fresh-exec forking for qrun delivery +postfork: qrun delivery delivering 10HmaZ-0005vi-00 (queue run pid ppppp) R: client (ACL) +qrun delivery forking for transport +postfork: transport T: send_to_server (ACL) +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery delivering 10HmbA-0005vi-00 (queue run pid ppppp) R: client (ACL) +qrun delivery forking for transport +postfork: transport T: send_to_server (ACL) +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> queue running combined directories looking in TESTSUITE/spool//input +fresh-exec forking for qrun delivery +postfork: qrun delivery delivering 10HmaZ-0005vi-00 (queue run pid ppppp) R: client (ACL) +qrun delivery forking for transport +postfork: transport T: send_to_server (ACL) Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP<< 220 Server ready @@ -100,8 +143,13 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP<< 503 Unexpected DATA SMTP>> QUIT SMTP(close)>> +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp LOG: MAIN ** a@test.ex F=<CALLER@test.ex> R=client T=send_to_server H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after pipelined MAIL FROM:<CALLER@test.ex>: 550 NO +qrun delivery forking for bounce message +postfork: bounce message +qrun delivery forked for bounce message: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -112,12 +160,18 @@ LOG: MAIN LOG: MAIN Completed >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery delivering 10HmbA-0005vi-00 (queue run pid ppppp) R: client (ACL) +qrun delivery forking for transport +postfork: transport T: send_to_server (ACL) Connecting to 127.0.0.1 [127.0.0.1]:1224 ... failed: Connection refused LOG: MAIN H=127.0.0.1 [127.0.0.1] Connection refused +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp LOG: MAIN == b@test.ex R=client T=send_to_server defer (dd): Connection refused >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> @@ -130,10 +184,18 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp -qqf +fresh-exec forking for qrun delivery +postfork: qrun delivery delivering 10HmbA-0005vi-00 (queue run pid ppppp) R: client (ACL) +qrun delivery forking for transport +postfork: transport T: send_to_server (ACL) +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery delivering 10HmbB-0005vi-00 (queue run pid ppppp) R: bounce (ACL) LOG: MAIN @@ -143,12 +205,23 @@ LOG: MAIN LOG: MAIN Completed >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forked for qrun delivery: npppp +fresh-exec forking for qrun delivery +postfork: qrun delivery delivering 10HmbC-0005vi-00 (queue run pid ppppp) R: client (ACL) +qrun delivery forking for transport +postfork: transport T: send_to_server (ACL) +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery delivering 10HmbA-0005vi-00 (queue run pid ppppp) R: client (ACL) +qrun delivery forking for transport +postfork: transport T: send_to_server (ACL) Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP<< 220 Server ready @@ -163,9 +236,20 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP<< 503 Unexpected DATA SMTP>> RSET SMTP<< 250 OK +transport forking for continued-transport interproc +postfork: continued-transport interproc +continued-transport interproc forking for continued-transport +postfork: continued-transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp +transport forked for continued-transport interproc: npppp +continued-transport interproc forked for continued-transport: npppp SMTP(close)>> LOG: MAIN ** b@test.ex F=<CALLER@test.ex> R=client T=send_to_server H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<b@test.ex>: 550 Unknown +qrun delivery forking for bounce message +postfork: bounce message +qrun delivery forked for bounce message: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -183,10 +267,13 @@ admin user dropping to exim gid; retaining priv uid delivering 10HmbC-0005vi-00 (queue run pid ppppp) R: client (ACL) +fresh-exec forking for transport +postfork: transport T: send_to_server (ACL) SMTP>> MAIL FROM:<CALLER@test.ex> SMTP>> RCPT TO:<c@test.ex> SMTP>> DATA +fresh-exec forked for transport: npppp SMTP<< 250 OK SMTP<< 250 OK SMTP<< 351 OK diff --git a/test/stderr/0264 b/test/stderr/0264 index 7e86817b4..2beb125bc 100644 --- a/test/stderr/0264 +++ b/test/stderr/0264 @@ -9,6 +9,9 @@ DSN: **** SPOOL_OUT - address: <rz.b@outside> errorsto: <NULL> orcpt: <NULL> dsn Renaming spool header file: TESTSUITE/spool//input//10HmbJ-0005vi-00-H LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user diff --git a/test/stderr/0275 b/test/stderr/0275 index af5aaef50..365f80453 100644 --- a/test/stderr/0275 +++ b/test/stderr/0275 @@ -144,7 +144,10 @@ LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -odi -Mc 10HmaX-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -286,6 +289,8 @@ search_tidyup called failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to userx <userx@test.ex> transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=NULL current=/ @@ -298,6 +303,7 @@ appendfile: mode=600 notify_comsat=0 quota=0 warning=0 maildir_use_size_file=no locking by lockfile fcntl search_tidyup called +fresh-exec forked for delivery (local): npppp journalling userx@test.ex t1 transport returned OK for userx@test.ex post-process userx@test.ex (0) diff --git a/test/stderr/0277 b/test/stderr/0277 index a28a021b0..48136b686 100644 --- a/test/stderr/0277 +++ b/test/stderr/0277 @@ -16,6 +16,9 @@ host in "V4NET.2.3.4"? yes (matched "V4NET.2.3.4") host in host_lookup? yes (matched "+lookup_hosts") looking up host name for V4NET.2.3.4 DNS lookup of 4.3.2.V4NET.in-addr.arpa (PTR) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of 4.3.2.V4NET.in-addr.arpa (PTR) gave HOST_NOT_FOUND returning DNS_NOMATCH DNS: no SOA record found for neg-TTL @@ -94,6 +97,9 @@ host in "V4NET.6.7.8"? no (end of list) host in host_lookup? yes (end of list) looking up host name for V4NET.10.11.12 DNS lookup of 12.11.10.V4NET.in-addr.arpa (PTR) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of 12.11.10.V4NET.in-addr.arpa (PTR) gave HOST_NOT_FOUND returning DNS_NOMATCH DNS: no SOA record found for neg-TTL @@ -139,6 +145,9 @@ host in "V4NET.6.7.8"? no (end of list) host in host_lookup? yes (end of list) looking up host name for V4NET.1.1.1 DNS lookup of 1.1.1.V4NET.in-addr.arpa (PTR) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of 1.1.1.V4NET.in-addr.arpa (PTR) gave HOST_NOT_FOUND returning DNS_NOMATCH DNS: no SOA record found for neg-TTL @@ -184,6 +193,9 @@ host in "V4NET.6.7.8"? no (end of list) host in host_lookup? yes (end of list) looking up host name for V4NET.2.2.2 DNS lookup of 2.2.2.V4NET.in-addr.arpa (PTR) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of 2.2.2.V4NET.in-addr.arpa (PTR) gave HOST_NOT_FOUND returning DNS_NOMATCH DNS: no SOA record found for neg-TTL diff --git a/test/stderr/0278 b/test/stderr/0278 index 834155bf9..af7929f5e 100644 --- a/test/stderr/0278 +++ b/test/stderr/0278 @@ -103,7 +103,10 @@ LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -odi -Mc 10HmaX-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -200,6 +203,8 @@ search_tidyup called failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to CALLER <CALLER@test.ex> transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=CALLER_HOME current=CALLER_HOME @@ -212,6 +217,7 @@ appendfile: mode=600 notify_comsat=0 quota=0 warning=0 maildir_use_size_file=no locking by lockfile fcntl search_tidyup called +fresh-exec forked for delivery (local): npppp journalling CALLER@test.ex t1 transport returned OK for CALLER@test.ex post-process CALLER@test.ex (0) @@ -290,12 +296,21 @@ r2 router called for unknown@test.ex domain = test.ex test.ex in "*"? yes (matched "*") DNS lookup of test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of test.ex (MX) gave NO_DATA returning DNS_NODATA faking res_search(MX) response length as 65535 writing neg-cache entry for test.ex-MX-xxxx, ttl 3000 test.ex (MX resp) DNSSEC +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of test.ex (A) gave NO_DATA returning DNS_NODATA faking res_search(A) response length as 65535 diff --git a/test/stderr/0283 b/test/stderr/0283 index 05b0be4f1..ff002dc9a 100644 --- a/test/stderr/0283 +++ b/test/stderr/0283 @@ -14,6 +14,9 @@ getpwnam() succeeded uid=uuuu gid=gggg LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -27,13 +30,25 @@ seeking password data for user "CALLER": cache not available getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID seeking password data for user "root": cache not available getpwnam() succeeded uid=uuuu gid=gggg +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to somebody <somebody@myhost.test.ex> transport=t1 uid=EXIM_UID gid=EXIM_GID pid=pppp +delivery (local) forking for child-open +postfork: child-open +fresh-exec forked for delivery (local): npppp +delivery (local) forked for child-open: npppp +delivery (local) forking for pipe-transport output +postfork: pipe-transport output +delivery (local) forked for pipe-transport output: npppp transport error EPIPE ignored LOG: MAIN ** somebody@myhost.test.ex R=rest T=t1: return message generated changed uid/gid: post-delivery tidying uid=EXIM_UID gid=EXIM_GID pid=pppp +fresh-exec forking for bounce message +postfork: bounce message +fresh-exec forked for bounce message: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -50,6 +65,9 @@ seeking password data for user "root": cache not available getpwnam() succeeded uid=uuuu gid=gggg LOG: MAIN <= <> R=10HmaY-0005vi-00 U=EXIMUSER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -63,8 +81,11 @@ seeking password data for user "CALLER": cache not available getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID seeking password data for user "root": cache not available getpwnam() succeeded uid=uuuu gid=gggg +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to CALLER <CALLER@myhost.test.ex> transport=t2 uid=CALLER_UID gid=CALLER_GID pid=pppp +fresh-exec forked for delivery (local): npppp LOG: MAIN => CALLER <CALLER@myhost.test.ex> R=caller T=t2 changed uid/gid: post-delivery tidying @@ -92,6 +113,9 @@ seeking password data for user "root": cache not available getpwnam() succeeded uid=uuuu gid=gggg LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -107,6 +131,9 @@ seeking password data for user "root": cache not available getpwnam() succeeded uid=uuuu gid=gggg LOG: MAIN PANIC User 0 set for t3 transport is on the never_users list +fresh-exec forking for logfile create +postfork: logfile create +fresh-exec forked for logfile create: npppp LOG: MAIN == never@myhost.test.ex R=never T=t3 defer (-29): User 0 set for t3 transport is on the never_users list changed uid/gid: post-delivery tidying diff --git a/test/stderr/0315 b/test/stderr/0315 index d31624964..3dcdcf76c 100644 --- a/test/stderr/0315 +++ b/test/stderr/0315 @@ -4,6 +4,9 @@ admin user LOG: MAIN <= CALLER@the.local.host.name U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -28,6 +31,15 @@ checking domains calling r1 router r1 router called for y@ten-1.test.ex domain = ten-1.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp set transport t1 queued for t1 transport: local_part = y domain = ten-1.test.ex @@ -48,7 +60,10 @@ After routing: y@ten-1.test.ex Failed addresses: Deferred addresses: +fresh-exec forking for transport +postfork: transport locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forked for transport: npppp LOG: MAIN *> x@ten-1.test.ex R=r1 T=t1 H=ten-1.test.ex [V4NET.0.0.1] C="delivery bypassed by -N option" LOG: MAIN @@ -62,6 +77,9 @@ configuration file is TESTSUITE/test-config admin user LOG: MAIN <= CALLER@the.local.host.name U=CALLER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -89,6 +107,15 @@ local_part=y domain=ten-2.test.ex calling r2 router r2 router called for y@ten-2.test.ex domain = ten-2.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp set transport t1 queued for t1 transport: local_part = y domain = ten-2.test.ex @@ -109,6 +136,9 @@ local_part=x domain=ten-2.test.ex calling r2 router r2 router called for x@ten-2.test.ex domain = ten-2.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp queued for t1 transport: local_part = x domain = ten-2.test.ex errors_to=NULL @@ -125,7 +155,10 @@ After routing: y@ten-2.test.ex Failed addresses: Deferred addresses: +fresh-exec forking for transport +postfork: transport locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forked for transport: npppp LOG: MAIN *> x@ten-2.test.ex R=r2 T=t1 H=ten-2.test.ex [V4NET.0.0.2] C="delivery bypassed by -N option" LOG: MAIN diff --git a/test/stderr/0332 b/test/stderr/0332 index 549a66302..eaf97e370 100644 --- a/test/stderr/0332 +++ b/test/stderr/0332 @@ -4,6 +4,8 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp +fresh-exec forking for qrun delivery +postfork: qrun delivery locking TESTSUITE/spool/db/retry.lockfile >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: ok@no.delay @@ -32,8 +34,18 @@ After routing: ok@no.delay Failed addresses: Deferred addresses: +qrun delivery forking for transport +postfork: transport locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-t1.lockfile +transport forking for continued-transport interproc +postfork: continued-transport interproc +continued-transport interproc forking for continued-transport +postfork: continued-transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp +transport forked for continued-transport interproc: npppp +continued-transport interproc forked for continued-transport: npppp LOG: MAIN => ok@no.delay R=r1 T=t1 H=127.0.0.1 [127.0.0.1] C="250 OK" LOG: MAIN @@ -78,11 +90,16 @@ After routing: Failed addresses: Deferred addresses: delay@test.again.dns +fresh-exec forking for transport +postfork: transport locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forked for transport: npppp locking TESTSUITE/spool/db/wait-t1.lockfile LOG: MAIN => ok@no.delay R=r1 T=t1 H=127.0.0.1 [127.0.0.1]* C="250 OK" >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery locking TESTSUITE/spool/db/retry.lockfile >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: delay@test.again.dns @@ -97,6 +114,7 @@ After routing: Deferred addresses: delay@test.again.dns >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forked for qrun delivery: npppp LOG: queue_run MAIN End queue run: pid=pppp >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>> diff --git a/test/stderr/0333 b/test/stderr/0333 index 723abbc65..f15d1d942 100644 --- a/test/stderr/0333 +++ b/test/stderr/0333 @@ -30,8 +30,17 @@ After routing: ok@no.delay Failed addresses: Deferred addresses: +fresh-exec forking for transport +postfork: transport locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-t1.lockfile +transport forking for continued-transport interproc +postfork: continued-transport interproc +continued-transport interproc forking for continued-transport +postfork: continued-transport +fresh-exec forked for transport: npppp +transport forked for continued-transport interproc: npppp +continued-transport interproc forked for continued-transport: npppp LOG: MAIN => ok@no.delay R=r1 T=t1 H=127.0.0.1 [127.0.0.1] C="250 OK" LOG: MAIN @@ -76,7 +85,10 @@ After routing: Failed addresses: Deferred addresses: delay@test.again.dns +fresh-exec forking for transport +postfork: transport locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forked for transport: npppp locking TESTSUITE/spool/db/wait-t1.lockfile LOG: MAIN => ok@no.delay R=r1 T=t1 H=127.0.0.1 [127.0.0.1]* C="250 OK" diff --git a/test/stderr/0357 b/test/stderr/0357 index bfb5bab1c..dcce26b3a 100644 --- a/test/stderr/0357 +++ b/test/stderr/0357 @@ -4,6 +4,9 @@ admin user LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -22,10 +25,13 @@ After routing: userx@test.ex Failed addresses: Deferred addresses: +fresh-exec forking for transport +postfork: transport checking status of 127.0.0.1 locking TESTSUITE/spool/db/retry.lockfile no retry data available added retry item for R:userx@test.ex:<CALLER@test.ex>: errno=-44 more_errno=dd,A flags=0 +fresh-exec forked for transport: npppp reading retry information for R:userx@test.ex:<CALLER@test.ex> from subprocess added retry item LOG: MAIN @@ -50,6 +56,8 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp +fresh-exec forking for qrun delivery +postfork: qrun delivery locking TESTSUITE/spool/db/retry.lockfile >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: userx@test.ex @@ -65,11 +73,15 @@ After routing: userx@test.ex Failed addresses: Deferred addresses: +qrun delivery forking for transport +postfork: transport checking status of 127.0.0.1 locking TESTSUITE/spool/db/retry.lockfile no host retry record no message retry record added retry item for R:userx@test.ex:<CALLER@test.ex>: errno=-44 more_errno=dd,A flags=0 +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp reading retry information for R:userx@test.ex:<CALLER@test.ex> from subprocess existing delete item dropped added retry item @@ -107,6 +119,8 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp +fresh-exec forking for qrun delivery +postfork: qrun delivery locking TESTSUITE/spool/db/retry.lockfile >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: userx@test.ex @@ -122,11 +136,15 @@ After routing: userx@test.ex Failed addresses: Deferred addresses: +qrun delivery forking for transport +postfork: transport checking status of 127.0.0.1 locking TESTSUITE/spool/db/retry.lockfile no host retry record no message retry record added retry item for R:userx@test.ex:<CALLER@test.ex>: errno=-44 more_errno=dd,A flags=0 +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp reading retry information for R:userx@test.ex:<CALLER@test.ex> from subprocess existing delete item dropped added retry item @@ -164,6 +182,8 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp +fresh-exec forking for qrun delivery +postfork: qrun delivery locking TESTSUITE/spool/db/retry.lockfile >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: userx@test.ex @@ -188,6 +208,7 @@ Deferred addresses: userx@test.ex: no retry items end of retry processing >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forked for qrun delivery: npppp LOG: queue_run MAIN End queue run: pid=pppp >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>> diff --git a/test/stderr/0358 b/test/stderr/0358 index fc4676285..ea470c627 100644 --- a/test/stderr/0358 +++ b/test/stderr/0358 @@ -4,6 +4,9 @@ admin user LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -27,11 +30,14 @@ After routing: usery@test.ex Failed addresses: Deferred addresses: +fresh-exec forking for transport +postfork: transport checking status of 127.0.0.1 locking TESTSUITE/spool/db/retry.lockfile no retry data available added retry item for R:userx@test.ex:<CALLER@test.ex>: errno=-44 more_errno=dd,A flags=0 added retry item for R:usery@test.ex:<CALLER@test.ex>: errno=-44 more_errno=dd,A flags=0 +fresh-exec forked for transport: npppp reading retry information for R:userx@test.ex:<CALLER@test.ex> from subprocess added retry item reading retry information for R:usery@test.ex:<CALLER@test.ex> from subprocess @@ -66,6 +72,8 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp +fresh-exec forking for qrun delivery +postfork: qrun delivery locking TESTSUITE/spool/db/retry.lockfile >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: userx@test.ex @@ -89,12 +97,16 @@ After routing: usery@test.ex Failed addresses: Deferred addresses: +qrun delivery forking for transport +postfork: transport checking status of 127.0.0.1 locking TESTSUITE/spool/db/retry.lockfile no host retry record no message retry record added retry item for R:userx@test.ex:<CALLER@test.ex>: errno=-44 more_errno=dd,A flags=0 added retry item for R:usery@test.ex:<CALLER@test.ex>: errno=-44 more_errno=dd,A flags=0 +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp reading retry information for R:userx@test.ex:<CALLER@test.ex> from subprocess existing delete item dropped added retry item diff --git a/test/stderr/0360 b/test/stderr/0360 index 2308b3206..59a5dfbdf 100644 --- a/test/stderr/0360 +++ b/test/stderr/0360 @@ -4,6 +4,9 @@ admin user LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -103,7 +106,19 @@ checking domains calling r1 router r1 router called for unknown@recurse.test.ex domain = recurse.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp r1 router widened recurse.test.ex to recurse.test.ex.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp domain changed to recurse.test.ex.test.ex rewriting header lines re-routed to unknown@recurse.test.ex.test.ex @@ -124,6 +139,9 @@ checking domains calling r1 router r1 router called for unknown@recurse.test.ex.test.ex domain = recurse.test.ex.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp set transport t1 queued for t1 transport: local_part = unknown domain = recurse.test.ex.test.ex @@ -142,7 +160,10 @@ After routing: Failed addresses: Deferred addresses: defer@test.ex +fresh-exec forking for transport +postfork: transport locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forked for transport: npppp LOG: MAIN *> unknown@recurse.test.ex.test.ex <cms@test.ex> R=r1 T=t1 H=recurse.test.ex.test.ex [V4NET.99.0.2] C="delivery bypassed by -N option" >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>> @@ -153,6 +174,8 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp -qf +fresh-exec forking for qrun delivery +postfork: qrun delivery locking TESTSUITE/spool/db/retry.lockfile no retry data available >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> @@ -243,6 +266,7 @@ After routing: Deferred addresses: defer@test.ex >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forked for qrun delivery: npppp LOG: queue_run MAIN End queue run: pid=pppp -qf >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>> diff --git a/test/stderr/0361 b/test/stderr/0361 index 8f5ef0b2b..b760bc582 100644 --- a/test/stderr/0361 +++ b/test/stderr/0361 @@ -50,7 +50,10 @@ Size of headers = sss LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -N -odi -Mc 10HmaY-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -98,6 +101,9 @@ r1 router called for kilos@recurse.test.ex domain = recurse.test.ex recurse.test.ex in "*"? yes (matched "*") DNS lookup of recurse.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of recurse.test.ex (MX) gave HOST_NOT_FOUND returning DNS_NOMATCH faking res_search(MX) response length as 65535 @@ -105,12 +111,21 @@ faking res_search(MX) response length as 65535 r1 router widened recurse.test.ex to recurse.test.ex.test.ex recurse.test.ex.test.ex in "*"? yes (matched "*") DNS lookup of recurse.test.ex.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of recurse.test.ex.test.ex (MX) gave NO_DATA returning DNS_NODATA faking res_search(MX) response length as 65535 writing neg-cache entry for recurse.test.ex.test.ex-MX-xxxx, ttl 3000 recurse.test.ex.test.ex (MX resp) DNSSEC +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of recurse.test.ex.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of recurse.test.ex.test.ex (A) succeeded fully qualified name = recurse.test.ex.test.ex recurse.test.ex.test.ex V4NET.99.0.2 mx=-1 sort=xx @@ -215,6 +230,8 @@ search_tidyup called failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to kilos <kilos@recurse.test.ex.test.ex> transport=t2 uid=CALLER_UID gid=CALLER_GID pid=pppp home=NULL current=/ @@ -228,6 +245,7 @@ appendfile: mode=600 notify_comsat=0 quota=0 warning=0 locking by lockfile fcntl *** delivery by t2 transport bypassed by -N option search_tidyup called +fresh-exec forked for delivery (local): npppp journalling kilos@recurse.test.ex.test.ex/t2 t2 transport returned OK for kilos@recurse.test.ex.test.ex post-process kilos@recurse.test.ex.test.ex (0) diff --git a/test/stderr/0364 b/test/stderr/0364 index 43462a56f..b80065f17 100644 --- a/test/stderr/0364 +++ b/test/stderr/0364 @@ -73,6 +73,9 @@ checking domains calling r2 router r2 router called for solik@otherhost.test.ex domain = otherhost.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp r2 router declined for solik@otherhost.test.ex --------> r3 router <-------- local_part=solik domain=otherhost.test.ex @@ -99,6 +102,9 @@ checking domains calling r2 router r2 router called for solik@otherhost.sub.test.ex domain = otherhost.sub.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp r2 router declined for solik@otherhost.sub.test.ex --------> r3 router <-------- local_part=solik domain=otherhost.sub.test.ex @@ -141,6 +147,15 @@ checking domains calling r2 router r2 router called for xxx@ten-1.test.ex domain = ten-1.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp set transport t1 queued for t1 transport: local_part = xxx domain = ten-1.test.ex @@ -176,6 +191,9 @@ checking domains calling r2 router r2 router called for xxx@testsub.test.ex domain = testsub.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp r2 router declined for xxx@testsub.test.ex --------> r3 router <-------- local_part=xxx domain=testsub.test.ex @@ -202,6 +220,15 @@ checking domains calling r2 router r2 router called for xxx@testsub.sub.test.ex domain = testsub.sub.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp queued for t1 transport: local_part = xxx domain = testsub.sub.test.ex errors_to=NULL diff --git a/test/stderr/0368 b/test/stderr/0368 index 9412296b9..30e753093 100644 --- a/test/stderr/0368 +++ b/test/stderr/0368 @@ -2,12 +2,54 @@ Exim version x.yz .... configuration file is TESTSUITE/test-config admin user dropping to exim gid; retaining priv uid +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp discarded duplicate host ten-1.test.ex (MX=8) +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp fully qualified name = mxt9.test.ex host_find_bydns yield = HOST_FOUND (3); returned hosts: ten-1.test.ex V4NET.0.0.1 MX=5 ten-2.test.ex V4NET.0.0.2 MX=6 ten-3.test.ex V4NET.0.0.3 MX=7 +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp duplicate IP address V4NET.0.0.5 (MX=5) removed duplicate IP address V4NET.0.0.6 (MX=6) removed fully qualified name = mxt14.test.ex @@ -16,14 +58,23 @@ host_find_bydns yield = HOST_FOUND (3); returned hosts: ten-5-6.test.ex V4NET.0.0.6 MX=4 finding IP address for ten-1.test.ex doing DNS lookup +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp fully qualified name = ten-1.test.ex ten-1.test.ex V4NET.0.0.1 mx=-1 sort=xx finding IP address for ten-1.test.ex doing DNS lookup +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp fully qualified name = ten-1.test.ex ten-1.test.ex V4NET.0.0.1 mx=-1 sort=xx finding IP address for ten-2.test.ex doing DNS lookup +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp fully qualified name = ten-2.test.ex ten-2.test.ex V4NET.0.0.2 mx=-1 sort=xx >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>> diff --git a/test/stderr/0370 b/test/stderr/0370 index ff8ccb065..c7f6f360a 100644 --- a/test/stderr/0370 +++ b/test/stderr/0370 @@ -8,6 +8,9 @@ changed uid/gid: privilege not needed LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -17,11 +20,20 @@ admin user dropping to exim gid; retaining priv uid >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>> --------> |TESTSUITE/bin/iefbr14 <-------- +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to |TESTSUITE/bin/iefbr14 <|TESTSUITE/bin/iefbr14> transport=t1 uid=EXIM_UID gid=CALLER_GID pid=pppp t1 transport entered direct command: argv[0] = 'TESTSUITE/bin/iefbr14' +delivery (local) forking for child-open +postfork: child-open +fresh-exec forked for delivery (local): npppp +delivery (local) forked for child-open: npppp +delivery (local) forking for pipe-transport output +postfork: pipe-transport output +delivery (local) forked for pipe-transport output: npppp Writing message to pipe writing data block fd=dddd size=sss timeout=3600 writing error EEE: Broken pipe diff --git a/test/stderr/0374 b/test/stderr/0374 index 27b04a234..86f260fc9 100644 --- a/test/stderr/0374 +++ b/test/stderr/0374 @@ -4,6 +4,9 @@ admin user LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -337,52 +340,106 @@ After routing: Failed addresses: Deferred addresses: locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => a1 <a1@myhost.test.ex> R=real T=real locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => b1 <b1@myhost.test.ex> R=real T=real locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => c1 <c1@myhost.test.ex> R=real T=real locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => d1 <d1@myhost.test.ex> R=real T=real locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => d2 <d2@myhost.test.ex> R=real T=real locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => d3 <d3@myhost.test.ex> R=real T=real locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => a1 <a1@myhost.test.ex> R=u1 T=ut1 locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +delivery (local) forking for child-open +postfork: child-open +fresh-exec forked for delivery (local): npppp +delivery (local) forked for child-open: npppp +delivery (local) forking for pipe-transport output +postfork: pipe-transport output +delivery (local) forked for pipe-transport output: npppp transport error EPIPE ignored LOG: MAIN ** b1@myhost.test.ex R=ut2 T=ut2: Child process of ut2 transport returned 127 (could mean unable to exec or command does not exist) from command: /non/existent/file locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +delivery (local) forking for child-open +postfork: child-open +fresh-exec forked for delivery (local): npppp +delivery (local) forked for child-open: npppp +delivery (local) forking for pipe-transport output +postfork: pipe-transport output +delivery (local) forked for pipe-transport output: npppp transport error EPIPE ignored LOG: MAIN == c1@myhost.test.ex R=ut3 T=ut3 defer (0): Child process of ut3 transport returned 127 (could mean unable to exec or command does not exist) from command: /non/existent/file +fresh-exec forking for transport +postfork: transport locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-ut4.lockfile +fresh-exec forked for transport: npppp LOG: MAIN => d1@myhost.test.ex R=ut4 T=ut4 H=127.0.0.1 [127.0.0.1] C="250 OK" +fresh-exec forking for transport +postfork: transport locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forked for transport: npppp LOG: MAIN == d2@myhost.test.ex R=ut4 T=ut4 defer (-44) H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<d2@myhost.test.ex>: 450 soft error +fresh-exec forking for transport +postfork: transport locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-ut4.lockfile +fresh-exec forked for transport: npppp LOG: MAIN ** d3@myhost.test.ex R=ut4 T=ut4 H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<d3@myhost.test.ex>: 550 hard error locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for bounce message +postfork: bounce message +fresh-exec forked for bounce message: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user admin user LOG: MAIN <= <> R=10HmaX-0005vi-00 U=EXIMUSER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -432,6 +489,9 @@ After routing: Failed addresses: Deferred addresses: locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => CALLER <CALLER@myhost.test.ex> R=real T=real LOG: MAIN diff --git a/test/stderr/0375 b/test/stderr/0375 index cc30e5668..f12e5cd57 100644 --- a/test/stderr/0375 +++ b/test/stderr/0375 @@ -4,6 +4,9 @@ admin user LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -757,79 +760,151 @@ After routing: Deferred addresses: g1@myhost.test.ex locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => a1 <a1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => b1 <b1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => c1 <c1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => d1 <d1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => d2 <d2@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => d3 <d3@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => e1 <e1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => f1 <f1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => f2 <f2@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => f3 <f3@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => a1 <a1@myhost.test.ex> P=<> R=u1 T=ut1 log writing disabled locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +delivery (local) forking for child-open +postfork: child-open +fresh-exec forked for delivery (local): npppp +delivery (local) forked for child-open: npppp +delivery (local) forking for pipe-transport output +postfork: pipe-transport output +delivery (local) forked for pipe-transport output: npppp transport error EPIPE ignored LOG: MAIN ** b1@myhost.test.ex P=<> R=ut2 T=ut2: Child process of ut2 transport returned 127 (could mean unable to exec or command does not exist) from command: /non/existent/file log writing disabled locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +delivery (local) forking for child-open +postfork: child-open +fresh-exec forked for delivery (local): npppp +delivery (local) forked for child-open: npppp +delivery (local) forking for pipe-transport output +postfork: pipe-transport output +delivery (local) forked for pipe-transport output: npppp transport error EPIPE ignored LOG: MAIN == c1@myhost.test.ex R=ut3 T=ut3 defer (0): Child process of ut3 transport returned 127 (could mean unable to exec or command does not exist) from command: /non/existent/file log writing disabled +fresh-exec forking for transport +postfork: transport locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-ut4.lockfile +fresh-exec forked for transport: npppp LOG: MAIN => d1@myhost.test.ex P=<> R=ut4 T=ut4 H=127.0.0.1 [127.0.0.1] C="250 OK" log writing disabled +fresh-exec forking for transport +postfork: transport locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forked for transport: npppp LOG: MAIN == d2@myhost.test.ex R=ut4 T=ut4 defer (-44) H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<d2@myhost.test.ex>: 450 soft error log writing disabled +fresh-exec forking for transport +postfork: transport locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-ut4.lockfile +fresh-exec forked for transport: npppp LOG: MAIN ** d3@myhost.test.ex P=<> R=ut4 T=ut4 H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<d3@myhost.test.ex>: 550 hard error log writing disabled +fresh-exec forking for transport +postfork: transport locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-ut5.lockfile +fresh-exec forked for transport: npppp LOG: MAIN ** e1@myhost.test.ex P=<> R=ut5 T=ut5 H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<e1@myhost.test.ex>: 550 hard error log writing disabled +fresh-exec forking for transport +postfork: transport locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-ut6.lockfile +fresh-exec forked for transport: npppp LOG: MAIN => f1@myhost.test.ex P=<CALLER@myhost.test.ex> R=ut6 T=ut6 H=127.0.0.1 [127.0.0.1] C="250 OK" log writing disabled +fresh-exec forking for transport +postfork: transport locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forked for transport: npppp LOG: MAIN == f2@myhost.test.ex R=ut6 T=ut6 defer (-44) H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<f2@myhost.test.ex>: 450 soft error log writing disabled +fresh-exec forking for transport +postfork: transport locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-ut6.lockfile +fresh-exec forked for transport: npppp LOG: MAIN ** f3@myhost.test.ex P=<CALLER@myhost.test.ex> R=ut6 T=ut6 H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<f3@myhost.test.ex>: 550 hard error log writing disabled @@ -837,12 +912,18 @@ locking TESTSUITE/spool/db/retry.lockfile LOG: MAIN f3@myhost.test.ex <f3@myhost.test.ex>: error ignored log writing disabled +fresh-exec forking for bounce message +postfork: bounce message +fresh-exec forked for bounce message: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user admin user LOG: MAIN <= <> R=10HmaX-0005vi-00 U=EXIMUSER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -908,6 +989,9 @@ After routing: Failed addresses: Deferred addresses: locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => CALLER <CALLER@myhost.test.ex> P=<> R=real T=real LOG: MAIN @@ -927,6 +1011,9 @@ configuration file is TESTSUITE/test-config admin user LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -1012,9 +1099,15 @@ After routing: Failed addresses: Deferred addresses: locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => h1 <h1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => h1 <h1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=ut8 T=ut1 log writing disabled diff --git a/test/stderr/0377 b/test/stderr/0377 index 09a1992e3..91d58ecad 100644 --- a/test/stderr/0377 +++ b/test/stderr/0377 @@ -4,6 +4,9 @@ admin user LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -299,12 +302,21 @@ After routing: defer_bbbb@myhost.test.ex defer_cccc@myhost.test.ex locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => aaaa <aaaa@myhost.test.ex> R=seen_aaaa T=t1 locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => bbbb <bbbb@myhost.test.ex> R=bbbb_0 T=t1 locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => cccc <cccc@myhost.test.ex> R=cccc_accept T=t1 locking TESTSUITE/spool/db/retry.lockfile @@ -316,6 +328,8 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp -qf +fresh-exec forking for qrun delivery +postfork: qrun delivery locking TESTSUITE/spool/db/retry.lockfile >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: aaaa@myhost.test.ex @@ -552,6 +566,7 @@ aaaa@myhost.test.ex was previously delivered (t1 transport): discarded bbbb@myhost.test.ex was previously delivered (t1 transport): discarded locking TESTSUITE/spool/db/retry.lockfile >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forked for qrun delivery: npppp LOG: queue_run MAIN End queue run: pid=pppp -qf >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>> @@ -561,6 +576,8 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp -qf +fresh-exec forking for qrun delivery +postfork: qrun delivery locking TESTSUITE/spool/db/retry.lockfile >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: aaaa@myhost.test.ex @@ -797,6 +814,7 @@ aaaa@myhost.test.ex was previously delivered (t1 transport): discarded bbbb@myhost.test.ex was previously delivered (t1 transport): discarded locking TESTSUITE/spool/db/retry.lockfile >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forked for qrun delivery: npppp LOG: queue_run MAIN End queue run: pid=pppp -qf >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>> diff --git a/test/stderr/0378 b/test/stderr/0378 index 1fa21a3e2..a7b63fd5c 100644 --- a/test/stderr/0378 +++ b/test/stderr/0378 @@ -4,6 +4,9 @@ admin user LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -41,10 +44,13 @@ save TESTSUITE/test-mail/file pipe "/bin/sh -c exit" mail subject autoreply text "This is an autoreply"' (tainted) +fresh-exec forking for router interpret +postfork: router interpret data is an Exim filter program Filter: start of processing Filter: end of processing >>>>>>>>>>>>>>>> Exim pid=pppp (rda) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forked for router interpret: npppp rda_interpret: subprocess yield=0 error=NULL set transport t3 aaaa router generated >CALLER@myhost.test.ex @@ -115,11 +121,20 @@ After routing: Deferred addresses: defer_aaaa@myhost.test.ex locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +delivery (local) forking for autoreply +postfork: autoreply +fresh-exec forked for delivery (local): npppp +delivery (local) forked for autoreply: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config admin user LOG: MAIN <= <> R=10HmaX-0005vi-00 U=CALLER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -158,10 +173,22 @@ LOG: MAIN LOG: MAIN => >CALLER@myhost.test.ex <aaaa@myhost.test.ex> R=aaaa T=t3 locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +delivery (local) forking for child-open +postfork: child-open +fresh-exec forked for delivery (local): npppp +delivery (local) forked for child-open: npppp +delivery (local) forking for pipe-transport output +postfork: pipe-transport output +delivery (local) forked for pipe-transport output: npppp transport error EPIPE ignored LOG: MAIN => |/bin/sh -c exit <aaaa@myhost.test.ex> R=aaaa T=t2 locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => TESTSUITE/test-mail/file <aaaa@myhost.test.ex> R=aaaa T=t1 locking TESTSUITE/spool/db/retry.lockfile @@ -173,6 +200,8 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp -qf +fresh-exec forking for qrun delivery +postfork: qrun delivery locking TESTSUITE/spool/db/retry.lockfile >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: aaaa@myhost.test.ex @@ -232,10 +261,14 @@ save TESTSUITE/test-mail/file pipe "/bin/sh -c exit" mail subject autoreply text "This is an autoreply"' (tainted) +qrun delivery forking for router interpret +postfork: router interpret data is an Exim filter program Filter: start of processing Filter: end of processing >>>>>>>>>>>>>>>> Exim pid=pppp (rda) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for router interpret: npppp rda_interpret: subprocess yield=0 error=NULL set transport t3 aaaa router generated >CALLER@myhost.test.ex diff --git a/test/stderr/0379 b/test/stderr/0379 index d4d49f0d3..2035bd844 100644 --- a/test/stderr/0379 +++ b/test/stderr/0379 @@ -4,6 +4,9 @@ admin user LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -126,9 +129,15 @@ After routing: Deferred addresses: defer@myhost.test.ex locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => bbbb <aaaa@myhost.test.ex> R=bc T=t1 locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => cccc <aaaa@myhost.test.ex> R=bc T=t1 locking TESTSUITE/spool/db/retry.lockfile @@ -140,6 +149,8 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp -qf +fresh-exec forking for qrun delivery +postfork: qrun delivery locking TESTSUITE/spool/db/retry.lockfile >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: defer@myhost.test.ex @@ -169,6 +180,7 @@ After routing: defer@myhost.test.ex locking TESTSUITE/spool/db/retry.lockfile >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forked for qrun delivery: npppp LOG: queue_run MAIN End queue run: pid=pppp -qf >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>> diff --git a/test/stderr/0380 b/test/stderr/0380 index b163d3f99..698cce50b 100644 --- a/test/stderr/0380 +++ b/test/stderr/0380 @@ -4,6 +4,9 @@ admin user LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -79,6 +82,9 @@ After routing: Deferred addresses: aaaa@myhost.test.ex locking TESTSUITE/spool/db/retry.lockfile +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp LOG: MAIN => bbbb <bbbb@myhost.test.ex> R=r3 T=t1 locking TESTSUITE/spool/db/retry.lockfile diff --git a/test/stderr/0381 b/test/stderr/0381 index 42b52d031..90edf4b2d 100644 --- a/test/stderr/0381 +++ b/test/stderr/0381 @@ -38,16 +38,31 @@ check hosts = *.gov.uk.test.ex sender host name required, to match against *.gov.uk.test.ex looking up host name for V4NET.99.99.97 DNS lookup of 97.99.99.V4NET.in-addr.arpa (PTR) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of 97.99.99.V4NET.in-addr.arpa (PTR) succeeded IP address lookup yielded "x.gov.uk.test.ex" alias "x.co.uk.test.ex" +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of x.gov.uk.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of x.gov.uk.test.ex (A) succeeded x.gov.uk.test.ex V4NET.99.99.97 mx=-1 sort=xx checking addresses for x.gov.uk.test.ex Forward DNS security status: unverified V4NET.99.99.97 OK +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of x.co.uk.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of x.co.uk.test.ex (A) succeeded x.co.uk.test.ex V4NET.99.99.97 mx=-1 sort=xx checking addresses for x.co.uk.test.ex diff --git a/test/stderr/0382 b/test/stderr/0382 index cf2af99c4..7605a7bd6 100644 --- a/test/stderr/0382 +++ b/test/stderr/0382 @@ -4,6 +4,9 @@ admin user LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -15,12 +18,18 @@ running system filter system filter returned 1 LOG: MAIN ** userx@test.ex R=r1: forced fail +fresh-exec forking for bounce message +postfork: bounce message +fresh-exec forked for bounce message: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user admin user LOG: MAIN <= <> R=10HmaX-0005vi-00 U=EXIMUSER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -46,11 +55,14 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp -qf +fresh-exec forking for qrun delivery +postfork: qrun delivery LOG: MAIN cancelled by timeout_frozen_after LOG: MAIN Completed >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forked for qrun delivery: npppp LOG: queue_run MAIN End queue run: pid=pppp -qf >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>> diff --git a/test/stderr/0386 b/test/stderr/0386 index 80de7da89..30dfa439a 100644 --- a/test/stderr/0386 +++ b/test/stderr/0386 @@ -195,10 +195,16 @@ check acl = TESTSUITE/aux-fixed/0386.acl2 dnslists check: rbl.test.ex new DNS lookup for 13.12.11.V4NET.rbl.test.ex DNS lookup of 13.12.11.V4NET.rbl.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of 13.12.11.V4NET.rbl.test.ex (A) succeeded dnslists: wrote cache entry, ttl=3 DNS lookup for 13.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2) DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) succeeded => that means V4NET.11.12.13 is listed at rbl.test.ex warn: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2" @@ -243,7 +249,10 @@ LOG: MAIN <= x@y H=[V4NET.11.12.13] U=CALLER P=smtp S=sss SMTP>> 250 OK id=10HmaX-0005vi-00 search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -odi -Mc 10HmaX-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -317,6 +326,8 @@ search_tidyup called failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to 2 <2@b> transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=NULL current=/ @@ -339,6 +350,7 @@ writing data block fd=dddd size=sss timeout=0 writing data block fd=dddd size=sss timeout=0 appendfile yields 0 with errno=dd more_errno=dd search_tidyup called +fresh-exec forked for delivery (local): npppp journalling 2@b t1 transport returned OK for 2@b post-process 2@b (0) @@ -436,7 +448,10 @@ LOG: MAIN <= x@y H=[V4NET.11.12.13] U=CALLER P=smtp S=sss SMTP>> 250 OK id=10HmaY-0005vi-00 search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -odi -Mc 10HmaY-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -509,6 +524,8 @@ search_tidyup called failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to 2 <2@b> transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=NULL current=/ @@ -531,6 +548,7 @@ writing data block fd=dddd size=sss timeout=0 writing data block fd=dddd size=sss timeout=0 appendfile yields 0 with errno=dd more_errno=dd search_tidyup called +fresh-exec forked for delivery (local): npppp journalling 2@b t1 transport returned OK for 2@b post-process 2@b (0) diff --git a/test/stderr/0388 b/test/stderr/0388 index 4d0629788..c77110e67 100644 --- a/test/stderr/0388 +++ b/test/stderr/0388 @@ -70,6 +70,8 @@ After routing: Deferred addresses: search_tidyup called search_tidyup called +fresh-exec forking for transport +postfork: transport changed uid/gid: remote delivery to x@y with transport=smtp uid=EXIM_UID gid=EXIM_GID pid=pppp set_process_info: pppp delivering 10HmaX-0005vi-00 using smtp @@ -101,6 +103,7 @@ added retry item for R:x@y: errno=-44 more_errno=dd,A flags=0 SMTP>> QUIT cmd buf flush ddd bytes SMTP(close)>> +fresh-exec forked for transport: npppp set_process_info: pppp delivering 10HmaX-0005vi-00: just tried 127.0.0.1 [127.0.0.1]:PORT_S for x@y: result OK address match test: subject=*@127.0.0.1 pattern=* 127.0.0.1 in "*"? yes (matched "*") @@ -169,7 +172,10 @@ LOG: MAIN EXIM_DBCLOSE(0xAAAAAAAA) closed hints database and lockfile end of retry processing +fresh-exec forking for bounce message +postfork: bounce message exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xd7715ced -odi -odi -t -oem -oi -f <> -E10HmaX-0005vi-00 +fresh-exec forked for bounce message: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -224,7 +230,10 @@ Size of headers = sss LOG: MAIN <= <> R=10HmaX-0005vi-00 U=EXIMUSER P=local S=sss search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xd7715ced -odi -Mc 10HmaY-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp diff --git a/test/stderr/0393 b/test/stderr/0393 index 79e68be12..19d4c7584 100644 --- a/test/stderr/0393 +++ b/test/stderr/0393 @@ -4,6 +4,9 @@ admin user LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -11,6 +14,8 @@ admin user dropping to exim gid; retaining priv uid >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>> --------> userx@test.ex <-------- +fresh-exec forking for delivery (local) +postfork: delivery (local) direct command: argv[0] = '/bin/cat' direct command after expansion: @@ -28,10 +33,17 @@ lock file created mailbox TESTSUITE/test-mail/userx is locked writing to file TESTSUITE/test-mail/userx writing data block fd=dddd size=sss timeout=0 +delivery (local) forking for child-open +postfork: child-open +fresh-exec forked for delivery (local): npppp +delivery (local) forked for child-open: npppp process pppp running as transport filter: fd_write=dddd fd_read=dddd +delivery (local) forking for transport filter writer +postfork: transport filter writer cannot use sendfile for body: spoolfile not wireformat writing data block fd=dddd size=sss timeout=0 >>>>>>>>>>>>>>>> Exim pid=pppp (tpt-filter writer) terminating with rc=0 >>>>>>>>>>>>>>>> +delivery (local) forked for transport filter writer: npppp process pppp writing to transport filter copying from the filter waiting for filter process @@ -52,6 +64,9 @@ configuration file is TESTSUITE/test-config admin user LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -59,6 +74,8 @@ admin user dropping to exim gid; retaining priv uid >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>> --------> userx@test.ex <-------- +fresh-exec forking for delivery (local) +postfork: delivery (local) direct command: direct command after expansion: appendfile transport entered @@ -78,6 +95,7 @@ cannot use sendfile for body: spoolfile not wireformat writing data block fd=dddd size=sss timeout=0 writing data block fd=dddd size=sss timeout=0 appendfile yields 0 with errno=dd more_errno=dd +fresh-exec forked for delivery (local): npppp t1 transport returned OK for userx@test.ex LOG: MAIN => userx <userx@test.ex> R=r1 T=t1 @@ -90,6 +108,9 @@ configuration file is TESTSUITE/test-config admin user LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -97,6 +118,8 @@ admin user dropping to exim gid; retaining priv uid >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>> --------> userx@test.ex <-------- +fresh-exec forking for delivery (local) +postfork: delivery (local) direct command: argv[0] = '${if={1}{1}{}{}}' direct command after expansion: @@ -118,6 +141,7 @@ cannot use sendfile for body: spoolfile not wireformat writing data block fd=dddd size=sss timeout=0 writing data block fd=dddd size=sss timeout=0 appendfile yields 0 with errno=dd more_errno=dd +fresh-exec forked for delivery (local): npppp t1 transport returned OK for userx@test.ex LOG: MAIN => userx <userx@test.ex> R=r1 T=t1 diff --git a/test/stderr/0402 b/test/stderr/0402 index a469f8aae..4e403a6c6 100644 --- a/test/stderr/0402 +++ b/test/stderr/0402 @@ -174,7 +174,10 @@ LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715dfd -odi -Mc 10HmaX-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -456,6 +459,8 @@ no retry data available ╰─────result: /non-exist/usery ╰──(tainted) search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to TESTSUITE/test-mail/junk <TESTSUITE/test-mail/junk> transport=ft1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=/non-exist/usery current=/ @@ -500,6 +505,7 @@ writing data block fd=dddd size=sss timeout=0 writing data block fd=dddd size=sss timeout=0 appendfile yields 0 with errno=dd more_errno=dd search_tidyup called +fresh-exec forked for delivery (local): npppp journalling TESTSUITE/test-mail/junk:rd+usery@test.ex ft1 transport returned OK for TESTSUITE/test-mail/junk post-process TESTSUITE/test-mail/junk (0) @@ -515,6 +521,8 @@ LOG: MAIN failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to TESTSUITE/test-mail/junk <TESTSUITE/test-mail/junk> transport=ft1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=/non-exist/CALLER current=/ @@ -559,6 +567,7 @@ writing data block fd=dddd size=sss timeout=0 writing data block fd=dddd size=sss timeout=0 appendfile yields 0 with errno=dd more_errno=dd search_tidyup called +fresh-exec forked for delivery (local): npppp journalling TESTSUITE/test-mail/junk:rd+CALLER@test.ex ft1 transport returned OK for TESTSUITE/test-mail/junk post-process TESTSUITE/test-mail/junk (0) @@ -574,6 +583,8 @@ LOG: MAIN failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to CALLER <CALLER@test.ex> transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=/non-exist/CALLER current=/ @@ -586,6 +597,7 @@ appendfile: mode=600 notify_comsat=0 quota=0 warning=0 maildir_use_size_file=no locking by lockfile fcntl search_tidyup called +fresh-exec forked for delivery (local): npppp journalling CALLER@test.ex t1 transport returned OK for CALLER@test.ex post-process CALLER@test.ex (0) @@ -604,6 +616,8 @@ no retry data available ╰─────result: /non-exist/usery ╰──(tainted) search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to usery <usery@test.ex> transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=/non-exist/usery current=/ @@ -616,6 +630,7 @@ appendfile: mode=600 notify_comsat=0 quota=0 warning=0 maildir_use_size_file=no locking by lockfile fcntl search_tidyup called +fresh-exec forked for delivery (local): npppp journalling usery@test.ex t1 transport returned OK for usery@test.ex post-process usery@test.ex (0) @@ -634,6 +649,8 @@ no retry data available ╰─────result: /userz ╰──(tainted) search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to userz <userz@test.ex> transport=t2 uid=CALLER_UID gid=CALLER_GID pid=pppp home=/userz current=/ @@ -646,6 +663,7 @@ appendfile: mode=600 notify_comsat=0 quota=0 warning=0 maildir_use_size_file=no locking by lockfile fcntl search_tidyup called +fresh-exec forked for delivery (local): npppp journalling userz@test.ex t2 transport returned OK for userz@test.ex post-process userz@test.ex (0) diff --git a/test/stderr/0403 b/test/stderr/0403 index 29a555881..766376d82 100644 --- a/test/stderr/0403 +++ b/test/stderr/0403 @@ -44,7 +44,10 @@ LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -N -odi -Mc 10HmaX-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -160,6 +163,8 @@ search_tidyup called failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to TESTSUITE/test-mail/junk <TESTSUITE/test-mail/junk> transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=/usr current=/usr @@ -178,6 +183,7 @@ appendfile: mode=600 notify_comsat=0 quota=0 warning=0 locking by lockfile fcntl *** delivery by t1 transport bypassed by -N option search_tidyup called +fresh-exec forked for delivery (local): npppp journalling TESTSUITE/test-mail/junk:userx@test.ex t1 transport returned OK for TESTSUITE/test-mail/junk post-process TESTSUITE/test-mail/junk (0) diff --git a/test/stderr/0404 b/test/stderr/0404 index fc4836073..70bab7a05 100644 --- a/test/stderr/0404 +++ b/test/stderr/0404 @@ -143,7 +143,10 @@ LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -odi -Mc 10HmaX-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -198,6 +201,8 @@ expanded: '#Exim filter mail text rhubarb seen finish' search_tidyup called +fresh-exec forking for router interpret +postfork: router interpret changed uid/gid: r2 router (recipient is userx@test.ex) uid=CALLER_UID gid=CALLER_GID pid=pppp turned off address rewrite logging (not root or exim in this process) @@ -206,6 +211,7 @@ Filter: start of processing Filter: end of processing search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (rda) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forked for router interpret: npppp rda_interpret: subprocess yield=0 error=NULL set transport t1 r2 router generated >sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex, ... @@ -242,13 +248,19 @@ search_tidyup called failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to >sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex, ... <>sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex,sender@test.ex, ...> transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=NULL current=/ set_process_info: pppp **** string overflowed buffer **** t1 transport entered taking data from address +delivery (local) forking for autoreply +postfork: autoreply exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -odi -odi -t -oem -oi -f <> -E10HmaX-0005vi-00 +fresh-exec forked for delivery (local): npppp +delivery (local) forked for autoreply: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=CALLER_GID pid=pppp @@ -1519,7 +1531,10 @@ Size of headers = sss LOG: MAIN <= <> R=10HmaX-0005vi-00 U=CALLER P=local S=sss search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -odi -Mc 10HmaY-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -17981,6 +17996,8 @@ sender@test.ex is a duplicate address: discarded failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to sender <sender@test.ex> transport=t2 uid=CALLER_UID gid=CALLER_GID pid=pppp home=NULL current=/ @@ -18005,6 +18022,7 @@ writing data block fd=dddd size=sss timeout=0 writing data block fd=dddd size=sss timeout=0 appendfile yields 0 with errno=dd more_errno=dd search_tidyup called +fresh-exec forked for delivery (local): npppp journalling sender@test.ex t2 transport returned OK for sender@test.ex post-process sender@test.ex (0) diff --git a/test/stderr/0408 b/test/stderr/0408 index c08b5e1b0..7e2632732 100644 --- a/test/stderr/0408 +++ b/test/stderr/0408 @@ -44,7 +44,10 @@ LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -odi -Mc 10HmaX-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -141,6 +144,8 @@ search_tidyup called failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to userx <userx@test.ex> transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=NULL current=/ @@ -163,6 +168,7 @@ writing data block fd=dddd size=sss timeout=0 writing data block fd=dddd size=sss timeout=0 appendfile yields 0 with errno=dd more_errno=dd search_tidyup called +fresh-exec forked for delivery (local): npppp journalling userx@test.ex t1 transport returned OK for userx@test.ex post-process userx@test.ex (0) diff --git a/test/stderr/0419 b/test/stderr/0419 index 39c797009..06311823b 100644 --- a/test/stderr/0419 +++ b/test/stderr/0419 @@ -24,10 +24,25 @@ dnslookup router called for k@mxt13.test.ex domain = mxt13.test.ex mxt13.test.ex in "*"? yes (matched "*") DNS lookup of mxt13.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of mxt13.test.ex (MX) succeeded +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of other1.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of other1.test.ex (A) succeeded +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of other2.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of other2.test.ex (A) succeeded other1.test.ex in "!mxt13.test.ex : !other1.test.ex : *.test.ex"? no (matched "!other1.test.ex") other1.test.ex in hosts_treat_as_local? no (end of list) diff --git a/test/stderr/0426 b/test/stderr/0426 index 4e49b7114..ff0caaa34 100644 --- a/test/stderr/0426 +++ b/test/stderr/0426 @@ -4,6 +4,9 @@ admin user LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -26,7 +29,16 @@ local_part=x domain=uppercase.test.ex calling r1 router r1 router called for x@uppercase.test.ex domain = uppercase.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp uppercase.test.ex (MX resp) DNSSEC +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp local host found for non-MX address fully qualified name = UpperCase.test.ex uppercase.test.ex 127.0.0.1 mx=-1 sort=xx @@ -47,16 +59,25 @@ After routing: x@UpperCase.test.ex Failed addresses: Deferred addresses: +fresh-exec forking for transport +postfork: transport locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-t1.lockfile +fresh-exec forked for transport: npppp LOG: MAIN ** x@uppercase.test.ex R=r1 T=t1 H=uppercase.test.ex [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<x@UpperCase.test.ex>: 550 Unknown +fresh-exec forking for bounce message +postfork: bounce message +fresh-exec forked for bounce message: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user admin user LOG: MAIN <= <> R=10HmaX-0005vi-00 U=EXIMUSER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user diff --git a/test/stderr/0433 b/test/stderr/0433 index 9972ae7d1..67cafe1b6 100644 --- a/test/stderr/0433 +++ b/test/stderr/0433 @@ -18,7 +18,10 @@ LOG: MAIN set_process_info: pppp daemon(x.yz): no queue runs, listening for SMTP on port 1225 daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID Listening... +fresh-exec forking for daemon del pidfile +pppp postfork: daemon del pidfile pppp exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -DSERVER=server -DPORT=daemon_smtp_port=1225 -C TESTSUITE/test-config -d=0xf7795cfd -oP TESTSUITE/spool/exim-daemon.pid -oPX +fresh-exec forked for daemon del pidfile: npppp search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>> Exim version x.yz .... @@ -40,7 +43,10 @@ LOG: MAIN set_process_info: pppp daemon(x.yz): no queue runs, listening for SMTP on port 1225 port 1226 daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID Listening... +fresh-exec forking for daemon del pidfile +pppp postfork: daemon del pidfile pppp exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -DSERVER=server -DPORT=daemon_smtp_port=1225:1226 -C TESTSUITE/test-config -d=0xf7795cfd -oP TESTSUITE/spool/exim-daemon.pid -oPX +fresh-exec forked for daemon del pidfile: npppp search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>> Exim version x.yz .... @@ -63,7 +69,10 @@ LOG: MAIN set_process_info: pppp daemon(x.yz): no queue runs, listening for SMTP on [127.0.0.1]:1228 port 1225 (IPv4) port 1226 (IPv4) daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID Listening... +fresh-exec forking for daemon del pidfile +pppp postfork: daemon del pidfile pppp exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -DSERVER=server -DPORT=daemon_smtp_port=1225:1226 -DIFACE=local_interfaces = <; 127.0.0.1.1228 ; 0.0.0.0 -C TESTSUITE/test-config -d=0xf7795cfd -oP TESTSUITE/spool/exim-daemon.pid -oPX +fresh-exec forked for daemon del pidfile: npppp search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>> Exim version x.yz .... @@ -86,7 +95,10 @@ LOG: MAIN set_process_info: pppp daemon(x.yz): no queue runs, listening for SMTP on port 1225 port 1226 [127.0.0.1]:1228 daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID Listening... +fresh-exec forking for daemon del pidfile +pppp postfork: daemon del pidfile pppp exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -DSERVER=server -DPORT=daemon_smtp_port=1225:1226 -DIFACE=local_interfaces = <; 0.0.0.0; 127.0.0.1.1228 -C TESTSUITE/test-config -d=0xf7795cfd -oP TESTSUITE/spool/exim-daemon.pid -oPX +fresh-exec forked for daemon del pidfile: npppp search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>> Exim version x.yz .... @@ -110,7 +122,10 @@ LOG: MAIN set_process_info: pppp daemon(x.yz): no queue runs, listening for SMTP on [127.0.0.1]:1228 port 1227 (IPv4) daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID Listening... +fresh-exec forking for daemon del pidfile +pppp postfork: daemon del pidfile pppp exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -DSERVER=server -DPORT=daemon_smtp_port=1225:1226 -DIFACE=local_interfaces = <; 127.0.0.1.1228 ; 0.0.0.0 -C TESTSUITE/test-config -d=0xf7795cfd -oP TESTSUITE/spool/exim-daemon.pid -oPX +fresh-exec forked for daemon del pidfile: npppp search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>> Exim version x.yz .... @@ -134,6 +149,9 @@ LOG: MAIN set_process_info: pppp daemon(x.yz): no queue runs, listening for SMTP on port 1225 port 1226 daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID Listening... +fresh-exec forking for daemon del pidfile +pppp postfork: daemon del pidfile pppp exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -DSERVER=server -C TESTSUITE/test-config -d=0xf7795cfd -oP TESTSUITE/spool/exim-daemon.pid -oPX +fresh-exec forked for daemon del pidfile: npppp search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>> diff --git a/test/stderr/0437 b/test/stderr/0437 index ce327a329..acb786092 100644 --- a/test/stderr/0437 +++ b/test/stderr/0437 @@ -16,6 +16,8 @@ dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp search_tidyup called +fresh-exec forking for qrun delivery +postfork: qrun delivery search_open: lsearch "TESTSUITE/aux-fixed/0437.ls" search_find: file="TESTSUITE/aux-fixed/0437.ls" key="transport" partial=-1 affix=NULL starflags=0 @@ -29,6 +31,8 @@ search_tidyup called lookup yielded: t1 search_tidyup called search_tidyup called +qrun delivery forking for delivery (local) +postfork: delivery (local) search_open: lsearch "TESTSUITE/aux-fixed/0437.ls" search_find: file="TESTSUITE/aux-fixed/0437.ls" key="file" partial=-1 affix=NULL starflags=0 @@ -41,6 +45,8 @@ search_tidyup called in TESTSUITE/aux-fixed/0437.ls lookup yielded: file search_tidyup called +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for delivery (local): npppp LOG: MAIN => userx <userx@myhost.test.ex> R=r1 T=t1 LOG: MAIN @@ -48,6 +54,8 @@ LOG: MAIN search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> search_tidyup called +fresh-exec forking for qrun delivery +postfork: qrun delivery search_open: lsearch "TESTSUITE/aux-fixed/0437.ls" search_find: file="TESTSUITE/aux-fixed/0437.ls" key="transport" partial=-1 affix=NULL starflags=0 @@ -61,6 +69,8 @@ search_tidyup called lookup yielded: t1 search_tidyup called search_tidyup called +qrun delivery forking for delivery (local) +postfork: delivery (local) search_open: lsearch "TESTSUITE/aux-fixed/0437.ls" search_find: file="TESTSUITE/aux-fixed/0437.ls" key="file" partial=-1 affix=NULL starflags=0 @@ -73,6 +83,8 @@ search_tidyup called in TESTSUITE/aux-fixed/0437.ls lookup yielded: file search_tidyup called +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for delivery (local): npppp LOG: MAIN => userx <userx@myhost.test.ex> R=r1 T=t1 LOG: MAIN diff --git a/test/stderr/0438 b/test/stderr/0438 index 1b39cfddc..4fffbc40f 100644 --- a/test/stderr/0438 +++ b/test/stderr/0438 @@ -20,7 +20,10 @@ LOG: MAIN set_process_info: pppp daemon(x.yz): no queue runs, listening for SMTP on port 1225 daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID Listening... +fresh-exec forking for daemon del pidfile +pppp postfork: daemon del pidfile pppp exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -DSERVER=server -C TESTSUITE/test-config -d=0xf7795cfd -oP TESTSUITE/spool/exim-daemon.pid -oPX +fresh-exec forked for daemon del pidfile: npppp search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>> Exim version x.yz .... @@ -43,7 +46,10 @@ LOG: MAIN set_process_info: pppp daemon(x.yz): no queue runs, listening for SMTP on port 1225 daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID Listening... +fresh-exec forking for daemon del pidfile +pppp postfork: daemon del pidfile pppp exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -DSERVER=server -C TESTSUITE/test-config -d=0xf7795cfd -oP TESTSUITE/spool/exim-daemon.anotherpid -oPX +fresh-exec forked for daemon del pidfile: npppp search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>> Exim version x.yz .... @@ -66,6 +72,9 @@ LOG: MAIN set_process_info: pppp daemon(x.yz): no queue runs, listening for SMTP on port 1225 daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID Listening... +fresh-exec forking for daemon del pidfile +pppp postfork: daemon del pidfile pppp exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -DSERVER=server -C TESTSUITE/test-config -d=0xf7795cfd -oP TESTSUITE/spool/mypidfile -oPX +fresh-exec forked for daemon del pidfile: npppp search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>> diff --git a/test/stderr/0450 b/test/stderr/0450 index 13280021b..63d0e7e69 100644 --- a/test/stderr/0450 +++ b/test/stderr/0450 @@ -4,6 +4,9 @@ admin user LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -11,6 +14,8 @@ admin user dropping to exim gid; retaining priv uid >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>> --------> userx@test.ex <-------- +fresh-exec forking for transport +postfork: transport t1 transport entered userx@test.ex using the transport's hosts: 127.0.0.1 @@ -22,6 +27,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1225 ... failed: Connection refused LOG: MAIN H=127.0.0.1 [127.0.0.1] Connection refused added retry item for T:127.0.0.1:127.0.0.1:1225: errno=dd more_errno=dd,A flags=2 +fresh-exec forked for transport: npppp all IP addresses skipped or deferred at least one address updating wait-t1 database added to list for 127.0.0.1 @@ -36,8 +42,12 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp +fresh-exec forking for qrun delivery +postfork: qrun delivery >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>> --------> userx@test.ex <-------- +qrun delivery forking for transport +postfork: transport t1 transport entered userx@test.ex using the transport's hosts: 127.0.0.1 @@ -51,6 +61,8 @@ Connecting to 127.0.0.1 [127.0.0.1]:1226 ... failed: Connection refused LOG: MAIN H=127.0.0.1 [127.0.0.1] Connection refused added retry item for T:127.0.0.1:127.0.0.1:1226: errno=dd more_errno=dd,A flags=2 +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp all IP addresses skipped or deferred at least one address updating wait-t1 database already listed for 127.0.0.1 diff --git a/test/stderr/0463 b/test/stderr/0463 index c74dc0349..c7f918671 100644 --- a/test/stderr/0463 +++ b/test/stderr/0463 @@ -17,6 +17,9 @@ routing x@ten-1 local_part=x domain=ten-1 checking domains DNS lookup of ten-1 (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ten-1 (MX) gave NO_DATA returning DNS_NODATA faking res_search(MX) response length as 65535 @@ -28,12 +31,21 @@ all router called for x@ten-1 domain = ten-1 ten-1 in "*"? yes (matched "*") DNS lookup of ten-1 (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ten-1 (MX) gave NO_DATA returning DNS_NODATA faking res_search(MX) response length as 65535 writing neg-cache entry for ten-1-MX-xxxx, ttl 3000 ten-1 (MX resp) DNSSEC +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ten-1 (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ten-1 (A) succeeded fully qualified name = ten-1.test.ex ten-1.test.ex V4NET.0.0.1 mx=-1 sort=xx @@ -48,6 +60,9 @@ routing x@ten-1.test.ex local_part=x domain=ten-1.test.ex checking domains DNS lookup of ten-1.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ten-1.test.ex (MX) gave NO_DATA returning DNS_NODATA faking res_search(MX) response length as 65535 @@ -59,12 +74,21 @@ all router called for x@ten-1.test.ex domain = ten-1.test.ex ten-1.test.ex in "*"? yes (matched "*") DNS lookup of ten-1.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ten-1.test.ex (MX) gave NO_DATA returning DNS_NODATA faking res_search(MX) response length as 65535 writing neg-cache entry for ten-1.test.ex-MX-xxxx, ttl 3000 ten-1.test.ex (MX resp) DNSSEC +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ten-1.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ten-1.test.ex (A) succeeded fully qualified name = ten-1.test.ex ten-1.test.ex V4NET.0.0.1 mx=-1 sort=xx diff --git a/test/stderr/0469 b/test/stderr/0469 index 9f9e1538e..407902de8 100644 --- a/test/stderr/0469 +++ b/test/stderr/0469 @@ -20,8 +20,14 @@ r1 router called for x@mxt1c.test.ex domain = mxt1c.test.ex mxt1c.test.ex in "*"? yes (matched "*") DNS lookup of mxt1c.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of mxt1c.test.ex (MX) succeeded DNS lookup of dontqualify (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of dontqualify (A) gave NO_DATA returning DNS_NODATA DNS: no SOA record found for neg-TTL diff --git a/test/stderr/0476 b/test/stderr/0476 index b2b69b3b6..9a7758612 100644 --- a/test/stderr/0476 +++ b/test/stderr/0476 @@ -6,10 +6,13 @@ set_process_info: pppp running the queue (single queue run) LOG: queue_run MAIN Start queue run: pid=pppp set_process_info: pppp running queue: 10HmaX-0005vi-00-H -set_process_info: pppp running queue: waiting for 10HmaX-0005vi-00 (pppp) +fresh-exec forking for qrun delivery +postfork: qrun delivery set_process_info: pppp delivering 10HmaX-0005vi-00 (queue run pid ppppp) >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>> --------> userx@test.ex <-------- +qrun delivery forking for transport +postfork: transport set_process_info: pppp delivering 10HmaX-0005vi-00 using t1 t1 transport entered userx@test.ex @@ -51,11 +54,17 @@ H=127.0.0.1 [127.0.0.1] Remote host closed connection in response to RSET set_process_info: pppp delivering 10HmaX-0005vi-00: just tried 127.0.0.1 [127.0.0.1]:PORT_S for userx@test.ex: result OK Leaving t1 transport set_process_info: pppp delivering 10HmaX-0005vi-00 (just run t1 for userx@test.ex in subprocess) +fresh-exec forked for qrun delivery: npppp +set_process_info: pppp running queue: waiting for 10HmaX-0005vi-00 (pppp) +qrun delivery forked for transport: npppp set_process_info: pppp delivering 10HmaX-0005vi-00: waiting for a remote delivery subprocess to finish set_process_info: pppp delivering 10HmaX-0005vi-00 LOG: MAIN ** userx@test.ex R=r1 T=t1 H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<userx@test.ex>: 550 NO set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00 +qrun delivery forking for bounce message +postfork: bounce message +qrun delivery forked for bounce message: npppp cannot use sendfile for body: spoolfile not wireformat writing data block fd=dddd size=sss timeout=0 Exim version x.yz .... @@ -65,6 +74,9 @@ admin user set_process_info: pppp accepting a local non-SMTP message from <> LOG: MAIN <= <> R=10HmaX-0005vi-00 U=EXIMUSER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -74,6 +86,8 @@ set_process_info: pppp delivering specified messages set_process_info: pppp delivering 10HmaZ-0005vi-00 >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>> --------> CALLER@the.local.host.name <-------- +fresh-exec forking for transport +postfork: transport set_process_info: pppp delivering 10HmaZ-0005vi-00 using t1 t1 transport entered CALLER@the.local.host.name @@ -88,6 +102,7 @@ LOG: MAIN H=127.0.0.1 [127.0.0.1] Connection refused set_process_info: pppp delivering 10HmaZ-0005vi-00: just tried 127.0.0.1 [127.0.0.1]:PORT_S for CALLER@the.local.host.name: result DEFER added retry item for T:127.0.0.1:127.0.0.1:1224: errno=dd more_errno=dd,A flags=2 +fresh-exec forked for transport: npppp all IP addresses skipped or deferred at least one address updating wait-t1 database added to list for 127.0.0.1 @@ -106,10 +121,13 @@ LOG: MAIN set_process_info: pppp running queue: waiting for children of pppp set_process_info: pppp running queue set_process_info: pppp running queue: 10HmaY-0005vi-00-H -set_process_info: pppp running queue: waiting for 10HmaY-0005vi-00 (pppp) +fresh-exec forking for qrun delivery +postfork: qrun delivery set_process_info: pppp delivering 10HmaY-0005vi-00 (queue run pid ppppp) >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>> --------> usery@test.ex <-------- +qrun delivery forking for transport +postfork: transport set_process_info: pppp delivering 10HmaY-0005vi-00 using t1 t1 transport entered usery@test.ex @@ -123,6 +141,9 @@ updating wait-t1 database added to list for 127.0.0.1 Leaving t1 transport set_process_info: pppp delivering 10HmaY-0005vi-00 (just run t1 for usery@test.ex in subprocess) +fresh-exec forked for qrun delivery: npppp +set_process_info: pppp running queue: waiting for 10HmaY-0005vi-00 (pppp) +qrun delivery forked for transport: npppp set_process_info: pppp delivering 10HmaY-0005vi-00: waiting for a remote delivery subprocess to finish set_process_info: pppp delivering 10HmaY-0005vi-00 LOG: retry_defer MAIN diff --git a/test/stderr/0487 b/test/stderr/0487 index 887f78ef5..e9153a50a 100644 --- a/test/stderr/0487 +++ b/test/stderr/0487 @@ -71,7 +71,10 @@ LOG: MAIN created log directory TESTSUITE/spool/log SMTP>> 250 OK id=10HmaX-0005vi-00 search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -odi -Mc 10HmaX-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -143,6 +146,8 @@ search_tidyup called failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to userx <userx@test.ex> transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=NULL current=/ @@ -167,6 +172,7 @@ writing data block fd=dddd size=sss timeout=0 writing data block fd=dddd size=sss timeout=0 appendfile yields 0 with errno=dd more_errno=dd search_tidyup called +fresh-exec forked for delivery (local): npppp journalling userx@test.ex t1 transport returned OK for userx@test.ex post-process userx@test.ex (0) diff --git a/test/stderr/0499 b/test/stderr/0499 index 0808ad6e6..26021f392 100644 --- a/test/stderr/0499 +++ b/test/stderr/0499 @@ -17,8 +17,14 @@ routing ph@mxt1.test.ex local_part=ph domain=mxt1.test.ex checking domains DNS lookup of mxt1.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of mxt1.test.ex (MX) succeeded DNS lookup of eximtesthost.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of eximtesthost.test.ex (A) succeeded local host has lowest MX host_find_bydns yield = HOST_FOUND_LOCAL (4); returned hosts: @@ -27,8 +33,14 @@ mxt1.test.ex in "@mx_any"? yes (matched "@mx_any") mxt1.test.ex in "+anymx"? yes (matched "+anymx") checking "condition" "${if match_domain{$domain}{+anymx}{yes}}"... DNS lookup of mxt1.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of mxt1.test.ex (MX) succeeded DNS lookup of eximtesthost.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of eximtesthost.test.ex (A) succeeded local host has lowest MX host_find_bydns yield = HOST_FOUND_LOCAL (4); returned hosts: diff --git a/test/stderr/0512 b/test/stderr/0512 index f0fa5a272..2a1d81131 100644 --- a/test/stderr/0512 +++ b/test/stderr/0512 @@ -4,8 +4,12 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp -qf +fresh-exec forking for qrun delivery +postfork: qrun delivery >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>> --------> userx@myhost.test.ex <-------- +qrun delivery forking for transport +postfork: transport t1 transport entered userx@myhost.test.ex using the transport's hosts: 127.0.0.1 : 127.0.0.1 : 127.0.0.1 : 127.0.0.1 @@ -20,6 +24,8 @@ LOG: MAIN H=127.0.0.1 [127.0.0.1] Connection refused added retry item for T:127.0.0.1:127.0.0.1:1224: errno=dd more_errno=dd,A flags=2 temporary delivery error(s) override hosts_max_try (message older than host's retry time) +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp getting address for 127.0.0.1 checking status of 127.0.0.1 no message retry record @@ -61,6 +67,9 @@ LOG: MAIN == userx@myhost.test.ex R=r1 T=t1 defer (dd): Connection refused LOG: MAIN ** userx@myhost.test.ex: retry timeout exceeded +qrun delivery forking for bounce message +postfork: bounce message +qrun delivery forked for bounce message: npppp cannot use sendfile for body: spoolfile not wireformat writing data block fd=dddd size=sss timeout=0 Exim version x.yz .... @@ -69,6 +78,9 @@ trusted user admin user LOG: MAIN <= <> R=10HmaX-0005vi-00 U=EXIMUSER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -92,8 +104,12 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp -qf +fresh-exec forking for qrun delivery +postfork: qrun delivery >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>> --------> userx@myhost.test.ex <-------- +qrun delivery forking for transport +postfork: transport t1 transport entered userx@myhost.test.ex using the transport's hosts: 127.0.0.1 : 127.0.0.1 : 127.0.0.1 : 127.0.0.1 @@ -108,6 +124,8 @@ LOG: MAIN H=127.0.0.1 [127.0.0.1] Connection refused added retry item for T:127.0.0.1:127.0.0.1:1224: errno=dd more_errno=dd,A flags=2 temporary delivery error(s) override hosts_max_try (message older than host's retry time) +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp getting address for 127.0.0.1 checking status of 127.0.0.1 no message retry record @@ -129,6 +147,9 @@ LOG: MAIN == userx@myhost.test.ex R=r1 T=t1 defer (dd): Connection refused LOG: MAIN ** userx@myhost.test.ex: retry timeout exceeded +qrun delivery forking for bounce message +postfork: bounce message +qrun delivery forked for bounce message: npppp cannot use sendfile for body: spoolfile not wireformat writing data block fd=dddd size=sss timeout=0 Exim version x.yz .... @@ -137,6 +158,9 @@ trusted user admin user LOG: MAIN <= <> R=10HmaZ-0005vi-00 U=EXIMUSER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user diff --git a/test/stderr/0529 b/test/stderr/0529 index b956254ba..f7e6fe253 100644 --- a/test/stderr/0529 +++ b/test/stderr/0529 @@ -4,6 +4,9 @@ admin user LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -28,6 +31,9 @@ After routing: Deferred addresses: locking TESTSUITE/spool/db/retry.lockfile no retry data available +fresh-exec forking for delivery (local) +postfork: delivery (local) +fresh-exec forked for delivery (local): npppp added retry item for T:TESTSUITE/test-mail/rmbox:x@test.ex: errno=-22 more_errno=dd flags=0 LOG: MAIN == TESTSUITE/test-mail/rmbox <x@test.ex> R=r1 T=t1 defer (-22): mailbox is full (MTA-imposed quota exceeded while writing to TESTSUITE/test-mail/rmbox) @@ -53,6 +59,8 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp +fresh-exec forking for qrun delivery +postfork: qrun delivery locking TESTSUITE/spool/db/retry.lockfile >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: x@test.ex @@ -85,6 +93,7 @@ Deferred addresses: x@test.ex: no retry items end of retry processing >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forked for qrun delivery: npppp LOG: queue_run MAIN End queue run: pid=pppp >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>> diff --git a/test/stderr/0543 b/test/stderr/0543 index c288de9a1..ef18299b8 100644 --- a/test/stderr/0543 +++ b/test/stderr/0543 @@ -4,6 +4,8 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp +fresh-exec forking for qrun delivery +postfork: qrun delivery locking TESTSUITE/spool/db/retry.lockfile >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: userx@domain1 @@ -31,6 +33,16 @@ After routing: userx@domain1 Failed addresses: Deferred addresses: +qrun delivery forking for transport +postfork: transport +transport forking for child-open +postfork: child-open +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp +transport forked for child-open: npppp +transport forking for child-open +postfork: child-open +transport forked for child-open: npppp locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-smtp.lockfile LOG: MAIN @@ -38,6 +50,8 @@ LOG: MAIN LOG: MAIN Completed >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery locking TESTSUITE/spool/db/retry.lockfile >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: usery@domain1 @@ -52,6 +66,7 @@ After routing: Deferred addresses: usery@domain1 >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forked for qrun delivery: npppp LOG: queue_run MAIN End queue run: pid=pppp >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>> diff --git a/test/stderr/0544 b/test/stderr/0544 index 026c28623..1383687fa 100644 --- a/test/stderr/0544 +++ b/test/stderr/0544 @@ -119,16 +119,22 @@ admin user LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... adding SSLKEYLOGFILE=TESTSUITE/spool/sslkeys configuration file is TESTSUITE/test-config trusted user admin user dropping to exim gid; retaining priv uid +fresh-exec forking for transport +postfork: transport ╭considering: $domain ├──expanding: $domain ╰─────result: domain1.ex ╰──(tainted) +fresh-exec forked for transport: npppp LOG: MAIN == userx@domain1.ex R=smarthost T=smtp defer (-1): first-pass only routing due to -odqs, queue_smtp_domains or control=queue LOG: MAIN diff --git a/test/stderr/0545 b/test/stderr/0545 index f2e5e37b1..404e65bf2 100644 --- a/test/stderr/0545 +++ b/test/stderr/0545 @@ -20,18 +20,30 @@ dns router called for userx@alias-eximtesthost domain = alias-eximtesthost alias-eximtesthost in "*"? yes (matched "*") DNS lookup of alias-eximtesthost (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of alias-eximtesthost (MX) succeeded CNAME found: change to eximtesthost.test.ex DNS lookup of eximtesthost.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of eximtesthost.test.ex (MX) gave NO_DATA returning DNS_NODATA faking res_search(MX) response length as 65535 writing neg-cache entry for eximtesthost.test.ex-MX-xxxx, ttl 3000 alias-eximtesthost (MX resp) DNSSEC DNS lookup of alias-eximtesthost (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of alias-eximtesthost (A) succeeded CNAME found: change to eximtesthost.test.ex DNS lookup of eximtesthost.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of eximtesthost.test.ex (A) succeeded local host found for non-MX address fully qualified name = alias-eximtesthost.test.ex @@ -50,13 +62,22 @@ dns router called for userx@alias-eximtesthost.test.ex domain = alias-eximtesthost.test.ex alias-eximtesthost.test.ex in "*"? yes (matched "*") DNS lookup of alias-eximtesthost.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of alias-eximtesthost.test.ex (MX) succeeded CNAME found: change to eximtesthost.test.ex DNS lookup of eximtesthost.test.ex-MX: using cached value DNS_NODATA DNS lookup of alias-eximtesthost.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of alias-eximtesthost.test.ex (A) succeeded CNAME found: change to eximtesthost.test.ex DNS lookup of eximtesthost.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of eximtesthost.test.ex (A) succeeded local host found for non-MX address fully qualified name = alias-eximtesthost.test.ex @@ -95,18 +116,30 @@ dns router called for userx@alias-eximtesthost.test.ex domain = alias-eximtesthost.test.ex alias-eximtesthost.test.ex in "*"? yes (matched "*") DNS lookup of alias-eximtesthost.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of alias-eximtesthost.test.ex (MX) succeeded CNAME found: change to eximtesthost.test.ex DNS lookup of eximtesthost.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of eximtesthost.test.ex (MX) gave NO_DATA returning DNS_NODATA faking res_search(MX) response length as 65535 writing neg-cache entry for eximtesthost.test.ex-MX-xxxx, ttl 3000 alias-eximtesthost.test.ex (MX resp) DNSSEC DNS lookup of alias-eximtesthost.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of alias-eximtesthost.test.ex (A) succeeded CNAME found: change to eximtesthost.test.ex DNS lookup of eximtesthost.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of eximtesthost.test.ex (A) succeeded local host found for non-MX address fully qualified name = alias-eximtesthost.test.ex diff --git a/test/stderr/0554 b/test/stderr/0554 index eb0e3c2a5..cb66e0837 100644 --- a/test/stderr/0554 +++ b/test/stderr/0554 @@ -15,10 +15,13 @@ After routing: x@y Failed addresses: Deferred addresses: +fresh-exec forking for transport +postfork: transport checking status of 127.0.0.1 locking TESTSUITE/spool/db/retry.lockfile no retry data available added retry item for R:x@y:<CALLER@myhost.test.ex>: errno=-44 more_errno=dd,A flags=0 +fresh-exec forked for transport: npppp reading retry information for R:x@y:<CALLER@myhost.test.ex> from subprocess added retry item LOG: MAIN @@ -55,6 +58,8 @@ After routing: x@y Failed addresses: Deferred addresses: +fresh-exec forking for transport +postfork: transport checking status of 127.0.0.1 locking TESTSUITE/spool/db/retry.lockfile no host retry record @@ -62,6 +67,7 @@ no message retry record added retry item for R:x@y:<CALLER@myhost.test.ex>: errno=dd more_errno=dd,A flags=1 added retry item for R:x@y: errno=dd more_errno=dd,A flags=1 locking TESTSUITE/spool/db/wait-smtp.lockfile +fresh-exec forked for transport: npppp reading retry information for R:x@y from subprocess existing delete item dropped added delete item diff --git a/test/stderr/0609 b/test/stderr/0609 index 3fb905b59..d74668cd6 100644 --- a/test/stderr/0609 +++ b/test/stderr/0609 @@ -17,14 +17,17 @@ ppppp Listening... ppppp Connection request from 127.0.0.1 port sssss ppppp LOG: smtp_connection MAIN ppppp SMTP connection from [127.0.0.1] (TCP/IP connection count = 1) -ppppp 1 SMTP accept process running -ppppp Listening... +ppppp fresh-exec forking for daemon accept +ppppp postfork: daemon accept ppppp Process ppppp is handling incoming connection from [127.0.0.1] ppppp Process ppppp is ready for new message ppppp using ACL "delay4_accept" ppppp processing "accept" (TESTSUITE/test-config 24) ppppp check delay = 4s ppppp delay modifier requests 4-second delay +ppppp fresh-exec forked for daemon accept: npppp +ppppp 1 SMTP accept process running +ppppp Listening... ppppp accept: condition test succeeded in ACL "delay4_accept" ppppp end of ACL "delay4_accept": ACCEPT ppppp LOG: smtp_connection MAIN @@ -37,8 +40,8 @@ ppppp Listening... ppppp Connection request from 127.0.0.1 port sssss ppppp LOG: smtp_connection MAIN ppppp SMTP connection from [127.0.0.1] (TCP/IP connection count = 1) -ppppp 1 SMTP accept process running -ppppp Listening... +ppppp fresh-exec forking for daemon accept +ppppp postfork: daemon accept ppppp Process ppppp is handling incoming connection from [127.0.0.1] ppppp Process ppppp is ready for new message ppppp using ACL "delay4_accept" @@ -51,8 +54,9 @@ ppppp end of ACL "delay4_accept": ACCEPT ppppp LOG: lost_incoming_connection MAIN ppppp unexpected disconnection while reading SMTP command from [127.0.0.1] D=qqs ppppp >>>>>>>>>>>>>>>> Exim pid=pppp (conn-setup) terminating with rc=1 >>>>>>>>>>>>>>>> -ppppp child ppppp ended: status=0x100 -ppppp normal exit, 1 -ppppp 0 SMTP accept processes now running -ppppp Listening... +ppppp fresh-exec forked for daemon accept: npppp +ppppp 1 SMTP accept process running +ppppp fresh-exec forking for daemon del pidfile +ppppp postfork: daemon del pidfile +ppppp fresh-exec forked for daemon del pidfile: npppp ppppp >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>> diff --git a/test/stderr/1006 b/test/stderr/1006 index 4c88e098f..a38b29239 100644 --- a/test/stderr/1006 +++ b/test/stderr/1006 @@ -3,20 +3,44 @@ configuration file is TESTSUITE/test-config admin user dropping to exim gid; retaining priv uid DNS lookup of mx46.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of mx46.test.ex (MX) succeeded +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of 46.test.ex (AAAA) succeeded DNS lookup of 46.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of 46.test.ex (A) succeeded +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of 46.test.ex (AAAA) succeeded DNS lookup of 46.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of 46.test.ex (A) succeeded DNS lookup of v6.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of v6.test.ex (MX) gave NO_DATA returning DNS_NODATA faking res_search(MX) response length as 65535 writing neg-cache entry for v6.test.ex-MX-xxxx, ttl 3000 +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of v6.test.ex (AAAA) succeeded DNS lookup of v6.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of v6.test.ex (A) gave NO_DATA returning DNS_NODATA faking res_search(A) response length as 65535 @@ -27,17 +51,32 @@ configuration file is TESTSUITE/test-config admin user dropping to exim gid; retaining priv uid DNS lookup of mx46.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of mx46.test.ex (MX) succeeded DNS lookup of 46.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of 46.test.ex (A) succeeded DNS lookup of 46.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of 46.test.ex (A) succeeded DNS lookup of v6.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of v6.test.ex (MX) gave NO_DATA returning DNS_NODATA faking res_search(MX) response length as 65535 writing neg-cache entry for v6.test.ex-MX-xxxx, ttl 3000 DNS lookup of v6.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of v6.test.ex (A) gave NO_DATA returning DNS_NODATA faking res_search(A) response length as 65535 diff --git a/test/stderr/1007 b/test/stderr/1007 index ebfae6aa1..55d29e248 100644 --- a/test/stderr/1007 +++ b/test/stderr/1007 @@ -19,7 +19,10 @@ LOG: MAIN set_process_info: pppp daemon(x.yz): no queue runs, listening for SMTP on port 1225 (IPv6 and IPv4) daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID Listening... +fresh-exec forking for daemon del pidfile +pppp postfork: daemon del pidfile pppp exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -DSERVER=server -DPORT=daemon_smtp_port=1225 -C TESTSUITE/test-config -d=0xf7795cfd -oP TESTSUITE/spool/exim-daemon.pid -oPX +fresh-exec forked for daemon del pidfile: npppp search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>> Exim version x.yz .... @@ -43,7 +46,10 @@ LOG: MAIN set_process_info: pppp daemon(x.yz): no queue runs, listening for SMTP on port 1225 (IPv6 and IPv4) port 1226 (IPv6 and IPv4) daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID Listening... +fresh-exec forking for daemon del pidfile +pppp postfork: daemon del pidfile pppp exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -DSERVER=server -DPORT=daemon_smtp_port=1225:1226 -C TESTSUITE/test-config -d=0xf7795cfd -oP TESTSUITE/spool/exim-daemon.pid -oPX +fresh-exec forked for daemon del pidfile: npppp search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>> Exim version x.yz .... @@ -68,7 +74,10 @@ LOG: MAIN set_process_info: pppp daemon(x.yz): no queue runs, listening for SMTP on port 1225 (IPv6 and IPv4) port 1226 (IPv6 and IPv4) [127.0.0.1]:1228 daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID Listening... +fresh-exec forking for daemon del pidfile +pppp postfork: daemon del pidfile pppp exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -DSERVER=server -DPORT=daemon_smtp_port=1225:1226 -DIFACE=local_interfaces = <; ::0 ; 127.0.0.1.1228 ; 0.0.0.0 -C TESTSUITE/test-config -d=0xf7795cfd -oP TESTSUITE/spool/exim-daemon.pid -oPX +fresh-exec forked for daemon del pidfile: npppp search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>> Exim version x.yz .... @@ -93,7 +102,10 @@ LOG: MAIN set_process_info: pppp daemon(x.yz): no queue runs, listening for SMTP on port 1225 (IPv6 and IPv4) port 1226 (IPv6 and IPv4) [127.0.0.1]:1228 daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID Listening... +fresh-exec forking for daemon del pidfile +pppp postfork: daemon del pidfile pppp exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -DSERVER=server -DPORT=daemon_smtp_port=1225:1226 -DIFACE=local_interfaces = <; 0.0.0.0; 127.0.0.1.1228 ; ::0 -C TESTSUITE/test-config -d=0xf7795cfd -oP TESTSUITE/spool/exim-daemon.pid -oPX +fresh-exec forked for daemon del pidfile: npppp search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>> Exim version x.yz .... @@ -115,7 +127,10 @@ LOG: MAIN set_process_info: pppp daemon(x.yz): no queue runs, listening for SMTP on [ip6:ip6:ip6:ip6:ip6:ip6:ip6:ip6]:{1225,1226} daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID Listening... +fresh-exec forking for daemon del pidfile +pppp postfork: daemon del pidfile pppp exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -DSERVER=server -DPORT=daemon_smtp_port=1225:1226 -DIFACE=local_interfaces = <; ip6:ip6:ip6:ip6:ip6:ip6:ip6:ip6 -C TESTSUITE/test-config -d=0xf7795cfd -oP TESTSUITE/spool/exim-daemon.pid -oPX +fresh-exec forked for daemon del pidfile: npppp search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>> Exim version x.yz .... @@ -140,7 +155,10 @@ LOG: MAIN set_process_info: pppp daemon(x.yz): no queue runs, listening for SMTP on port 1227 (IPv6 and IPv4) [127.0.0.1]:1228 daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID Listening... +fresh-exec forking for daemon del pidfile +pppp postfork: daemon del pidfile pppp exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -DSERVER=server -DPORT=daemon_smtp_port=1225:1226 -DIFACE=local_interfaces = <; ::0 ; 127.0.0.1.1228 ; 0.0.0.0 -C TESTSUITE/test-config -d=0xf7795cfd -oP TESTSUITE/spool/exim-daemon.pid -oPX +fresh-exec forked for daemon del pidfile: npppp search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>> Exim version x.yz .... @@ -166,7 +184,10 @@ LOG: MAIN set_process_info: pppp daemon(x.yz): no queue runs, listening for SMTP on [127.0.0.1]:{1227,1225} daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID Listening... +fresh-exec forking for daemon del pidfile +pppp postfork: daemon del pidfile pppp exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -DSERVER=server -DPORT=daemon_smtp_port=1225:1226 -DIFACE=local_interfaces = <; ::0 ; 127.0.0.1.1228 ; 0.0.0.0 -C TESTSUITE/test-config -d=0xf7795cfd -oP TESTSUITE/spool/exim-daemon.pid -oPX +fresh-exec forked for daemon del pidfile: npppp search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>> Exim version x.yz .... @@ -191,6 +212,9 @@ LOG: MAIN set_process_info: pppp daemon(x.yz): no queue runs, listening for SMTP on port 1225 (IPv6 and IPv4) port 1226 (IPv4) daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID Listening... +fresh-exec forking for daemon del pidfile +pppp postfork: daemon del pidfile pppp exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -DSERVER=server -C TESTSUITE/test-config -d=0xf7795cfd -oP TESTSUITE/spool/exim-daemon.pid -oPX +fresh-exec forked for daemon del pidfile: npppp search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>> diff --git a/test/stderr/2013 b/test/stderr/2013 index 77d2774ba..1db091fdc 100644 --- a/test/stderr/2013 +++ b/test/stderr/2013 @@ -4,13 +4,37 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp -qqf +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport Connecting to 127.0.0.1 [127.0.0.1]:1225 ... connected SMTP<< 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000 SMTP>> EHLO myhost.test.ex cmd buf flush ddd bytes +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp SMTP<< 250-myhost.test.ex Hello localhost [127.0.0.1] 250-SIZE 52428800 250-8BITMIME @@ -35,6 +59,18 @@ cmd buf flush ddd bytes SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself SMTP<< 250 OK id=10HmbA-0005vi-00 +transport forking for continued-transport interproc +postfork: continued-transport interproc +continued-transport interproc forking for continued-transport +postfork: continued-transport +transport forked for continued-transport interproc: npppp +continued-transport interproc forked for continued-transport: npppp +transport forking for tls proxy interproc +postfork: tls proxy interproc +tls proxy interproc forking for tls proxy +postfork: tls proxy +transport forked for tls proxy interproc: npppp +tls proxy interproc forked for tls proxy: npppp LOG: MAIN => userx@test.ex R=client T=send_to_server H=127.0.0.1 [127.0.0.1] X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=no DN="C=UK,O=The Exim Maintainers,OU=Test Suite,CN=Phil Pennock" C="250 OK id=10HmbA-0005vi-00" LOG: MAIN @@ -45,6 +81,8 @@ configuration file is TESTSUITE/test-config trusted user admin user dropping to exim gid; retaining priv uid +fresh-exec forking for transport +postfork: transport SMTP>> MAIL FROM:<CALLER@myhost.test.ex> SIZE=ssss SMTP>> RCPT TO:<userz@test.ex> SMTP>> DATA @@ -53,6 +91,13 @@ cmd buf flush ddd bytes SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself SMTP<< 250 OK id=10HmbB-0005vi-00 +transport forking for continued-transport interproc +postfork: continued-transport interproc +continued-transport interproc forking for continued-transport +postfork: continued-transport +fresh-exec forked for transport: npppp +transport forked for continued-transport interproc: npppp +continued-transport interproc forked for continued-transport: npppp SMTP(close)>> LOG: MAIN => userz@test.ex R=client T=send_to_server H=127.0.0.1 [127.0.0.1]* X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=no C="250 OK id=10HmbB-0005vi-00" @@ -64,6 +109,8 @@ configuration file is TESTSUITE/test-config trusted user admin user dropping to exim gid; retaining priv uid +fresh-exec forking for transport +postfork: transport SMTP>> MAIL FROM:<CALLER@myhost.test.ex> SIZE=ssss SMTP>> RCPT TO:<usery@test.ex> SMTP>> DATA @@ -75,6 +122,7 @@ cmd buf flush ddd bytes SMTP>> QUIT cmd buf flush ddd bytes SMTP(close)>> +fresh-exec forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (TLS proxy) terminating with rc=0 >>>>>>>>>>>>>>>> LOG: MAIN => usery@test.ex R=client T=send_to_server H=127.0.0.1 [127.0.0.1]* X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=no C="250 OK id=10HmbC-0005vi-00" @@ -90,13 +138,37 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp -qqf +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport Connecting to 127.0.0.1 [127.0.0.1]:1225 ... connected SMTP<< 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000 SMTP>> EHLO myhost.test.ex cmd buf flush ddd bytes +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp SMTP<< 250-myhost.test.ex Hello localhost [127.0.0.1] 250-SIZE 52428800 250-8BITMIME @@ -121,6 +193,18 @@ cmd buf flush ddd bytes SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself SMTP<< 250 OK id=10HmbG-0005vi-00 +transport forking for continued-transport interproc +postfork: continued-transport interproc +continued-transport interproc forking for continued-transport +postfork: continued-transport +transport forked for continued-transport interproc: npppp +continued-transport interproc forked for continued-transport: npppp +transport forking for tls proxy interproc +postfork: tls proxy interproc +tls proxy interproc forking for tls proxy +postfork: tls proxy +transport forked for tls proxy interproc: npppp +tls proxy interproc forked for tls proxy: npppp LOG: MAIN => usera@test.ex R=cl_override T=send_to_server H=127.0.0.1 [127.0.0.1] X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=no DN="C=UK,O=The Exim Maintainers,OU=Test Suite,CN=Phil Pennock" C="250 OK id=10HmbG-0005vi-00" LOG: MAIN @@ -131,6 +215,8 @@ configuration file is TESTSUITE/test-config trusted user admin user dropping to exim gid; retaining priv uid +fresh-exec forking for transport +postfork: transport SMTP>> MAIL FROM:<CALLER@myhost.test.ex> SIZE=ssss SMTP>> RCPT TO:<userc@test.ex> SMTP>> DATA @@ -139,6 +225,13 @@ cmd buf flush ddd bytes SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself SMTP<< 250 OK id=10HmbH-0005vi-00 +transport forking for continued-transport interproc +postfork: continued-transport interproc +continued-transport interproc forking for continued-transport +postfork: continued-transport +fresh-exec forked for transport: npppp +transport forked for continued-transport interproc: npppp +continued-transport interproc forked for continued-transport: npppp SMTP(close)>> LOG: MAIN => userc@test.ex R=cl_override T=send_to_server H=127.0.0.1 [127.0.0.1]* X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=no C="250 OK id=10HmbH-0005vi-00" @@ -150,6 +243,8 @@ configuration file is TESTSUITE/test-config trusted user admin user dropping to exim gid; retaining priv uid +fresh-exec forking for transport +postfork: transport SMTP>> MAIL FROM:<CALLER@myhost.test.ex> SIZE=ssss SMTP>> RCPT TO:<userb@test.ex> SMTP>> DATA @@ -161,6 +256,7 @@ cmd buf flush ddd bytes SMTP>> QUIT cmd buf flush ddd bytes SMTP(close)>> +fresh-exec forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (TLS proxy) terminating with rc=0 >>>>>>>>>>>>>>>> LOG: MAIN => userb@test.ex R=cl_override T=send_to_server H=127.0.0.1 [127.0.0.1]* X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=no C="250 OK id=10HmbI-0005vi-00" @@ -176,13 +272,37 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp -qqf +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport Connecting to 127.0.0.1 [127.0.0.1]:1225 ... connected SMTP<< 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000 SMTP>> EHLO myhost.test.ex cmd buf flush ddd bytes +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp SMTP<< 250-myhost.test.ex Hello localhost [127.0.0.1] 250-SIZE 52428800 250-8BITMIME @@ -215,6 +335,12 @@ cmd buf flush ddd bytes 250-PIPELINING 250-STARTTLS 250 HELP +transport forking for continued-transport interproc +postfork: continued-transport interproc +continued-transport interproc forking for continued-transport +postfork: continued-transport +transport forked for continued-transport interproc: npppp +continued-transport interproc forked for continued-transport: npppp SMTP(close)>> LOG: MAIN => userx@test.ex R=client T=send_to_server H=127.0.0.1 [127.0.0.1] X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=no DN="C=UK,O=The Exim Maintainers,OU=Test Suite,CN=Phil Pennock" C="250 OK id=10HmbM-0005vi-00" @@ -226,8 +352,11 @@ configuration file is TESTSUITE/test-config trusted user admin user dropping to exim gid; retaining priv uid +fresh-exec forking for transport +postfork: transport SMTP>> STARTTLS cmd buf flush ddd bytes +fresh-exec forked for transport: npppp SMTP<< 220 TLS go ahead SMTP>> EHLO myhost.test.ex cmd buf flush ddd bytes @@ -252,6 +381,12 @@ cmd buf flush ddd bytes 250-PIPELINING 250-STARTTLS 250 HELP +transport forking for continued-transport interproc +postfork: continued-transport interproc +continued-transport interproc forking for continued-transport +postfork: continued-transport +transport forked for continued-transport interproc: npppp +continued-transport interproc forked for continued-transport: npppp SMTP(close)>> LOG: MAIN => userz@test.ex R=client T=send_to_server H=127.0.0.1 [127.0.0.1]* X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=no DN="C=UK,O=The Exim Maintainers,OU=Test Suite,CN=Phil Pennock" C="250 OK id=10HmbN-0005vi-00" @@ -263,8 +398,11 @@ configuration file is TESTSUITE/test-config trusted user admin user dropping to exim gid; retaining priv uid +fresh-exec forking for transport +postfork: transport SMTP>> STARTTLS cmd buf flush ddd bytes +fresh-exec forked for transport: npppp SMTP<< 220 TLS go ahead SMTP>> EHLO myhost.test.ex cmd buf flush ddd bytes diff --git a/test/stderr/2035 b/test/stderr/2035 index 4359c4ab2..7f4c1b1b8 100644 --- a/test/stderr/2035 +++ b/test/stderr/2035 @@ -35,10 +35,19 @@ sync_responses expect rcpt SMTP<< 250 Accepted LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local-smtp S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp LOG: smtp_connection MAIN SMTP connection from CALLER closed by QUIT >>>>>>>>>>>>>>>> Exim pid=pppp (msg setup toplevel) terminating with rc=0 >>>>>>>>>>>>>>>> +local-accept delivery forking for tls-proxy interproc +postfork: tls-proxy interproc +tls-proxy interproc forking for tls proxy +postfork: tls proxy +local-accept delivery forked for tls-proxy interproc: npppp proxy-proc inter-pid pppp +tls-proxy interproc forked for tls proxy: npppp proxy-proc final-pid pppp Exim version x.yz .... configuration file is TESTSUITE/test-config @@ -47,6 +56,8 @@ admin user dropping to exim gid; retaining priv uid >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>> --------> userb@test.ex <-------- +fresh-exec forking for transport +postfork: transport t1 transport entered userb@test.ex hostlist: @@ -69,6 +80,7 @@ ok=1 send_quit=1 send_rset=0 continue_more=0 yield=0 first_address is NULL SMTP>> QUIT cmd buf flush ddd bytes SMTP(close)>> +fresh-exec forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (TLS proxy) terminating with rc=0 >>>>>>>>>>>>>>>> Leaving t1 transport LOG: MAIN diff --git a/test/stderr/2113 b/test/stderr/2113 index b242d3f71..70a7f429e 100644 --- a/test/stderr/2113 +++ b/test/stderr/2113 @@ -4,13 +4,37 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp -qqf +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport Connecting to 127.0.0.1 [127.0.0.1]:1225 ... connected SMTP<< 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000 SMTP>> EHLO myhost.test.ex cmd buf flush ddd bytes +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp SMTP<< 250-myhost.test.ex Hello localhost [127.0.0.1] 250-SIZE 52428800 250-8BITMIME @@ -35,6 +59,18 @@ cmd buf flush ddd bytes SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself SMTP<< 250 OK id=10HmbA-0005vi-00 +transport forking for continued-transport interproc +postfork: continued-transport interproc +continued-transport interproc forking for continued-transport +postfork: continued-transport +transport forked for continued-transport interproc: npppp +continued-transport interproc forked for continued-transport: npppp +transport forking for tls proxy interproc +postfork: tls proxy interproc +tls proxy interproc forking for tls proxy +postfork: tls proxy +transport forked for tls proxy interproc: npppp +tls proxy interproc forked for tls proxy: npppp LOG: MAIN => userx@test.ex R=client T=send_to_server H=127.0.0.1 [127.0.0.1] X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=no DN="/C=UK/O=The Exim Maintainers/OU=Test Suite/CN=Phil Pennock" C="250 OK id=10HmbA-0005vi-00" LOG: MAIN @@ -45,6 +81,8 @@ configuration file is TESTSUITE/test-config trusted user admin user dropping to exim gid; retaining priv uid +fresh-exec forking for transport +postfork: transport SMTP>> MAIL FROM:<CALLER@myhost.test.ex> SIZE=ssss SMTP>> RCPT TO:<userz@test.ex> SMTP>> DATA @@ -53,6 +91,13 @@ cmd buf flush ddd bytes SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself SMTP<< 250 OK id=10HmbB-0005vi-00 +transport forking for continued-transport interproc +postfork: continued-transport interproc +continued-transport interproc forking for continued-transport +postfork: continued-transport +fresh-exec forked for transport: npppp +transport forked for continued-transport interproc: npppp +continued-transport interproc forked for continued-transport: npppp SMTP(close)>> LOG: MAIN => userz@test.ex R=client T=send_to_server H=127.0.0.1 [127.0.0.1]* X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=no C="250 OK id=10HmbB-0005vi-00" @@ -64,6 +109,8 @@ configuration file is TESTSUITE/test-config trusted user admin user dropping to exim gid; retaining priv uid +fresh-exec forking for transport +postfork: transport SMTP>> MAIL FROM:<CALLER@myhost.test.ex> SIZE=ssss SMTP>> RCPT TO:<usery@test.ex> SMTP>> DATA @@ -75,6 +122,7 @@ cmd buf flush ddd bytes SMTP>> QUIT cmd buf flush ddd bytes SMTP(close)>> +fresh-exec forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (TLS proxy) terminating with rc=0 >>>>>>>>>>>>>>>> LOG: MAIN => usery@test.ex R=client T=send_to_server H=127.0.0.1 [127.0.0.1]* X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=no C="250 OK id=10HmbC-0005vi-00" @@ -90,13 +138,37 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp -qqf +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport Connecting to 127.0.0.1 [127.0.0.1]:1225 ... connected SMTP<< 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000 SMTP>> EHLO myhost.test.ex cmd buf flush ddd bytes +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp SMTP<< 250-myhost.test.ex Hello localhost [127.0.0.1] 250-SIZE 52428800 250-8BITMIME @@ -121,6 +193,18 @@ cmd buf flush ddd bytes SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself SMTP<< 250 OK id=10HmbG-0005vi-00 +transport forking for continued-transport interproc +postfork: continued-transport interproc +continued-transport interproc forking for continued-transport +postfork: continued-transport +transport forked for continued-transport interproc: npppp +continued-transport interproc forked for continued-transport: npppp +transport forking for tls proxy interproc +postfork: tls proxy interproc +tls proxy interproc forking for tls proxy +postfork: tls proxy +transport forked for tls proxy interproc: npppp +tls proxy interproc forked for tls proxy: npppp LOG: MAIN => usera@test.ex R=cl_override T=send_to_server H=127.0.0.1 [127.0.0.1] X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=no DN="/C=UK/O=The Exim Maintainers/OU=Test Suite/CN=Phil Pennock" C="250 OK id=10HmbG-0005vi-00" LOG: MAIN @@ -131,6 +215,8 @@ configuration file is TESTSUITE/test-config trusted user admin user dropping to exim gid; retaining priv uid +fresh-exec forking for transport +postfork: transport SMTP>> MAIL FROM:<CALLER@myhost.test.ex> SIZE=ssss SMTP>> RCPT TO:<userc@test.ex> SMTP>> DATA @@ -139,6 +225,13 @@ cmd buf flush ddd bytes SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself SMTP<< 250 OK id=10HmbH-0005vi-00 +transport forking for continued-transport interproc +postfork: continued-transport interproc +continued-transport interproc forking for continued-transport +postfork: continued-transport +fresh-exec forked for transport: npppp +transport forked for continued-transport interproc: npppp +continued-transport interproc forked for continued-transport: npppp SMTP(close)>> LOG: MAIN => userc@test.ex R=cl_override T=send_to_server H=127.0.0.1 [127.0.0.1]* X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=no C="250 OK id=10HmbH-0005vi-00" @@ -150,6 +243,8 @@ configuration file is TESTSUITE/test-config trusted user admin user dropping to exim gid; retaining priv uid +fresh-exec forking for transport +postfork: transport SMTP>> MAIL FROM:<CALLER@myhost.test.ex> SIZE=ssss SMTP>> RCPT TO:<userb@test.ex> SMTP>> DATA @@ -161,6 +256,7 @@ cmd buf flush ddd bytes SMTP>> QUIT cmd buf flush ddd bytes SMTP(close)>> +fresh-exec forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (TLS proxy) terminating with rc=0 >>>>>>>>>>>>>>>> LOG: MAIN => userb@test.ex R=cl_override T=send_to_server H=127.0.0.1 [127.0.0.1]* X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=no C="250 OK id=10HmbI-0005vi-00" @@ -176,13 +272,37 @@ admin user dropping to exim gid; retaining priv uid LOG: queue_run MAIN Start queue run: pid=pppp -qqf +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forking for qrun delivery +postfork: qrun delivery +qrun delivery forking for transport +postfork: transport Connecting to 127.0.0.1 [127.0.0.1]:1225 ... connected SMTP<< 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000 SMTP>> EHLO myhost.test.ex cmd buf flush ddd bytes +fresh-exec forked for qrun delivery: npppp +qrun delivery forked for transport: npppp SMTP<< 250-myhost.test.ex Hello localhost [127.0.0.1] 250-SIZE 52428800 250-8BITMIME @@ -215,6 +335,12 @@ cmd buf flush ddd bytes 250-PIPELINING 250-STARTTLS 250 HELP +transport forking for continued-transport interproc +postfork: continued-transport interproc +continued-transport interproc forking for continued-transport +postfork: continued-transport +transport forked for continued-transport interproc: npppp +continued-transport interproc forked for continued-transport: npppp SMTP(close)>> LOG: MAIN => userx@test.ex R=client T=send_to_server H=127.0.0.1 [127.0.0.1] X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=no DN="/C=UK/O=The Exim Maintainers/OU=Test Suite/CN=Phil Pennock" C="250 OK id=10HmbM-0005vi-00" @@ -226,8 +352,11 @@ configuration file is TESTSUITE/test-config trusted user admin user dropping to exim gid; retaining priv uid +fresh-exec forking for transport +postfork: transport SMTP>> STARTTLS cmd buf flush ddd bytes +fresh-exec forked for transport: npppp SMTP<< 220 TLS go ahead SMTP>> EHLO myhost.test.ex cmd buf flush ddd bytes @@ -252,6 +381,12 @@ cmd buf flush ddd bytes 250-PIPELINING 250-STARTTLS 250 HELP +transport forking for continued-transport interproc +postfork: continued-transport interproc +continued-transport interproc forking for continued-transport +postfork: continued-transport +transport forked for continued-transport interproc: npppp +continued-transport interproc forked for continued-transport: npppp SMTP(close)>> LOG: MAIN => userz@test.ex R=client T=send_to_server H=127.0.0.1 [127.0.0.1]* X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=no DN="/C=UK/O=The Exim Maintainers/OU=Test Suite/CN=Phil Pennock" C="250 OK id=10HmbN-0005vi-00" @@ -263,8 +398,11 @@ configuration file is TESTSUITE/test-config trusted user admin user dropping to exim gid; retaining priv uid +fresh-exec forking for transport +postfork: transport SMTP>> STARTTLS cmd buf flush ddd bytes +fresh-exec forked for transport: npppp SMTP<< 220 TLS go ahead SMTP>> EHLO myhost.test.ex cmd buf flush ddd bytes diff --git a/test/stderr/2135 b/test/stderr/2135 index 4359c4ab2..3438de35c 100644 --- a/test/stderr/2135 +++ b/test/stderr/2135 @@ -35,10 +35,19 @@ sync_responses expect rcpt SMTP<< 250 Accepted LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local-smtp S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +local-accept delivery forking for tls-proxy interproc +postfork: tls-proxy interproc +tls-proxy interproc forking for tls proxy +postfork: tls proxy +fresh-exec forked for local-accept delivery: npppp LOG: smtp_connection MAIN SMTP connection from CALLER closed by QUIT >>>>>>>>>>>>>>>> Exim pid=pppp (msg setup toplevel) terminating with rc=0 >>>>>>>>>>>>>>>> +local-accept delivery forked for tls-proxy interproc: npppp proxy-proc inter-pid pppp +tls-proxy interproc forked for tls proxy: npppp proxy-proc final-pid pppp Exim version x.yz .... configuration file is TESTSUITE/test-config @@ -47,6 +56,8 @@ admin user dropping to exim gid; retaining priv uid >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>> --------> userb@test.ex <-------- +fresh-exec forking for transport +postfork: transport t1 transport entered userb@test.ex hostlist: @@ -69,6 +80,7 @@ ok=1 send_quit=1 send_rset=0 continue_more=0 yield=0 first_address is NULL SMTP>> QUIT cmd buf flush ddd bytes SMTP(close)>> +fresh-exec forked for transport: npppp >>>>>>>>>>>>>>>> Exim pid=pppp (TLS proxy) terminating with rc=0 >>>>>>>>>>>>>>>> Leaving t1 transport LOG: MAIN diff --git a/test/stderr/2200 b/test/stderr/2200 index 894b4b72a..a1953b268 100644 --- a/test/stderr/2200 +++ b/test/stderr/2200 @@ -10,6 +10,9 @@ dropping to exim gid; retaining priv uid type=dnsdb key="a=localhost.test.ex" database lookup required for a=localhost.test.ex dnsdb key: localhost.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp lookup yielded: 127.0.0.1 search_open: dnsdb "NULL" cached open @@ -35,6 +38,9 @@ search_tidyup called type=dnsdb key="a=shorthost.test.ex" database lookup required for a=shorthost.test.ex dnsdb key: shorthost.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp lookup yielded: 127.0.0.1 search_open: dnsdb "NULL" cached open @@ -45,6 +51,9 @@ search_tidyup called type=dnsdb key="a=shorthost.test.ex" cached data found but past valid time; database lookup required for a=shorthost.test.ex dnsdb key: shorthost.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp lookup yielded: 127.0.0.1 LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local S=sss diff --git a/test/stderr/2201 b/test/stderr/2201 index 5cbdbc04f..f4fa473e7 100644 --- a/test/stderr/2201 +++ b/test/stderr/2201 @@ -36,6 +36,9 @@ internal_search_find: file="NULL" database lookup required for test.ex dnsdb key: test.ex DNS lookup of test.ex (TXT) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of test.ex (TXT) succeeded lookup yielded: A TXT record for test.ex. test.ex in "dnsdb;test.ex"? yes (matched "dnsdb;test.ex") @@ -97,6 +100,9 @@ internal_search_find: file="NULL" database lookup required for unknown dnsdb key: unknown DNS lookup of unknown (TXT) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of unknown (TXT) gave HOST_NOT_FOUND returning DNS_NOMATCH faking res_search(TXT) response length as 65535 @@ -129,6 +135,9 @@ internal_search_find: file="NULL" database lookup required for A=myhost.test.ex dnsdb key: myhost.test.ex DNS lookup of myhost.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of myhost.test.ex (A) succeeded lookup yielded: V4NET.10.10.10 CALLER@myhost.test.ex in "dnsdb;A=myhost.test.ex"? yes (matched "dnsdb;A=myhost.test.ex") @@ -159,6 +168,9 @@ internal_search_find: file="NULL" type=dnsdb key="a=shorthost.test.ex" database lookup required for a=shorthost.test.ex dnsdb key: shorthost.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp lookup yielded: 127.0.0.1 search_open: dnsdb "NULL" cached open @@ -178,6 +190,9 @@ internal_search_find: file="NULL" type=dnsdb key="a=shorthost.test.ex" cached data found but past valid time; database lookup required for a=shorthost.test.ex dnsdb key: shorthost.test.ex +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp lookup yielded: 127.0.0.1 LOG: MAIN <= a@shorthost.test.ex U=CALLER P=local S=sss @@ -202,14 +217,29 @@ ppppp exim x.yz daemon started: pid=pppp, no queue runs, listening for SMTP on ppppp daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID ppppp Listening... ppppp Connection request from 127.0.0.1 port sssss -ppppp 1 SMTP accept process running -ppppp Listening... +ppppp fresh-exec forking for daemon accept +ppppp postfork: daemon accept ppppp Process ppppp is handling incoming connection from [127.0.0.1] ppppp Process ppppp is ready for new message +ppppp daemon accept forking for child-open +ppppp postfork: child-open +ppppp fresh-exec forked for daemon accept: npppp +ppppp 1 SMTP accept process running +ppppp Listening... +ppppp daemon accept forked for child-open: npppp +ppppp daemon accept forking for child-open +ppppp postfork: child-open +ppppp daemon accept forked for child-open: npppp ppppp dnslists check: rbl.test.ex/V4NET.11.12.14 ppppp new DNS lookup for 14.12.11.V4NET.rbl.test.ex +ppppp daemon accept forking for child-open +ppppp postfork: child-open +ppppp daemon accept forked for child-open: npppp ppppp dnslists: wrote cache entry, ttl=2 ppppp DNS lookup for 14.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2) +ppppp daemon accept forking for child-open +ppppp postfork: child-open +ppppp daemon accept forked for child-open: npppp ppppp => that means V4NET.11.12.14 is listed at rbl.test.ex ppppp dnslists check: rbl.test.ex/V4NET.11.12.14 ppppp dnslists: using result of previous lookup @@ -217,8 +247,14 @@ ppppp DNS lookup for 14.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2) ppppp => that means V4NET.11.12.14 is listed at rbl.test.ex ppppp dnslists check: rbl.test.ex/V4NET.11.12.14 ppppp cached data found but past valid time; new DNS lookup for 14.12.11.V4NET.rbl.test.ex +ppppp daemon accept forking for child-open +ppppp postfork: child-open +ppppp daemon accept forked for child-open: npppp ppppp dnslists: wrote cache entry, ttl=2 ppppp DNS lookup for 14.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2) +ppppp daemon accept forking for child-open +ppppp postfork: child-open +ppppp daemon accept forked for child-open: npppp ppppp => that means V4NET.11.12.14 is listed at rbl.test.ex ppppp LOG: MAIN ppppp <= a@shorthost.test.ex H=localhost (myhost.test.ex) [127.0.0.1] P=esmtp S=sss id=E10HmaX-0005vi-00@myhost.test.ex @@ -230,4 +266,7 @@ ppppp child ppppp ended: status=0x0 ppppp normal exit, 0 ppppp 0 SMTP accept processes now running ppppp Listening... +ppppp fresh-exec forking for daemon del pidfile +ppppp postfork: daemon del pidfile +ppppp fresh-exec forked for daemon del pidfile: npppp ppppp >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>> diff --git a/test/stderr/2202 b/test/stderr/2202 index 46e172c1a..a696f13ac 100644 --- a/test/stderr/2202 +++ b/test/stderr/2202 @@ -39,6 +39,9 @@ check hosts = +ignore_unknown : *.$sender_address_domain : $sender_address_domai database lookup required for >:defer_never,mxh=cioce.test.again.dns dnsdb key: cioce.test.again.dns DNS lookup of cioce.test.again.dns (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of cioce.test.again.dns (MX) gave TRY_AGAIN cioce.test.again.dns in dns_again_means_nonexist? yes (matched "*") cioce.test.again.dns is in dns_again_means_nonexist: returning DNS_NOMATCH @@ -48,9 +51,15 @@ DNS: no SOA record found for neg-TTL sender host name required, to match against *.cioce.test.again.dns looking up host name for ip4.ip4.ip4.ip4 DNS lookup of ip4-reverse.in-addr.arpa (PTR) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of ip4-reverse.in-addr.arpa (PTR) succeeded IP address lookup yielded "the.local.host.name" DNS lookup of the.local.host.name (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of the.local.host.name (A) succeeded local host found for non-MX address the.local.host.name ip4.ip4.ip4.ip4 mx=-1 sort=xx @@ -61,6 +70,9 @@ sender_fullhost = the.local.host.name [ip4.ip4.ip4.ip4] sender_rcvhost = the.local.host.name ([ip4.ip4.ip4.ip4]) using host_fake_gethostbyname for cioce.test.again.dns (IPv4) DNS lookup of cioce.test.again.dns (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of cioce.test.again.dns (A) gave TRY_AGAIN cioce.test.again.dns in dns_again_means_nonexist? yes (matched "*") cioce.test.again.dns is in dns_again_means_nonexist: returning DNS_NOMATCH diff --git a/test/stderr/2600 b/test/stderr/2600 index 3c2b058d6..6a0ef9760 100644 --- a/test/stderr/2600 +++ b/test/stderr/2600 @@ -331,7 +331,10 @@ LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -odi -Mc 10HmaX-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -411,6 +414,8 @@ search_tidyup called failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to userx <userx@myhost.test.ex> transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=NULL current=/ @@ -442,6 +447,7 @@ writing data block fd=dddd size=sss timeout=0 writing data block fd=dddd size=sss timeout=0 appendfile yields 0 with errno=dd more_errno=dd search_tidyup called +fresh-exec forked for delivery (local): npppp journalling userx@myhost.test.ex t1 transport returned OK for userx@myhost.test.ex post-process userx@myhost.test.ex (0) diff --git a/test/stderr/2610 b/test/stderr/2610 index ef3e0a901..1da8bfd9d 100644 --- a/test/stderr/2610 +++ b/test/stderr/2610 @@ -324,7 +324,10 @@ LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -odi -Mc 10HmaX-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -406,6 +409,8 @@ close MYSQL connection: 127.0.0.1:1223/test/root failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to ph10 <ph10@myhost.test.ex> transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=NULL current=/ @@ -439,6 +444,7 @@ writing data block fd=dddd size=sss timeout=0 appendfile yields 0 with errno=dd more_errno=dd search_tidyup called close MYSQL connection: 127.0.0.1:1223/test/root +fresh-exec forked for delivery (local): npppp journalling ph10@myhost.test.ex t1 transport returned OK for ph10@myhost.test.ex post-process ph10@myhost.test.ex (0) diff --git a/test/stderr/2620 b/test/stderr/2620 index f31be1b7f..597d960d0 100644 --- a/test/stderr/2620 +++ b/test/stderr/2620 @@ -342,7 +342,10 @@ LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -odi -Mc 10HmaX-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -424,6 +427,8 @@ close PGSQL connection: localhost:1223/test/CALLER failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to CALLER <CALLER@myhost.test.ex> transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=NULL current=/ @@ -457,6 +462,7 @@ writing data block fd=dddd size=sss timeout=0 appendfile yields 0 with errno=dd more_errno=dd search_tidyup called close PGSQL connection: localhost:1223/test/CALLER +fresh-exec forked for delivery (local): npppp journalling CALLER@myhost.test.ex t1 transport returned OK for CALLER@myhost.test.ex post-process CALLER@myhost.test.ex (0) diff --git a/test/stderr/4052 b/test/stderr/4052 index ee166097b..b9629ad4b 100644 --- a/test/stderr/4052 +++ b/test/stderr/4052 @@ -3,6 +3,9 @@ configuration file is TESTSUITE/test-config admin user LOG: MAIN <= CALLER@the.local.host.name U=CALLER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -10,6 +13,8 @@ admin user dropping to exim gid; retaining priv uid >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>> --------> extchange@test.ex <-------- +fresh-exec forking for transport +postfork: transport smtp transport entered extchange@test.ex hostlist: @@ -58,6 +63,7 @@ no messages waiting for 127.0.0.1 SMTP>> QUIT cmd buf flush ddd bytes SMTP(close)>> +fresh-exec forked for transport: npppp Leaving smtp transport LOG: MAIN => extchange@test.ex R=client T=smtp H=127.0.0.1 [127.0.0.1] L* C="250 message accepted" diff --git a/test/stderr/4520 b/test/stderr/4520 index 1b7714d83..5ff7f648e 100644 --- a/test/stderr/4520 +++ b/test/stderr/4520 @@ -3,15 +3,21 @@ configuration file is TESTSUITE/test-config admin user LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user admin user dropping to exim gid; retaining priv uid +fresh-exec forking for transport +postfork: transport Connecting to ip4.ip4.ip4.ip4 [ip4.ip4.ip4.ip4]:1225 ... connected SMTP<< 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000 SMTP>> EHLO myhost.test.ex cmd buf flush ddd bytes +fresh-exec forked for transport: npppp SMTP<< 250-myhost.test.ex Hello the.local.host.name [ip4.ip4.ip4.ip4] 250-SIZE 52428800 250-8BITMIME @@ -25,6 +31,9 @@ cmd buf flush ddd bytes SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself DKIM (checking verify key)>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> +transport forking for child-open +postfork: child-open +transport forked for child-open: npppp DKIM >> Parsing public key record >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> sel_bad._domainkey.test.ex. Raw record: v=DKIM1\;{SP}p=MIGfMA0GCSqGSIb3DQEBAQUAA4GNADCBiQKBgQDXRFf+VhT+lCgFhhSkinZKcFNeRzjYdW8vT29Rbb3NadvTFwAd+cVLPFwZL8H5tUD/7JbUPqNTCPxmpgIL+V5T4tEZMorHatvvUM2qfcpQ45IfsZ+YdhbIiAslHCpy4xNxIR3zylgqRUF4+Dtsaqy3a5LhwMiKCLrnzhXk1F1hxwIDAQAB diff --git a/test/stderr/4802 b/test/stderr/4802 index 9575f881f..85a2b1ca0 100644 --- a/test/stderr/4802 +++ b/test/stderr/4802 @@ -3,8 +3,17 @@ configuration file is TESTSUITE/test-config admin user dropping to exim gid; retaining priv uid DNS lookup of mx-sec-a-aa.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of mx-sec-a-aa.test.ex (MX) succeeded +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of a-aa.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of a-aa.test.ex (A) succeeded DNS lookup of a-aa.test.ex (A/AAAA) requested AD, but got AA >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>> @@ -13,8 +22,17 @@ configuration file is TESTSUITE/test-config admin user dropping to exim gid; retaining priv uid DNS lookup of mx-aa-a-sec.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of mx-aa-a-sec.test.ex (MX) succeeded DNS lookup of mx-aa-a-sec.test.ex (MX) requested AD, but got AA +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of a-sec.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of a-sec.test.ex (A) succeeded >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>> diff --git a/test/stderr/4803 b/test/stderr/4803 index a7aa7bfa8..5636a3954 100644 --- a/test/stderr/4803 +++ b/test/stderr/4803 @@ -3,8 +3,17 @@ configuration file is TESTSUITE/test-config admin user dropping to exim gid; retaining priv uid DNS lookup of mx-sec-a-aa.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of mx-sec-a-aa.test.ex (MX) succeeded +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of a-aa.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of a-aa.test.ex (A) succeeded DNS faked the AD bit (got AA and matched with dns_trust_aa (test.ex in *)) DNS faked the AD bit (got AA and matched with dns_trust_aa (test.ex in *)) @@ -15,10 +24,19 @@ configuration file is TESTSUITE/test-config admin user dropping to exim gid; retaining priv uid DNS lookup of mx-aa-a-sec.test.ex (MX) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of mx-aa-a-sec.test.ex (MX) succeeded DNS faked the AD bit (got AA and matched with dns_trust_aa (test.ex in *)) DNS faked the AD bit (got AA and matched with dns_trust_aa (test.ex in *)) DNS faked the AD bit (got AA and matched with dns_trust_aa (test.ex in *)) +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of a-sec.test.ex (A) using fakens +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp DNS lookup of a-sec.test.ex (A) succeeded >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>> diff --git a/test/stderr/5000 b/test/stderr/5000 index 2b96d8906..d6d1dffc6 100644 --- a/test/stderr/5000 +++ b/test/stderr/5000 @@ -4,6 +4,9 @@ configuration file is TESTSUITE/test-config admin user LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -11,6 +14,8 @@ admin user dropping to exim gid; retaining priv uid >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>> --------> userx@myhost.test.ex <-------- +fresh-exec forking for delivery (local) +postfork: delivery (local) appendfile transport entered appendfile: mode=600 notify_comsat=0 quota=20480 warning=0 directory=TESTSUITE/test-mail format=maildir @@ -43,6 +48,7 @@ mailbox quota exceeded maildir: time since "new" directory modified = 10s Exim quota exceeded for tmp/dddddddddd.HddddddPddddd.myhost.test.ex appendfile yields 1 with errno=-22 more_errno=dd +fresh-exec forked for delivery (local): npppp maildir_taggedX_appendfile transport returned DEFER for userx@myhost.test.ex added retry item for T:userx@myhost.test.ex: errno=-22 more_errno=dd flags=0 LOG: MAIN diff --git a/test/stderr/5004 b/test/stderr/5004 index c4dc1b0aa..413bb519c 100644 --- a/test/stderr/5004 +++ b/test/stderr/5004 @@ -46,7 +46,10 @@ LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -odi -Mc 10HmaX-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -95,6 +98,8 @@ rda_interpret (string): '# Exim filter\nsave TESTSUITE/test-mail' expanded: '# Exim filter save TESTSUITE/test-mail' search_tidyup called +fresh-exec forking for router interpret +postfork: router interpret changed uid/gid: r1 router (recipient is userx@test.ex) uid=CALLER_UID gid=CALLER_GID pid=pppp turned off address rewrite logging (not root or exim in this process) @@ -103,6 +108,7 @@ Filter: start of processing Filter: end of processing search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp (rda) terminating with rc=0 >>>>>>>>>>>>>>>> +fresh-exec forked for router interpret: npppp rda_interpret: subprocess yield=0 error=NULL set transport t1 r1 router generated TESTSUITE/test-mail @@ -139,6 +145,8 @@ search_tidyup called failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to TESTSUITE/test-mail <TESTSUITE/test-mail> transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=NULL current=/ @@ -161,6 +169,7 @@ renaming temporary file renamed tmp/MAILDIR.mail.test.ex as new/MAILDIR.mail.test.ex appendfile yields 0 with errno=dd more_errno=dd search_tidyup called +fresh-exec forked for delivery (local): npppp journalling TESTSUITE/test-mail:userx@test.ex t1 transport returned OK for TESTSUITE/test-mail post-process TESTSUITE/test-mail (0) diff --git a/test/stderr/5005 b/test/stderr/5005 index deeee90d6..d37d3bd9e 100644 --- a/test/stderr/5005 +++ b/test/stderr/5005 @@ -44,7 +44,10 @@ LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -odi -Mc 10HmaX-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -114,6 +117,8 @@ search_tidyup called failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to nofile <nofile@test.ex> transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=NULL current=/ @@ -155,6 +160,7 @@ renaming temporary file renamed tmp/MAILDIR.myhost.test.ex as new/MAILDIR.myhost.test.ex appendfile yields 0 with errno=dd more_errno=dd search_tidyup called +fresh-exec forked for delivery (local): npppp journalling nofile@test.ex t1 transport returned OK for nofile@test.ex post-process nofile@test.ex (0) @@ -232,7 +238,10 @@ Size of headers = sss LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -odi -Mc 10HmaY-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -301,6 +310,8 @@ search_tidyup called failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to userx <userx@test.ex> transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=NULL current=/ @@ -344,6 +355,7 @@ renaming temporary file renamed tmp/MAILDIR.myhost.test.ex as new/MAILDIR.myhost.test.ex appendfile yields 0 with errno=dd more_errno=dd search_tidyup called +fresh-exec forked for delivery (local): npppp journalling userx@test.ex t1 transport returned OK for userx@test.ex post-process userx@test.ex (0) @@ -421,7 +433,10 @@ Size of headers = sss LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -odi -Mc 10HmaZ-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -490,6 +505,8 @@ search_tidyup called failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to userx <userx@test.ex> transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=NULL current=/ @@ -528,6 +545,7 @@ maildir: time since "new" directory modified = 10s Exim quota exceeded for tmp/dddddddddd.HddddddPddddd.myhost.test.ex appendfile yields 1 with errno=-22 more_errno=dd search_tidyup called +fresh-exec forked for delivery (local): npppp t1 transport returned DEFER for userx@test.ex added retry item for T:userx@test.ex: errno=-22 more_errno=dd flags=0 post-process userx@test.ex (1) @@ -619,7 +637,10 @@ Size of headers = sss LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -odi -Mc 10HmbA-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -696,6 +717,8 @@ retry record exists: age=ttt (max 1w) EXIM_DBCLOSE(0xAAAAAAAA) closed hints database and lockfile search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to userx <userx@test.ex> transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=NULL current=/ @@ -721,6 +744,7 @@ maildir: time since "new" directory modified = 10s Exim quota exceeded for tmp/dddddddddd.HddddddPddddd.myhost.test.ex appendfile yields 1 with errno=-22 more_errno=dd search_tidyup called +fresh-exec forked for delivery (local): npppp t1 transport returned DEFER for userx@test.ex added retry item for T:userx@test.ex: errno=-22 more_errno=dd flags=0 post-process userx@test.ex (1) diff --git a/test/stderr/5006 b/test/stderr/5006 index b1f282df7..6b759c971 100644 --- a/test/stderr/5006 +++ b/test/stderr/5006 @@ -44,7 +44,10 @@ LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log search_tidyup called +fresh-exec forking for local-accept delivery +postfork: local-accept delivery exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -odi -Mc 10HmaX-0005vi-00 +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp @@ -114,6 +117,8 @@ search_tidyup called failed to open DB file TESTSUITE/spool/db/retry: No such file or directory no retry data available search_tidyup called +fresh-exec forking for delivery (local) +postfork: delivery (local) changed uid/gid: local delivery to userx <userx@test.ex> transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=NULL current=/ @@ -153,6 +158,7 @@ renaming temporary file renamed tmp/MAILDIR.myhost.test.ex as new/MAILDIR.myhost.test.ex appendfile yields 0 with errno=dd more_errno=dd search_tidyup called +fresh-exec forked for delivery (local): npppp journalling userx@test.ex t1 transport returned OK for userx@test.ex post-process userx@test.ex (0) diff --git a/test/stderr/5008 b/test/stderr/5008 index 96f5cd9b0..b85ce5d9a 100644 --- a/test/stderr/5008 +++ b/test/stderr/5008 @@ -4,6 +4,9 @@ admin user LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -11,6 +14,8 @@ admin user dropping to exim gid; retaining priv uid >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>> --------> userx@test.ex <-------- +fresh-exec forking for delivery (local) +postfork: delivery (local) appendfile transport entered appendfile: mode=600 notify_comsat=0 quota=1048576 warning=0 directory=TESTSUITE/test-mail/userx format=maildir @@ -31,6 +36,7 @@ writing data block fd=dddd size=sss timeout=0 renaming temporary file renamed tmp/MAILDIR.myhost.test.ex as new/MAILDIR.myhost.test.ex appendfile yields 0 with errno=dd more_errno=dd +fresh-exec forked for delivery (local): npppp t1 transport returned OK for userx@test.ex LOG: MAIN => userx <userx@test.ex> R=r1 T=t1 @@ -43,6 +49,9 @@ configuration file is TESTSUITE/test-config admin user LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss +fresh-exec forking for local-accept delivery +postfork: local-accept delivery +fresh-exec forked for local-accept delivery: npppp Exim version x.yz .... configuration file is TESTSUITE/test-config trusted user @@ -50,6 +59,8 @@ admin user dropping to exim gid; retaining priv uid >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>> --------> userx@test.ex <-------- +fresh-exec forking for delivery (local) +postfork: delivery (local) appendfile transport entered appendfile: mode=600 notify_comsat=0 quota=1048576 warning=0 directory=TESTSUITE/test-mail/userx format=maildir @@ -72,6 +83,7 @@ writing data block fd=dddd size=sss timeout=0 renaming temporary file renamed tmp/MAILDIR.myhost.test.ex as new/MAILDIR.myhost.test.ex appendfile yields 0 with errno=dd more_errno=dd +fresh-exec forked for delivery (local): npppp t1 transport returned OK for userx@test.ex LOG: MAIN => userx <userx@test.ex> R=r1 T=t1 diff --git a/test/stderr/5204 b/test/stderr/5204 index f84acadd8..187938a3f 100644 --- a/test/stderr/5204 +++ b/test/stderr/5204 @@ -16,6 +16,9 @@ checking domains calling q router q router called for "DECLINE cannot route this one (DECLINE)"@some.host: domain = some.host requires uid=EXIM_UID gid=EXIM_GID current_directory=/ +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp command wrote: DECLINE cannot route this one (DECLINE) q router declined for "DECLINE cannot route this one (DECLINE)"@some.host "more" is false: skipping remaining routers @@ -37,6 +40,9 @@ checking domains calling q router q router called for "FAIL cannot route this one (FAIL)"@some.host: domain = some.host requires uid=EXIM_UID gid=EXIM_GID current_directory=/ +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp command wrote: FAIL cannot route this one (FAIL) q router forced address failure >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=2 >>>>>>>>>>>>>>>> @@ -56,6 +62,9 @@ checking domains calling q router q router called for "ERROR cannot route this one (ERROR)"@some.host: domain = some.host requires uid=EXIM_UID gid=EXIM_GID current_directory=/ +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp command wrote: ERROR cannot route this one (ERROR) LOG: PANIC q router: bad command yield: ERROR cannot route this one (ERROR) @@ -78,6 +87,9 @@ checking domains calling q router q router called for "DEFER cannot route this one (DEFER)"@some.host: domain = some.host requires uid=EXIM_UID gid=EXIM_GID current_directory=/ +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp command wrote: DEFER cannot route this one (DEFER) q router: defer for "DEFER cannot route this one (DEFER)"@some.host message: cannot route this one (DEFER) @@ -98,9 +110,18 @@ checking domains calling q router q router called for "ACCEPT transport = other_smtp hosts=ten-1.test.ex"@some.host: domain = some.host requires uid=EXIM_UID gid=EXIM_GID current_directory=/ +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp command wrote: ACCEPT transport = other_smtp hosts=ten-1.test.ex finding IP address for ten-1.test.ex doing DNS lookup +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp queued for other_smtp transport: local_part = ACCEPT transport = other_smtp hosts=ten-1.test.ex domain = some.host errors_to=NULL @@ -126,6 +147,9 @@ checking domains calling q router q router called for PASS@some.host: domain = some.host requires uid=EXIM_UID gid=EXIM_GID current_directory=/ +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp command wrote: PASS q router passed for PASS@some.host --------> s router <-------- @@ -166,6 +190,9 @@ checking domains calling q router q router called for "FREEZE cannot route this one (FREEZE)"@some.host: domain = some.host requires uid=EXIM_UID gid=EXIM_GID current_directory=/ +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp command wrote: FREEZE cannot route this one (FREEZE) q router: defer for "FREEZE cannot route this one (FREEZE)"@some.host message: cannot route this one (FREEZE) @@ -186,6 +213,9 @@ checking domains calling q router q router called for "REDIRECT postmaster@test.ex"@some.host: domain = some.host requires uid=EXIM_UID gid=EXIM_GID current_directory=/ +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp command wrote: REDIRECT postmaster@test.ex rda_interpret (string): 'postmaster@test.ex' expanded: 'postmaster@test.ex' @@ -262,6 +292,9 @@ q router called for "FAIL cannot route this one (FAIL)"@some.host: domain = some requires uid=CALLER_UID gid=CALLER_GID current_directory=/ not running as root: cannot change uid/gid subprocess will run with uid=EXIM_UID gid=EXIM_GID +fresh-exec forking for child-open +postfork: child-open +fresh-exec forked for child-open: npppp command wrote: FAIL cannot route this one (FAIL) q router forced address failure ----------- end verify ------------ diff --git a/test/stdout/0601 b/test/stdout/0601 index 85107ba74..3c2710ecf 100644 --- a/test/stdout/0601 +++ b/test/stdout/0601 @@ -1,7 +1,7 @@ 220 the.local.host.name ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
-received: message from exim 250 OK
250 Accepted
354 Enter message, ending with "." on a line by itself
250 OK id=10HmaX-0005vi-00
221 the.local.host.name closing connection
+received: message from exim |