Debug: pass ACL-initiated debug through execs
[exim.git] / test / stdout / 0574
1 Connecting to 127.0.0.1 port 1225 ... connected
2 ??? 220
3 <<< 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
4 >>> EHLO test.ex
5 ??? 250-
6 <<< 250-myhost.test.ex Hello test.ex [127.0.0.1]
7 ??? 250-
8 <<< 250-SIZE 52428800
9 ??? 250-
10 <<< 250-8BITMIME
11 ??? 250-
12 <<< 250-PIPELINING
13 ??? 250 
14 <<< 250 HELP
15 >>> MAIL FROM:<tester@test.ex>
16 ??? 250
17 <<< 250 OK
18 >>> RCPT TO:<dest@test.ex>
19 ??? 250
20 <<< 250 Accepted
21 >>> DATA
22 ??? 354
23 <<< 354 Enter message, ending with "." on a line by itself
24 >>> Subject: test
25 >>> 
26 >>> body
27 >>> .
28 ??? 250
29 <<< 250 OK id=10HmaX-0005vi-00
30 >>> QUIT
31 ??? 221
32 <<< 221 myhost.test.ex closing connection
33 End of script
34 accept: condition test succeeded in ACL "chk_data"
35 end of ACL "chk_data": ACCEPT
36  ╭considering: ${tod_full}
37  ├──expanding: ${tod_full}
38  ╰─────result: Tue, 2 Mar 1999 09:44:33 +0000
39 Writing spool header file: TESTSUITE/spool//input//hdr.10HmaX-0005vi-00
40 DSN: **** SPOOL_OUT - address: <dest@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
41 Renaming spool header file: TESTSUITE/spool//input//10HmaX-0005vi-00-H
42 Size of headers = sss
43 LOG: MAIN
44   <= tester@test.ex H=(test.ex) [127.0.0.1] P=esmtp S=sss
45 SMTP>> 250 OK id=10HmaX-0005vi-00
46 search_tidyup called
47 Sender: tester@test.ex
48 Recipients:
49   dest@test.ex
50 daemon-accept forking for daemon-accept-delivery
51 postfork: daemon-accept-delivery
52 daemon-accept forked for daemon-accept-delivery: pppp
53 forked delivery process pppp
54 Process pppp is ready for new message
55 smtp_setup_msg entered
56 SMTP<< QUIT
57 SMTP>> 221 myhost.test.ex closing connection
58 LOG: smtp_connection MAIN
59   SMTP connection from (test.ex) [127.0.0.1] closed by QUIT
60 Exim version x.yz uid=EXIM_UID gid=EXIM_GID pid=pppp D=fff9ffff
61 Support for: crypteq iconv() IPv6 PAM Perl Expand_dlfunc OpenSSL TLS_resume move_frozen_messages Content_Scanning DANE DKIM DNSSEC Event I18N OCSP PIPECONNECT PRDR PROXY Queue_Ramp SOCKS SPF SRS TCP_Fast_Open Experimental_ARC Experimental_DCC Experimental_DSN_info Experimental_ESMTP_Limits Experimental_QUEUEFILE
62 Lookups (built-in): lsearch wildlsearch nwildlsearch iplsearch cdb dbm dbmjz dbmnz dnsdb dsearch json ldap ldapdn ldapm lmdb mysql nis nis0 passwd pgsql redis sqlite testdb
63 Authenticators: cram_md5 cyrus_sasl dovecot external gsasl plaintext spa tls
64 Routers: accept dnslookup ipliteral manualroute queryprogram redirect
65 Transports: appendfile/maildir/mailstore/mbx autoreply lmtp pipe queuefile smtp
66 Malware: sophie clamd sock cmdline
67 Fixed never_users: 0
68 Configure owner: 1002:1002
69 Size of off_t: 8
70 Compiler: GCC [11.2.1 20210728 (Red Hat 11.2.1-1)]
71 Library version: Glibc: Compile: 2.33
72                         Runtime: 2.33
73 Library version: BDB: Compile: Berkeley DB 5.3.28: (September  9, 2013)
74                       Runtime: Berkeley DB 5.3.28: (September  9, 2013)
75 Library version: OpenSSL: Compile: OpenSSL 1.1.1l  FIPS 24 Aug 2021
76                           Runtime: OpenSSL 1.1.1l  FIPS 24 Aug 2021
77                                  : built on: Tue Mar 02 09:44:33 1999 UTC
78 Library version: IDN2: Compile: 2.3.2
79                        Runtime: 2.3.2
80 Library version: Stringprep: Compile: 1.36
81                              Runtime: 1.36
82 Library version: spf2: Compile: 1.2.11
83                        Runtime: 1.2.11
84 Library version: Cyrus SASL: Compile: 2.1.27
85                              Runtime: 2.1.27 [Cyrus SASL]
86 Library version: GNU SASL: Compile: 1.8.1
87                            Runtime: 1.8.1
88 Library version: PCRE2: Compile: 10.36
89                         Runtime: 10.36 2020-12-04
90 Total 25 lookups
91 Library version: json: Jansonn version 2.13.1
92 Library version: LMDB: Compile: 0.9.29
93 Library version: MySQL: Compile: 100505 10.5.5 [mariadb-10.5]
94                         Runtime: 100505 10.5.5
95 Library version: REDIS: Compile: 0 [13]
96 Library version: SQLite: Compile: 3.34.1
97                          Runtime: 3.34.1
98 WHITELIST_D_MACROS: "DIR:EXIM_PATH:AA:ACL:ACLRCPT:ACL_MAIL:ACL_PREDATA:ACL_RCPT:AFFIX:ALLOW:ARG1:ARG2:AUTHF:AUTHS:AUTH_ID_DOMAIN:BAD:BANNER:BB:BR:BRB:CERT:COM:COMMAND_USER:CONNECTCOND:CONTROL:CREQCIP:CREQMAC:CRL:CSS:D6:DATA:DCF:DDF:DEFAULTDWC:DELAY:DETAILS:DRATELIMIT:DYNAMIC_OPTION:ELI:ERROR_DETAILS:ERT:FAKE:FALLBACK:FILTER:FILTER_PREPEND_HOME:FORBID:FORBID_SMTP_CODE:FUSER:HAI:HAP:HARDLIMIT:HEADER_LINE_MAXSIZE:HEADER_MAXSIZE:HELO_MSG:HL:HOSTS:HOSTS_AVOID_TLS:HOSTS_MAX_TRY:HVH:IFACE:IGNORE_QUOTA:INC:INSERT:IP1:IP2:LAST:LDAPSERVERS:LENCHECK:LIMIT:LIST:LOG_SELECTOR:LS:MAXNM:MESSAGE_LOGS:MSIZE:NOTDAEMON:ONCE:ONLY:OPT:OPTION:ORDER:PAH:PEX:PORT:PTBC:QDG:QOLL:QUOTA:QUOTA_FILECOUNT:QWM:RCPT_MSG:REMEMBER:REQUIRE:RETRY:RETRY1:RETRY2:RETURN:RETURN_ERROR_DETAILS:REWRITE:ROUTE_DATA:RRATELIMIT:RT:S:SELECTOR:SELF:SERVER:SERVERS:SREQCIP:SREQMAC:SRV:STD:STRICT:SUB:SUBMISSION_OPTIONS:TIMEOUTDEFER:TIMES:TRUSTED:TRYCLEAR:UL:USE_SENDER:UTF8:VALUE:WMF:X:Y"
99 TRUSTED_CONFIG_LIST: "TESTSUITE/trusted_configs"
100 macros_trusted overridden to true by whitelisting
101 changed uid/gid: forcing real = effective
102   uid=uuuu gid=EXIM_GID pid=pppp
103   auxiliary group list: <none>
104 PATH in keep_environment? yes (matched "PATH")
105 SSLKEYLOGFILE in keep_environment? no (end of list)
106 PATH in keep_environment? yes (matched "PATH")
107 adding SSLKEYLOGFILE=TESTSUITE/spool/sslkeys
108 configuration file is TESTSUITE/test-config
109 log selectors = 00000ffc 64205022 0000000c
110 cwd=TESTSUITE/spool 10 args: TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -DSERVER=server -C TESTSUITE/test-config -d=0xfff9ffff -MCd daemon-accept-delivery -Mc 10HmaX-0005vi-00
111 trusted user
112 admin user
113 dropping to exim gid; retaining priv uid
114 set_process_info: pppp delivering specified messages
115 set_process_info: pppp delivering 10HmaX-0005vi-00
116 Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D
117 reading spool file 10HmaX-0005vi-00-H
118 user=EXIMUSER uid=EXIM_UID gid=EXIM_GID sender=tester@test.ex
119 sender_fullhost = (test.ex) [127.0.0.1]
120 sender_rcvhost = [127.0.0.1] (helo=test.ex)
121 sender_local=0 ident=unset
122 Non-recipients:
123  Empty Tree
124 ---- End of tree ----
125 recipients_count=1
126 **** SPOOL_IN - No additional fields
127 body_linecount=1 message_linecount=7
128 DSN: set orcpt:   flags: 0x0
129 Delivery address list:
130   dest@test.ex 
131  locking TESTSUITE/spool/db/retry.lockfile
132  locked  TESTSUITE/spool/db/retry.lockfile
133  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
134  returned from EXIM_DBOPEN: (nil)
135  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
136 no retry data available
137 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
138 Considering: dest@test.ex
139 unique = dest@test.ex
140 no   domain  retry record
141 no   address retry record
142 dest@test.ex: queued for routing
143 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
144 routing dest@test.ex
145 --------> r1 router <--------
146 local_part=dest domain=test.ex
147 calling r1 router
148 rda_interpret (string): ':blackhole:'
149 expanded: ':blackhole:'
150 file is not a filter file
151 parse_forward_list: :blackhole:
152 extract item: :blackhole:
153 address :blackhole:d
154 LOG: MAIN
155   => :blackhole: <dest@test.ex> R=r1
156 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
157 After routing:
158   Local deliveries:
159   Remote deliveries:
160   Failed addresses:
161   Deferred addresses:
162 search_tidyup called
163 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
164 changed uid/gid: post-delivery tidying
165   uid=EXIM_UID gid=EXIM_GID pid=pppp
166   auxiliary group list: <none>
167 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
168 Processing retry items
169 Succeeded addresses:
170  dest@test.ex: no retry items
171 Failed addresses:
172 Deferred addresses:
173 end of retry processing
174 DSN: processing router : r1
175 DSN: processing successful delivery address: dest@test.ex
176 DSN: Sender_address: tester@test.ex
177 DSN: orcpt: NULL  flags: 0x0
178 DSN: envid: NULL  ret: 0
179 DSN: Final recipient: dest@test.ex
180 DSN: Remote SMTP server supports DSN: 0
181 DSN: not sending DSN success message
182 LOG: MAIN
183   Completed
184 end delivery of 10HmaX-0005vi-00
185 search_tidyup called
186 search_tidyup called
187 >>>>>>>>>>>>>>>> Exim pid=pppp (daemon-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
188 search_tidyup called
189 SMTP>>(close on process exit)
190 >>>>>>>>>>>>>>>> Exim pid=pppp (daemon-accept) terminating with rc=0 >>>>>>>>>>>>>>>>