X-Git-Url: https://git.exim.org/users/jgh/exim.git/blobdiff_plain/54c5ebb14ead7439af300e9d7d9d7d2ba29ff32e..ce889807c90746896f1310e9f4957215f46f7836:/test/stderr/0402 diff --git a/test/stderr/0402 b/test/stderr/0402 index 52886dcc8..7f301651b 100644 --- a/test/stderr/0402 +++ b/test/stderr/0402 @@ -5,11 +5,22 @@ configuration file is TESTSUITE/test-config admin user changed uid/gid: privilege not needed uid=EXIM_UID gid=EXIM_GID pid=pppp -finduser used cached passwd data for CALLER -finduser used cached passwd data for CALLER +DSN: r1 propagating DSN +DSN: r2 propagating DSN +DSN: r3 propagating DSN +DSN: r4 propagating DSN +DSN: r5 propagating DSN +seeking password data for user "CALLER": cache not available +getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID +seeking password data for user "CALLER": using cached result +getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID +seeking password data for user "CALLER": using cached result +getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME sender address = CALLER@test.ex set_process_info: pppp accepting a local non-SMTP message from +spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0 +log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 Sender: CALLER@test.ex Recipients: CALLER@test.ex @@ -28,58 +39,136 @@ I Message-Id: F From: CALLER_NAME Date: Tue, 2 Mar 1999 09:44:33 +0000 +Data file name: TESTSUITE/spool//input//10HmaX-0005vi-00-D Data file written for message 10HmaX-0005vi-00 -expanding: ${tod_full} - result: Tue, 2 Mar 1999 09:44:33 +0000 -condition: def:sender_rcvhost - result: false -expanding: from $sender_rcvhost - - result: from - -skipping: result is not used -condition: def:sender_ident - result: true -expanding: $sender_ident - result: CALLER -expanding: from ${quote_local_part:$sender_ident} - result: from CALLER -condition: def:sender_helo_name - result: false -expanding: (helo=$sender_helo_name) - - result: (helo=) - -skipping: result is not used -expanding: ${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name) - }} - result: from CALLER -condition: def:received_protocol - result: true -expanding: with $received_protocol - result: with local -condition: def:sender_address - result: true -expanding: (envelope-from <$sender_address>) - - result: (envelope-from ) - -condition: def:received_for - result: false -expanding: - for $received_for - result: - for -skipping: result is not used + ┌considering: ${tod_full} + ├──expanding: ${tod_full} + └─────result: Tue, 2 Mar 1999 09:44:33 +0000 + ┌considering: Received: ${if def:sender_rcvhost {from $sender_rcvhost + }{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name) + }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} (Exim $version_number) + ${if def:sender_address {(envelope-from <$sender_address>) + }}id $message_exim_id${if def:received_for { + for $received_for}} + ├──condition: def:sender_rcvhost + ├─────result: false + ┌───scanning: from $sender_rcvhost + }{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name) + }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} (Exim $version_number) + ${if def:sender_address {(envelope-from <$sender_address>) + }}id $message_exim_id${if def:received_for { + for $received_for}} + ├──expanding: from $sender_rcvhost + + ├─────result: from + + └───skipping: result is not used + ┌considering: ${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name) + }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} (Exim $version_number) + ${if def:sender_address {(envelope-from <$sender_address>) + }}id $message_exim_id${if def:received_for { + for $received_for}} + ├──condition: def:sender_ident + ├─────result: true + ┌considering: from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name) + }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} (Exim $version_number) + ${if def:sender_address {(envelope-from <$sender_address>) + }}id $message_exim_id${if def:received_for { + for $received_for}} + ╎┌considering: $sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name) + ╎ }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol ╎}} (Exim $version_number) + ╎ ${if def:sender_address {(envelope-from <$sender_address>) + ╎ }}id $message_exim_id${if def:received_for { + ╎ for $received_for}} + ╎├──expanding: $sender_ident + ╎└─────result: CALLER + ├──expanding: from ${quote_local_part:$sender_ident} + └─────result: from CALLER + ├──condition: def:sender_helo_name + ├─────result: false + ┌───scanning: (helo=$sender_helo_name) + }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} (Exim $version_number) + ${if def:sender_address {(envelope-from <$sender_address>) + }}id $message_exim_id${if def:received_for { + for $received_for}} + ├──expanding: (helo=$sender_helo_name) + + ├─────result: (helo=) + + └───skipping: result is not used + ├──expanding: ${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name) + }} + └─────result: from CALLER + ├──condition: def:received_protocol + ├─────result: true + ┌considering: with $received_protocol}} (Exim $version_number) + ${if def:sender_address {(envelope-from <$sender_address>) + }}id $message_exim_id${if def:received_for { + for $received_for}} + ├──expanding: with $received_protocol + └─────result: with local + ├──condition: def:tls_cipher + ├─────result: false + ┌───scanning: ($tls_cipher) + }}(Exim $version_number) + ${if def:sender_address {(envelope-from <$sender_address>) + }}id $message_exim_id${if def:received_for { + for $received_for}} + ├──expanding: ($tls_cipher) + + ├─────result: () + + └───skipping: result is not used + ├──condition: def:sender_address + ├─────result: true + ┌considering: (envelope-from <$sender_address>) + }}id $message_exim_id${if def:received_for { + for $received_for}} + ├──expanding: (envelope-from <$sender_address>) + + └─────result: (envelope-from ) + + ├──condition: def:received_for + ├─────result: false + ┌───scanning: + for $received_for}} + ├──expanding: + for $received_for + ├─────result: + for + └───skipping: result is not used + ├──expanding: Received: ${if def:sender_rcvhost {from $sender_rcvhost + }{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name) + }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} (Exim $version_number) + ${if def:sender_address {(envelope-from <$sender_address>) + }}id $message_exim_id${if def:received_for { + for $received_for}} + └─────result: Received: from CALLER by mail.test.ex with local (Exim x.yz) + (envelope-from ) + id 10HmaX-0005vi-00 >>Generated Received: header line P Received: from CALLER by mail.test.ex with local (Exim x.yz) (envelope-from ) id 10HmaX-0005vi-00; Tue, 2 Mar 1999 09:44:33 +0000 calling local_scan(); timeout=300 local_scan() returned 0 NULL -expanding: ${tod_full} - result: Tue, 2 Mar 1999 09:44:33 +0000 -Writing spool header file + ┌considering: ${tod_full} + ├──expanding: ${tod_full} + └─────result: Tue, 2 Mar 1999 09:44:33 +0000 +Writing spool header file: TESTSUITE/spool//input//hdr.pppp +DSN: Write SPOOL :-dsn_envid NULL +DSN: Write SPOOL :-dsn_ret 0 +DSN: Flags :0 +DSN: **** SPOOL_OUT - address: |CALLER@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0 +DSN: Flags :0 +DSN: **** SPOOL_OUT - address: |usery@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0 +DSN: Flags :0 +DSN: **** SPOOL_OUT - address: |userz@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0 +DSN: Flags :0 +DSN: **** SPOOL_OUT - address: |rd+CALLER@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0 +DSN: Flags :0 +DSN: **** SPOOL_OUT - address: |rd+usery@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0 +Renaming spool header file: TESTSUITE/spool//input//10HmaX-0005vi-00-H Size of headers = sss LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss @@ -92,10 +181,20 @@ changed uid/gid: forcing real = effective configuration file is TESTSUITE/test-config trusted user admin user -finduser used cached passwd data for CALLER -finduser used cached passwd data for CALLER +DSN: r1 propagating DSN +DSN: r2 propagating DSN +DSN: r3 propagating DSN +DSN: r4 propagating DSN +DSN: r5 propagating DSN +seeking password data for user "CALLER": cache not available +getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID +seeking password data for user "CALLER": using cached result +getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID +seeking password data for user "CALLER": using cached result +getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID set_process_info: pppp delivering specified messages set_process_info: pppp delivering 10HmaX-0005vi-00 +Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D reading spool file 10HmaX-0005vi-00-H user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex sender_local=1 ident=CALLER @@ -103,7 +202,17 @@ Non-recipients: Empty Tree ---- End of tree ---- recipients_count=5 +**** SPOOL_IN - No additional fields +**** SPOOL_IN - No additional fields +**** SPOOL_IN - No additional fields +**** SPOOL_IN - No additional fields +**** SPOOL_IN - No additional fields body_linecount=0 message_linecount=6 +DSN: set orcpt: NULL flags: 0 +DSN: set orcpt: NULL flags: 0 +DSN: set orcpt: NULL flags: 0 +DSN: set orcpt: NULL flags: 0 +DSN: set orcpt: NULL flags: 0 Delivery address list: CALLER@test.ex usery@test.ex @@ -111,7 +220,7 @@ Delivery address list: rd+CALLER@test.ex rd+usery@test.ex locking TESTSUITE/spool/db/retry.lockfile -locked TESTSUITE/spool/db/retry.lockfile +locked TESTSUITE/spool/db/retry.lockfile EXIM_DBOPEN(TESTSUITE/spool/db/retry) returned from EXIM_DBOPEN ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim @@ -174,8 +283,9 @@ local_part=rd+usery domain=test.ex stripped prefix rd+ checking local_parts usery in "usery"? yes (matched "usery") -expanding: /non-exist/$domain - result: /non-exist/test.ex + ┌considering: /non-exist/$domain + ├──expanding: /non-exist/$domain + └─────result: /non-exist/test.ex calling r5 router rda_interpret (string): TESTSUITE/test-mail/junk expanded: TESTSUITE/test-mail/junk @@ -212,8 +322,9 @@ local_part=rd+CALLER domain=test.ex stripped prefix rd+ checking local_parts CALLER in "CALLER"? yes (matched "CALLER") -expanding: /non-exist/$local_part - result: /non-exist/CALLER + ┌considering: /non-exist/$local_part + ├──expanding: /non-exist/$local_part + └─────result: /non-exist/CALLER calling r4 router rda_interpret (string): TESTSUITE/test-mail/junk expanded: TESTSUITE/test-mail/junk @@ -244,8 +355,9 @@ r2 router skipped: local_parts mismatch local_part=userz domain=test.ex checking local_parts userz in "userz"? yes (matched "userz") -expanding: /non-exist/$domain - result: /non-exist/test.ex + ┌considering: /non-exist/$domain + ├──expanding: /non-exist/$domain + └─────result: /non-exist/test.ex calling r3 router r3 router called for userz@test.ex domain = test.ex @@ -268,8 +380,9 @@ r1 router skipped: local_parts mismatch local_part=usery domain=test.ex checking local_parts usery in "usery"? yes (matched "usery") -expanding: /non-exist/$domain - result: /non-exist/test.ex + ┌considering: /non-exist/$domain + ├──expanding: /non-exist/$domain + └─────result: /non-exist/test.ex calling r2 router r2 router called for usery@test.ex domain = test.ex @@ -287,8 +400,9 @@ routing CALLER@test.ex local_part=CALLER domain=test.ex checking local_parts CALLER in "CALLER"? yes (matched "CALLER") -expanding: /non-exist/$local_part - result: /non-exist/CALLER + ┌considering: /non-exist/$local_part + ├──expanding: /non-exist/$local_part + └─────result: /non-exist/CALLER calling r1 router r1 router called for CALLER@test.ex domain = test.ex @@ -301,7 +415,7 @@ routed by r1 router envelope to: CALLER@test.ex transport: t1 locking TESTSUITE/spool/db/retry.lockfile -locked TESTSUITE/spool/db/retry.lockfile +locked TESTSUITE/spool/db/retry.lockfile EXIM_DBOPEN(TESTSUITE/spool/db/retry) returned from EXIM_DBOPEN no retry data available @@ -328,20 +442,22 @@ search_tidyup called >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>> --------> TESTSUITE/test-mail/junk <-------- locking TESTSUITE/spool/db/retry.lockfile -locked TESTSUITE/spool/db/retry.lockfile +locked TESTSUITE/spool/db/retry.lockfile EXIM_DBOPEN(TESTSUITE/spool/db/retry) returned from EXIM_DBOPEN no retry data available -expanding: /non-exist/$local_part - result: /non-exist/usery + ┌considering: /non-exist/$local_part + ├──expanding: /non-exist/$local_part + └─────result: /non-exist/usery search_tidyup called changed uid/gid: local delivery to TESTSUITE/test-mail/junk transport=ft1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=/non-exist/usery current=/ set_process_info: pppp delivering 10HmaX-0005vi-00 to TESTSUITE/test-mail/junk using ft1 appendfile transport entered -expanding: $address_file - result: TESTSUITE/test-mail/junk + ┌considering: $address_file + ├──expanding: $address_file + └─────result: TESTSUITE/test-mail/junk appendfile: mode=600 notify_comsat=0 quota=0 warning=0 file=TESTSUITE/test-mail/junk format=unix message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n @@ -353,20 +469,27 @@ hitch name: TESTSUITE/test-mail/junk.lock.test.ex.dddddddd.pppppppp lock file created mailbox TESTSUITE/test-mail/junk is locked writing to file TESTSUITE/test-mail/junk -condition: def:return_path - result: true -expanding: $return_path - result: CALLER@test.ex -expanding: MAILER-DAEMON - result: MAILER-DAEMON -skipping: result is not used -expanding: From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox} - - result: From CALLER@test.ex Tue Mar 02 09:44:33 1999 - -writing data block fd=6 size=sss timeout=0 -writing data block fd=6 size=sss timeout=0 -writing data block fd=6 size=sss timeout=0 + ┌considering: From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox} + + ├──condition: def:return_path + ├─────result: true + ┌considering: $return_path}{MAILER-DAEMON}} ${tod_bsdinbox} + + ├──expanding: $return_path + └─────result: CALLER@test.ex + ┌───scanning: MAILER-DAEMON}} ${tod_bsdinbox} + + ├──expanding: MAILER-DAEMON + ├─────result: MAILER-DAEMON + └───skipping: result is not used + ├──expanding: From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox} + + └─────result: From CALLER@test.ex Tue Mar 02 09:44:33 1999 + +writing data block fd=dddd size=sss timeout=0 +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 search_tidyup called journalling TESTSUITE/test-mail/junk:rd+usery@test.ex @@ -378,7 +501,7 @@ LOG: MAIN => TESTSUITE/test-mail/junk R=r5 T=ft1 --------> TESTSUITE/test-mail/junk <-------- locking TESTSUITE/spool/db/retry.lockfile -locked TESTSUITE/spool/db/retry.lockfile +locked TESTSUITE/spool/db/retry.lockfile EXIM_DBOPEN(TESTSUITE/spool/db/retry) returned from EXIM_DBOPEN no retry data available @@ -388,8 +511,9 @@ changed uid/gid: local delivery to TESTSUITE/test-mail/junk TESTSUITE/test-mail/junk R=r4 T=ft1 --------> CALLER@test.ex <-------- locking TESTSUITE/spool/db/retry.lockfile -locked TESTSUITE/spool/db/retry.lockfile +locked TESTSUITE/spool/db/retry.lockfile EXIM_DBOPEN(TESTSUITE/spool/db/retry) returned from EXIM_DBOPEN no retry data available @@ -451,12 +582,13 @@ LOG: MAIN => CALLER R=r1 T=t1 --------> usery@test.ex <-------- locking TESTSUITE/spool/db/retry.lockfile -locked TESTSUITE/spool/db/retry.lockfile +locked TESTSUITE/spool/db/retry.lockfile EXIM_DBOPEN(TESTSUITE/spool/db/retry) returned from EXIM_DBOPEN no retry data available -expanding: /non-exist/$local_part - result: /non-exist/usery + ┌considering: /non-exist/$local_part + ├──expanding: /non-exist/$local_part + └─────result: /non-exist/usery search_tidyup called changed uid/gid: local delivery to usery transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp @@ -478,12 +610,13 @@ LOG: MAIN => usery R=r2 T=t1 --------> userz@test.ex <-------- locking TESTSUITE/spool/db/retry.lockfile -locked TESTSUITE/spool/db/retry.lockfile +locked TESTSUITE/spool/db/retry.lockfile EXIM_DBOPEN(TESTSUITE/spool/db/retry) returned from EXIM_DBOPEN no retry data available -expanding: /$local_part - result: /userz + ┌considering: /$local_part + ├──expanding: /$local_part + └─────result: /userz search_tidyup called changed uid/gid: local delivery to userz transport=t2 uid=CALLER_UID gid=CALLER_GID pid=pppp @@ -509,18 +642,74 @@ changed uid/gid: post-delivery tidying set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00 Processing retry items Succeeded addresses: -userz@test.ex: no retry items -usery@test.ex: no retry items -CALLER@test.ex: no retry items -TESTSUITE/test-mail/junk: no retry items -rd+CALLER@test.ex: no retry items -TESTSUITE/test-mail/junk: no retry items -rd+usery@test.ex: no retry items -rd+CALLER@test.ex: no retry items -rd+usery@test.ex: no retry items + userz@test.ex: no retry items + usery@test.ex: no retry items + CALLER@test.ex: no retry items + TESTSUITE/test-mail/junk: no retry items + rd+CALLER@test.ex: no retry items + TESTSUITE/test-mail/junk: no retry items + rd+usery@test.ex: no retry items + rd+CALLER@test.ex: no retry items + rd+usery@test.ex: no retry items Failed addresses: Deferred addresses: end of retry processing +DSN: processing router : r3 +DSN: processing successful delivery address: userz@test.ex +DSN: Sender_address: CALLER@test.ex +DSN: orcpt: NULL flags: 0 +DSN: envid: NULL ret: 0 +DSN: Final recipient: userz@test.ex +DSN: Remote SMTP server supports DSN: 0 +DSN: not sending DSN success message +DSN: processing router : r2 +DSN: processing successful delivery address: usery@test.ex +DSN: Sender_address: CALLER@test.ex +DSN: orcpt: NULL flags: 0 +DSN: envid: NULL ret: 0 +DSN: Final recipient: usery@test.ex +DSN: Remote SMTP server supports DSN: 0 +DSN: not sending DSN success message +DSN: processing router : r1 +DSN: processing successful delivery address: CALLER@test.ex +DSN: Sender_address: CALLER@test.ex +DSN: orcpt: NULL flags: 0 +DSN: envid: NULL ret: 0 +DSN: Final recipient: CALLER@test.ex +DSN: Remote SMTP server supports DSN: 0 +DSN: not sending DSN success message +DSN: processing router : r4 +DSN: processing successful delivery address: TESTSUITE/test-mail/junk +DSN: Sender_address: CALLER@test.ex +DSN: orcpt: NULL flags: 0 +DSN: envid: NULL ret: 0 +DSN: Final recipient: TESTSUITE/test-mail/junk +DSN: Remote SMTP server supports DSN: 0 +DSN: not sending DSN success message +DSN: processing router : r5 +DSN: processing successful delivery address: TESTSUITE/test-mail/junk +DSN: Sender_address: CALLER@test.ex +DSN: orcpt: NULL flags: 0 +DSN: envid: NULL ret: 0 +DSN: Final recipient: TESTSUITE/test-mail/junk +DSN: Remote SMTP server supports DSN: 0 +DSN: not sending DSN success message +DSN: processing router : r4 +DSN: processing successful delivery address: rd+CALLER@test.ex +DSN: Sender_address: CALLER@test.ex +DSN: orcpt: NULL flags: 0 +DSN: envid: NULL ret: 0 +DSN: Final recipient: rd+CALLER@test.ex +DSN: Remote SMTP server supports DSN: 0 +DSN: not sending DSN success message +DSN: processing router : r5 +DSN: processing successful delivery address: rd+usery@test.ex +DSN: Sender_address: CALLER@test.ex +DSN: orcpt: NULL flags: 0 +DSN: envid: NULL ret: 0 +DSN: Final recipient: rd+usery@test.ex +DSN: Remote SMTP server supports DSN: 0 +DSN: not sending DSN success message LOG: MAIN Completed end delivery of 10HmaX-0005vi-00