Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=CALLER_GID pid=pppp configuration file is TESTSUITE/test-config admin user changed uid/gid: privilege not needed uid=EXIM_UID gid=EXIM_GID pid=pppp 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 Sender: CALLER@test.ex Recipients: CALLER@test.ex usery@test.ex userz rd+CALLER rd+usery search_tidyup called >>Headers received: rewrite_one_header: type=F: From: CALLER_NAME search_tidyup called >>Headers after rewriting and local additions: I Message-Id: F From: CALLER_NAME Date: Tue, 2 Mar 1999 09:44:33 +0000 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 >>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 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 Size of headers = sss LOG: MAIN <= CALLER@test.ex U=CALLER P=local S=sss created log directory TESTSUITE/spool/log search_tidyup called exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xfbb95dfd -odi -Mc 10HmaX-0005vi-00 Exim version x.yz .... changed uid/gid: forcing real = effective uid=uuuu gid=EXIM_GID pid=pppp configuration file is TESTSUITE/test-config trusted user admin user 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 reading spool file 10HmaX-0005vi-00-H user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex sender_local=1 ident=CALLER 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 userz@test.ex rd+CALLER@test.ex rd+usery@test.ex locking 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 no retry data available >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: CALLER@test.ex unique = CALLER@test.ex no domain retry record no address retry record CALLER@test.ex: queued for routing >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: usery@test.ex unique = usery@test.ex no domain retry record no address retry record usery@test.ex: queued for routing >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: userz@test.ex unique = userz@test.ex no domain retry record no address retry record userz@test.ex: queued for routing >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: rd+CALLER@test.ex unique = rd+CALLER@test.ex no domain retry record no address retry record rd+CALLER@test.ex: queued for routing >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: rd+usery@test.ex unique = rd+usery@test.ex no domain retry record no address retry record rd+usery@test.ex: queued for routing >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> routing rd+usery@test.ex --------> r1 router <-------- local_part=rd+usery domain=test.ex checking local_parts rd+usery in "CALLER"? no (end of list) r1 router skipped: local_parts mismatch --------> r2 router <-------- local_part=rd+usery domain=test.ex checking local_parts rd+usery in "usery"? no (end of list) r2 router skipped: local_parts mismatch --------> r3 router <-------- local_part=rd+usery domain=test.ex checking local_parts rd+usery in "userz"? no (end of list) r3 router skipped: local_parts mismatch --------> r4 router <-------- local_part=rd+usery domain=test.ex stripped prefix rd+ checking local_parts usery in "CALLER"? no (end of list) r4 router skipped: local_parts mismatch --------> r5 router <-------- 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 calling r5 router rda_interpret (string): TESTSUITE/test-mail/junk expanded: TESTSUITE/test-mail/junk file is not a filter file parse_forward_list: TESTSUITE/test-mail/junk extract item: TESTSUITE/test-mail/junk set transport ft1 r5 router generated TESTSUITE/test-mail/junk pipe, file, or autoreply errors_to=NULL transport=ft1 uid=unset gid=unset home=/non-exist/$local_part routed by r5 router envelope to: rd+usery@test.ex transport: >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> routing rd+CALLER@test.ex --------> r1 router <-------- local_part=rd+CALLER domain=test.ex checking local_parts rd+CALLER in "CALLER"? no (end of list) r1 router skipped: local_parts mismatch --------> r2 router <-------- local_part=rd+CALLER domain=test.ex checking local_parts rd+CALLER in "usery"? no (end of list) r2 router skipped: local_parts mismatch --------> r3 router <-------- local_part=rd+CALLER domain=test.ex checking local_parts rd+CALLER in "userz"? no (end of list) r3 router skipped: local_parts mismatch --------> r4 router <-------- 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 calling r4 router rda_interpret (string): TESTSUITE/test-mail/junk expanded: TESTSUITE/test-mail/junk file is not a filter file parse_forward_list: TESTSUITE/test-mail/junk extract item: TESTSUITE/test-mail/junk set transport ft1 r4 router generated TESTSUITE/test-mail/junk pipe, file, or autoreply errors_to=NULL transport=ft1 uid=unset gid=unset home=/non-exist/CALLER routed by r4 router envelope to: rd+CALLER@test.ex transport: >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> routing userz@test.ex --------> r1 router <-------- local_part=userz domain=test.ex checking local_parts userz in "CALLER"? no (end of list) r1 router skipped: local_parts mismatch --------> r2 router <-------- local_part=userz domain=test.ex checking local_parts userz in "usery"? no (end of list) r2 router skipped: local_parts mismatch --------> r3 router <-------- local_part=userz domain=test.ex checking local_parts userz in "userz"? yes (matched "userz") expanding: /non-exist/$domain result: /non-exist/test.ex calling r3 router r3 router called for userz@test.ex domain = test.ex set transport t2 queued for t2 transport: local_part = userz domain = test.ex errors_to=NULL domain_data=NULL localpart_data=NULL routed by r3 router envelope to: userz@test.ex transport: t2 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> routing usery@test.ex --------> r1 router <-------- local_part=usery domain=test.ex checking local_parts usery in "CALLER"? no (end of list) r1 router skipped: local_parts mismatch --------> r2 router <-------- local_part=usery domain=test.ex checking local_parts usery in "usery"? yes (matched "usery") expanding: /non-exist/$domain result: /non-exist/test.ex calling r2 router r2 router called for usery@test.ex domain = test.ex set transport t1 queued for t1 transport: local_part = usery domain = test.ex errors_to=NULL domain_data=NULL localpart_data=NULL routed by r2 router envelope to: usery@test.ex transport: t1 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> routing CALLER@test.ex --------> r1 router <-------- local_part=CALLER domain=test.ex checking local_parts CALLER in "CALLER"? yes (matched "CALLER") expanding: /non-exist/$local_part result: /non-exist/CALLER calling r1 router r1 router called for CALLER@test.ex domain = test.ex set transport t1 queued for t1 transport: local_part = CALLER domain = test.ex errors_to=NULL domain_data=NULL localpart_data=NULL routed by r1 router envelope to: CALLER@test.ex transport: t1 locking 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 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: TESTSUITE/test-mail/junk unique = TESTSUITE/test-mail/junk:rd+CALLER@test.ex queued for ft1 transport >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> Considering: TESTSUITE/test-mail/junk unique = TESTSUITE/test-mail/junk:rd+usery@test.ex queued for ft1 transport >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> After routing: Local deliveries: TESTSUITE/test-mail/junk TESTSUITE/test-mail/junk CALLER@test.ex usery@test.ex userz@test.ex Remote deliveries: Failed addresses: Deferred addresses: search_tidyup called >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>> --------> TESTSUITE/test-mail/junk <-------- locking 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 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 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 message_suffix=\n maildir_use_size_file=no locking by lockfile fcntl lock name: TESTSUITE/test-mail/junk.lock 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=dddd size=sss timeout=0 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 ft1 transport returned OK for TESTSUITE/test-mail/junk post-process TESTSUITE/test-mail/junk (0) TESTSUITE/test-mail/junk delivered rd+usery@test.ex: children all complete 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 EXIM_DBOPEN(TESTSUITE/spool/db/retry) returned from EXIM_DBOPEN no retry data available 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/CALLER 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 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 message_suffix=\n maildir_use_size_file=no locking by lockfile fcntl lock name: TESTSUITE/test-mail/junk.lock 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=dddd size=sss timeout=0 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+CALLER@test.ex ft1 transport returned OK for TESTSUITE/test-mail/junk post-process TESTSUITE/test-mail/junk (0) TESTSUITE/test-mail/junk delivered rd+CALLER@test.ex: children all complete LOG: MAIN => TESTSUITE/test-mail/junk R=r4 T=ft1 --------> CALLER@test.ex <-------- locking 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 search_tidyup called changed uid/gid: local delivery to CALLER transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=/non-exist/CALLER current=/ set_process_info: pppp delivering 10HmaX-0005vi-00 to CALLER using t1 appendfile transport entered appendfile: mode=600 notify_comsat=0 quota=0 warning=0 file=/dev/null format=unix message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n message_suffix=\n maildir_use_size_file=no locking by lockfile fcntl search_tidyup called journalling CALLER@test.ex t1 transport returned OK for CALLER@test.ex post-process CALLER@test.ex (0) CALLER@test.ex delivered LOG: MAIN => CALLER R=r1 T=t1 --------> usery@test.ex <-------- locking 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 search_tidyup called changed uid/gid: local delivery to usery transport=t1 uid=CALLER_UID gid=CALLER_GID pid=pppp home=/non-exist/usery current=/ set_process_info: pppp delivering 10HmaX-0005vi-00 to usery using t1 appendfile transport entered appendfile: mode=600 notify_comsat=0 quota=0 warning=0 file=/dev/null format=unix message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n message_suffix=\n maildir_use_size_file=no locking by lockfile fcntl search_tidyup called journalling usery@test.ex t1 transport returned OK for usery@test.ex post-process usery@test.ex (0) usery@test.ex delivered LOG: MAIN => usery R=r2 T=t1 --------> userz@test.ex <-------- locking 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 search_tidyup called changed uid/gid: local delivery to userz transport=t2 uid=CALLER_UID gid=CALLER_GID pid=pppp home=/userz current=/ set_process_info: pppp delivering 10HmaX-0005vi-00 to userz using t2 appendfile transport entered appendfile: mode=600 notify_comsat=0 quota=0 warning=0 file=/dev/null format=unix message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n message_suffix=\n maildir_use_size_file=no locking by lockfile fcntl search_tidyup called journalling userz@test.ex t2 transport returned OK for userz@test.ex post-process userz@test.ex (0) userz@test.ex delivered LOG: MAIN => userz R=r3 T=t2 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>> changed uid/gid: post-delivery tidying uid=EXIM_UID gid=EXIM_GID pid=pppp 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 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 search_tidyup called search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>> search_tidyup called >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>