consistent fork-time debug

Testcase issues: 0366 2035

1 files changed, 41 insertions, 2 deletions

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 >>>>>>>>>>>>>>>>