diff options
| author | Jeremy Harris <jgh146exb@wizmail.org> | 2022-03-19 19:14:34 +0000 |
|---|---|---|
| committer | Jeremy Harris <jgh146exb@wizmail.org> | 2022-03-19 19:14:34 +0000 |
| commit | 5800e3234f2594639d82e5063d9c522c6a881d25 (patch) | |
| tree | f510c6487c7d24b6094126cde17752605996218d /test | |
| parent | 3a03e18340fd94cad88d0edeedc383aad2d107a3 (diff) | |
Debug: build a summary string tracking transport SMTP commands & responses
Diffstat (limited to 'test')
39 files changed, 172 insertions, 0 deletions
diff --git a/test/stderr/0143 b/test/stderr/0143 index 02e23a8ac..a6ac4c949 100644 --- a/test/stderr/0143 +++ b/test/stderr/0143 @@ -42,6 +42,7 @@ sync_responses expect data SMTP<< 354 Send data SMTP>> writing message and terminating "." cannot use sendfile for body: spoolfile not wireformat + SMTP>> . writing data block fd=dddd size=sss timeout=300 SMTP<< 250 OK ok=1 send_quit=1 send_rset=0 continue_more=0 yield=0 first_address is NULL @@ -54,6 +55,7 @@ cmd buf flush ddd bytes (more expected) SMTP(shutdown)>> SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL:250:RCPT:250:DATA:354:.:250:QUIT:250' 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/0217 b/test/stderr/0217 index a1efa5cdd..30724222c 100644 --- a/test/stderr/0217 +++ b/test/stderr/0217 @@ -418,6 +418,8 @@ LOG: MAIN SMTP(shutdown)>> SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT:250:250:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:RCPT|:DATA:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:550:55 +**** debug string too long - truncated **** LOG: MAIN == yes@test.ex R=client T=send_to_server defer (-46) H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after pipelined DATA: 403 Sorry temp data error LOG: MAIN @@ -850,11 +852,13 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> DATA SMTP<< 351 Send more SMTP>> writing message and terminating "." + SMTP>> . SMTP<< 250 OK SMTP+> QUIT SMTP(shutdown)>> SMTP(closed)<< SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL:250:RCPT:250:RCPT:250:RCPT:250:RCPT:250:DATA:351:.:250:QUIT' LOG: MAIN => w@test.ex R=client T=send_to_server H=127.0.0.1 [127.0.0.1] C="250 OK" LOG: MAIN diff --git a/test/stderr/0218 b/test/stderr/0218 index c07bd2a46..acfb3c156 100644 --- a/test/stderr/0218 +++ b/test/stderr/0218 @@ -32,8 +32,10 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP<< 250 OK SMTP<< 351 Send more SMTP>> writing message and terminating "." + SMTP>> . SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT|:DATA:250:250:351:.:250' 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" LOG: MAIN @@ -54,11 +56,13 @@ T: send_to_server (ACL) SMTP<< 250 OK SMTP<< 351 Send more SMTP>> writing message and terminating "." + SMTP>> . SMTP+> QUIT SMTP(shutdown)>> SMTP<< 250 OK SMTP<< 250 OK SMTP(close)>> +cmdlog: 'MAIL|:RCPT|:DATA:250:250:351:.:QUIT:250:250' LOG: MAIN => b@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" LOG: MAIN @@ -104,6 +108,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP(shutdown)>> SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT|:DATA:550:503:503:QUIT:250' 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 Exim version x.yz .... @@ -168,6 +173,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> RSET SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT|:DATA:250:550:503:RSET:250' 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 Exim version x.yz .... @@ -195,11 +201,13 @@ T: send_to_server (ACL) SMTP<< 250 OK SMTP<< 351 OK SMTP>> writing message and terminating "." + SMTP>> . SMTP+> QUIT SMTP(shutdown)>> SMTP<< 250 OK SMTP<< 250 OK SMTP(close)>> +cmdlog: 'MAIL|:RCPT|:DATA:250:250:351:.:QUIT:250:250' LOG: MAIN => c@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" LOG: MAIN diff --git a/test/stderr/0227 b/test/stderr/0227 index 71b9637ff..8d766d61d 100644 --- a/test/stderr/0227 +++ b/test/stderr/0227 @@ -11,6 +11,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:QUIT:250' LOG: smtp_connection MAIN SMTP connection from root closed by QUIT LOG: smtp_connection MAIN @@ -30,6 +31,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:550:QUIT:250' LOG: MAIN REJECT H=(test) [V4NET.0.0.1] U=root sender verify fail for <bad@localhost>: 127.0.0.1 [127.0.0.1] : SMTP error from remote mail server after RCPT TO:<bad@localhost>: 550 Unknown user LOG: MAIN REJECT @@ -49,6 +51,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:450:QUIT:250' LOG: MAIN REJECT H=(test) [V4NET.0.0.1] U=root sender verify defer for <uncheckable@localhost1>: Could not complete sender verify callout: 127.0.0.1 [127.0.0.1] : SMTP error from remote mail server after RCPT TO:<uncheckable@localhost1>: 450 Temporary error LOG: MAIN REJECT @@ -66,6 +69,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:550:QUIT:250' LOG: MAIN REJECT H=(test) [V4NET.0.0.1] U=root sender verify fail for <uncheckable2@localhost1>: 127.0.0.1 [127.0.0.1] : response to "MAIL FROM:<>" was: 550 Error for <> LOG: MAIN REJECT @@ -84,6 +88,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:550-:QUIT:250' LOG: MAIN REJECT H=(test) [V4NET.0.0.1] U=root sender verify fail for <uncheckable@localhost1>: 127.0.0.1 [127.0.0.1] : response to "MAIL FROM:<>" was: 550-Multiline error for <>\n550 Here's the second line LOG: MAIN REJECT @@ -101,6 +106,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:550:QUIT:250' LOG: MAIN REJECT H=(test) [V4NET.0.0.1] U=root sender verify fail for <uncheckable2@localhost1>: 127.0.0.1 [127.0.0.1] : response to "MAIL FROM:<>" was: 550 Bad-char error for <> topbitchar:\200\377\377 LOG: MAIN REJECT @@ -120,6 +126,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:550:QUIT:250' LOG: MAIN REJECT H=(test) [V4NET.0.0.3] U=root F=<uncheckable@localhost1> rejected RCPT <z@remote.domain>: 127.0.0.1 [127.0.0.1] : SMTP error from remote mail server after RCPT TO:<z@remote.domain>: 550 Recipient not liked LOG: smtp_connection MAIN @@ -138,6 +145,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:550-:QUIT:250' LOG: MAIN REJECT H=(test) [V4NET.0.0.3] U=root F=<uncheckable@localhost1> rejected RCPT <z@remote.domain>: 127.0.0.1 [127.0.0.1] : SMTP error from remote mail server after RCPT TO:<z@remote.domain>: 550-Recipient not liked on two lines\n550 Here's the second LOG: smtp_connection MAIN @@ -155,6 +163,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:550:QUIT:250' LOG: MAIN REJECT H=(test) [V4NET.0.0.3] U=root F=<uncheckable@localhost1> rejected RCPT <z@remote.domain>: 127.0.0.1 [127.0.0.1] : SMTP error from remote mail server after RCPT TO:<z@remote.domain>: 550 Recipient not liked, with bad char:\200\377\377 LOG: smtp_connection MAIN @@ -180,6 +189,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:550:QUIT:250' LOG: MAIN REJECT H=(test) [V4NET.0.0.4] U=root F=<uncheckable@localhost1> rejected after DATA: there is no valid sender in any header line LOG: smtp_connection MAIN @@ -197,6 +207,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:550:QUIT:250' LOG: MAIN REJECT H=(test) [V4NET.0.0.4] U=root F=<uncheckable@localhost1> rejected after DATA: there is no valid sender in any header line LOG: smtp_connection MAIN @@ -221,6 +232,7 @@ Cutthrough cancelled by presence of postmaster verify SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:RSET:250:MAIL:250:RCPT:250:QUIT:250' LOG: MAIN REJECT H=(test) [V4NET.0.0.5] U=root F=<ok@localhost1> rejected RCPT <z@remote.domain>: relay not permitted LOG: smtp_connection MAIN @@ -245,6 +257,7 @@ Cutthrough cancelled by presence of postmaster verify SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:RSET:250:MAIL:250:RCPT:550:QUIT:250' LOG: MAIN REJECT H=(test) [V4NET.0.0.5] U=root sender verify fail for <ok@localhost1>: 127.0.0.1 [127.0.0.1] : SMTP error from remote mail server after RCPT TO:<postmaster@localhost1>: 550 Don't like postmaster LOG: MAIN REJECT @@ -266,6 +279,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL:250:RCPT:250:QUIT:250' LOG: smtp_connection MAIN SMTP connection from root closed by QUIT LOG: smtp_connection MAIN @@ -283,6 +297,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL:250:RCPT:250:QUIT:250' LOG: MAIN REJECT H=(me) [V4NET.0.0.3] U=root F=<ok@localhost1> rejected RCPT <z@remote.domain>: relay not permitted LOG: smtp_connection MAIN @@ -302,6 +317,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL:250:RCPT:250:QUIT:250' LOG: MAIN REJECT H=(me) [V4NET.0.0.3] U=root F=<ok@localhost1> rejected RCPT <z@remote.domain>: relay not permitted LOG: smtp_connection MAIN @@ -327,6 +343,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL:250:RCPT:550:RSET:250:MAIL:250:RCPT:250:QUIT:250' LOG: MAIN REJECT H=(me) [V4NET.0.0.7] U=root F=<ok@localhost1> rejected RCPT <z@remote.domain>: relay not permitted LOG: smtp_connection MAIN @@ -344,6 +361,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:LHLO:250:MAIL:250:RCPT:550:QUIT:250' LOG: MAIN REJECT H=(test) [V4NET.0.0.3] U=root F=<uncheckable@localhost1> rejected RCPT <z@remote.lmtp>: 127.0.0.1 [127.0.0.1] : SMTP error from remote mail server after RCPT TO:<z@remote.lmtp>: 550 Recipient not liked LOG: smtp_connection MAIN @@ -353,6 +371,7 @@ LOG: smtp_connection MAIN Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP(closed)<< SMTP(close)>> +cmdlog: '(unset)' LOG: MAIN REJECT H=(test) [V4NET.0.0.1] U=root sender verify defer for <bad@localhost1>: Could not complete sender verify callout: 127.0.0.1 [127.0.0.1] : Remote host closed connection in response to initial connection LOG: MAIN REJECT diff --git a/test/stderr/0276 b/test/stderr/0276 index 3519ecf16..eb289faae 100644 --- a/test/stderr/0276 +++ b/test/stderr/0276 @@ -17,6 +17,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP(shutdown)>> SMTP<< 200 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT|:DATA:250:250:500:QUIT:200' 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 pipelined DATA: 500 NO LOG: MAIN @@ -53,6 +54,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP(shutdown)>> SMTP<< 200 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL:250:RCPT:250:DATA:500:QUIT:200' LOG: MAIN ** usery@test.ex R=r1 T=t1 H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after DATA: 500 NO LOG: MAIN diff --git a/test/stderr/0332 b/test/stderr/0332 index 67efe896d..4ca67a51c 100644 --- a/test/stderr/0332 +++ b/test/stderr/0332 @@ -34,6 +34,7 @@ After routing: Deferred addresses: locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-t1.lockfile +cmdlog: '220:EHLO:250-:MAIL|:RCPT|:DATA:250:250:354:.:250' LOG: MAIN => ok@no.delay R=r1 T=t1 H=127.0.0.1 [127.0.0.1] C="250 OK" LOG: MAIN @@ -80,6 +81,7 @@ After routing: delay@test.again.dns locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-t1.lockfile +cmdlog: 'MAIL|:RCPT|:DATA:250:250:354:.:250:QUIT:250' LOG: MAIN => ok@no.delay R=r1 T=t1 H=127.0.0.1 [127.0.0.1]* C="250 OK" >>>>>>>>>>>>>>>> Exim pid=pppp (continued-transport) terminating with rc=0 >>>>>>>>>>>>>>>> diff --git a/test/stderr/0333 b/test/stderr/0333 index a1ca416aa..1acaa1f9e 100644 --- a/test/stderr/0333 +++ b/test/stderr/0333 @@ -32,6 +32,7 @@ After routing: Deferred addresses: locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-t1.lockfile +cmdlog: '220:EHLO:250-:MAIL|:RCPT|:DATA:250:250:354:.:250' LOG: MAIN => ok@no.delay R=r1 T=t1 H=127.0.0.1 [127.0.0.1] C="250 OK" LOG: MAIN @@ -78,6 +79,7 @@ After routing: delay@test.again.dns locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-t1.lockfile +cmdlog: 'MAIL|:RCPT|:DATA:250:250:354:.:250:QUIT:250' LOG: MAIN => ok@no.delay R=r1 T=t1 H=127.0.0.1 [127.0.0.1]* C="250 OK" >>>>>>>>>>>>>>>> Exim pid=pppp (continued-transport) terminating with rc=0 >>>>>>>>>>>>>>>> diff --git a/test/stderr/0357 b/test/stderr/0357 index 53ecffabe..6881590d6 100644 --- a/test/stderr/0357 +++ b/test/stderr/0357 @@ -26,6 +26,7 @@ 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 +cmdlog: '220:EHLO:250:MAIL:250:RCPT:451:QUIT:250' reading retry information for R:userx@test.ex:<CALLER@test.ex> from subprocess added retry item LOG: MAIN @@ -70,6 +71,7 @@ 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 +cmdlog: '220:EHLO:250:MAIL:250:RCPT:451:QUIT:250' reading retry information for R:userx@test.ex:<CALLER@test.ex> from subprocess existing delete item dropped added retry item @@ -127,6 +129,7 @@ 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 +cmdlog: '220:EHLO:250:MAIL:250:RCPT:451:QUIT:250' 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/0358 b/test/stderr/0358 index 219691d4a..abc5f64c3 100644 --- a/test/stderr/0358 +++ b/test/stderr/0358 @@ -32,6 +32,7 @@ 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 +cmdlog: '220:EHLO:250:MAIL:250:RCPT:451:RCPT:451:QUIT:250' 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 @@ -95,6 +96,7 @@ 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 +cmdlog: '220:EHLO:250:MAIL:250:RCPT:451:RCPT:451:QUIT:250' 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/0374 b/test/stderr/0374 index 5bdf559ed..69f54579b 100644 --- a/test/stderr/0374 +++ b/test/stderr/0374 @@ -367,13 +367,16 @@ 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 locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-ut4.lockfile +cmdlog: '220' LOG: MAIN => d1@myhost.test.ex R=ut4 T=ut4 H=127.0.0.1 [127.0.0.1] C="250 OK" locking TESTSUITE/spool/db/retry.lockfile +cmdlog: '220' 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 locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-ut4.lockfile +cmdlog: '220' 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 diff --git a/test/stderr/0375 b/test/stderr/0375 index 6c8f00010..0f16b9e52 100644 --- a/test/stderr/0375 +++ b/test/stderr/0375 @@ -802,34 +802,41 @@ LOG: MAIN log writing disabled locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-ut4.lockfile +cmdlog: '220' 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 locking TESTSUITE/spool/db/retry.lockfile +cmdlog: '220' 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 locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-ut4.lockfile +cmdlog: '220' 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 locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-ut5.lockfile +cmdlog: '220' 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 locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-ut6.lockfile +cmdlog: '220' 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 locking TESTSUITE/spool/db/retry.lockfile +cmdlog: '220' 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 locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-ut6.lockfile +cmdlog: '220' 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 diff --git a/test/stderr/0376 b/test/stderr/0376 index 96c834781..8fdcf31a7 100644 --- a/test/stderr/0376 +++ b/test/stderr/0376 @@ -23,6 +23,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:QUIT:250' wrote callout cache domain record for localhost: result=1 postmaster=0 random=0 wrote positive callout cache address record for ok@localhost @@ -94,6 +95,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:550:QUIT:250' wrote callout cache domain record for localhost: result=1 postmaster=0 random=0 wrote negative callout cache address record for bad@localhost @@ -148,6 +150,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:550:QUIT:250' wrote callout cache domain record for localhost: result=3 postmaster=0 random=0 LOG: MAIN REJECT @@ -209,6 +212,7 @@ Cutthrough cancelled by presence of postmaster verify SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:RSET:250:MAIL:250:RCPT:550:QUIT:250' wrote callout cache domain record for otherhost: result=1 postmaster=2 random=0 wrote positive callout cache address record for ok@otherhost @@ -271,6 +275,7 @@ Cutthrough cancelled by presence of postmaster verify SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:RSET:250:MAIL:250:RCPT:250:QUIT:250' wrote callout cache domain record for otherhost2: result=1 postmaster=1 random=0 wrote positive callout cache address record for ok@otherhost2 @@ -320,6 +325,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:QUIT:250' wrote callout cache domain record for otherhost3: result=1 postmaster=0 random=1 LOG: MAIN @@ -370,6 +376,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:QUIT:250' wrote callout cache domain record for otherhost4: result=1 postmaster=0 random=1 LOG: MAIN @@ -433,6 +440,7 @@ Cutthrough cancelled by presence of postmaster verify SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:550:RSET:250:MAIL:250:RCPT:250:RSET:250:MAIL:250:RCPT:250:QUIT:250' wrote callout cache domain record for otherhost41: result=1 postmaster=1 random=2 wrote positive callout cache address record for ok@otherhost41 @@ -490,6 +498,7 @@ Cutthrough cancelled by presence of postmaster verify SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:RSET:250:MAIL:250:RCPT:250:QUIT:250' wrote callout cache domain record for otherhost21: result=1 postmaster=1 random=0 wrote positive callout cache address record for ok@otherhost21 @@ -522,6 +531,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:QUIT:250' wrote callout cache domain record for otherhost21: result=1 postmaster=1 random=0 wrote positive callout cache address record for ok2@otherhost21 @@ -559,6 +569,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:550:RSET:250:MAIL:250:RCPT:250:QUIT:250' wrote callout cache domain record for otherhost31: result=1 postmaster=0 random=2 wrote positive callout cache address record for ok@otherhost31 @@ -591,6 +602,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:QUIT:250' wrote callout cache domain record for otherhost31: result=1 postmaster=0 random=2 wrote positive callout cache address record for okok@otherhost31 @@ -628,6 +640,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:550:RSET:250:MAIL:250:RCPT:250:QUIT:250' wrote callout cache domain record for otherhost31: result=1 postmaster=0 random=2 wrote positive callout cache address record for okokok@otherhost31 @@ -658,6 +671,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP(Connection timed out)<< SMTP timeout SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT' wrote callout cache domain record for otherhost51: result=1 postmaster=0 random=0 LOG: MAIN REJECT @@ -699,6 +713,7 @@ Cutthrough cancelled by presence of postmaster verify SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:RSET:250:MAIL:250:RCPT:250:QUIT:250' wrote callout cache domain record for otherhost52: result=1 postmaster=1 random=0 wrote positive callout cache address record for okokok@otherhost52 @@ -731,6 +746,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:QUIT:250' wrote callout cache domain record for x.y.z: result=1 postmaster=0 random=0 wrote positive callout cache address record for abcd@x.y.z/<somesender@a.domain> @@ -764,6 +780,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP(Connection timed out)<< SMTP timeout SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT' wrote callout cache domain record for x.y.z: result=1 postmaster=0 random=0 LOG: MAIN @@ -805,6 +822,7 @@ Cutthrough cancelled by presence of postmaster verify SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:RSET:250:MAIL:250:RCPT:550:RCPT:250:QUIT:250' wrote callout cache domain record for otherhost9: result=1 postmaster=1 random=0 wrote positive callout cache address record for ok@otherhost9 @@ -849,6 +867,7 @@ Cutthrough cancelled by presence of postmaster verify SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:550:RSET:250:MAIL:250:RCPT:250:RSET:250:MAIL:250:RCPT:250:QUIT:250' wrote callout cache domain record for test.ex: result=1 postmaster=1 random=2 wrote positive callout cache address record for z@test.ex/<postmaster@myhost.test.ex> diff --git a/test/stderr/0388 b/test/stderr/0388 index c5acae2a8..1c2a5a388 100644 --- a/test/stderr/0388 +++ b/test/stderr/0388 @@ -102,6 +102,7 @@ cmd buf flush ddd bytes (more expected) SMTP(shutdown)>> SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:451:QUIT:250' 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 "*") diff --git a/test/stderr/0398 b/test/stderr/0398 index d14f1056a..81854ad9b 100644 --- a/test/stderr/0398 +++ b/test/stderr/0398 @@ -150,6 +150,7 @@ sync_responses expect rcpt for qq@remote cmd buf flush ddd bytes SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:550:QUIT:250' locking TESTSUITE/spool/db/callout.lockfile locked TESTSUITE/spool/db/callout.lockfile EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR|O_CREAT diff --git a/test/stderr/0426 b/test/stderr/0426 index 0ac7207b2..23080e96d 100644 --- a/test/stderr/0426 +++ b/test/stderr/0426 @@ -49,6 +49,7 @@ After routing: Deferred addresses: locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-t1.lockfile +cmdlog: '220:EHLO:250:MAIL:250:RCPT:550:QUIT:250' 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 Exim version x.yz .... diff --git a/test/stderr/0432 b/test/stderr/0432 index 2f55fa252..f1c2fa553 100644 --- a/test/stderr/0432 +++ b/test/stderr/0432 @@ -117,6 +117,7 @@ sync_responses expect rcpt for x@y cmd buf flush ddd bytes SMTP<< 220 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:QUIT:220' locking TESTSUITE/spool/db/callout.lockfile locked TESTSUITE/spool/db/callout.lockfile EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR|O_CREAT @@ -292,6 +293,7 @@ MUNGED: ::1 will be omitted in what follows >>> cmd buf flush 6 bytes >>> SMTP<< 220 OK >>> SMTP(close)>> +>>> cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:QUIT:220' >>> wrote callout cache domain record for b: >>> result=1 postmaster=0 random=0 >>> wrote positive callout cache address record for a@b @@ -328,6 +330,7 @@ MUNGED: ::1 will be omitted in what follows >>> SMTP>> EHLO myhost.test.ex >>> cmd buf flush 21 bytes >>> SMTP(close)>> +>>> cmdlog: '220:EHLO' >>> SMTP timeout >>> ----------- end verify ------------ >>> accept: condition test deferred in ACL "mail" diff --git a/test/stderr/0462 b/test/stderr/0462 index 0cf9bd412..0fc6bd06a 100644 --- a/test/stderr/0462 +++ b/test/stderr/0462 @@ -30,6 +30,7 @@ Cutthrough cancelled by presence of postmaster verify SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:RSET:250:MAIL:250:RCPT:550:QUIT:250' wrote callout cache domain record for localhost: result=1 postmaster=2 random=0 wrote positive callout cache address record for Ok@localhost @@ -74,6 +75,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:550:QUIT:250' wrote callout cache domain record for elsewhere: result=1 postmaster=0 random=0 wrote negative callout cache address record for NOTok@elsewhere @@ -109,6 +111,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:550:QUIT:250' wrote callout cache domain record for elsewhere: result=1 postmaster=0 random=0 wrote negative callout cache address record for NOTok2@elsewhere diff --git a/test/stderr/0467 b/test/stderr/0467 index 54d1e8bc1..6c6ce3ede 100644 --- a/test/stderr/0467 +++ b/test/stderr/0467 @@ -28,11 +28,13 @@ Connecting to localhost.test.ex [127.0.0.1]:1224 ... connected SMTP>> DATA SMTP<< 354 OK SMTP>> writing message and terminating "." + SMTP>> . SMTP<< 250 OK SMTP+> QUIT SMTP(shutdown)>> SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL:250:RCPT:250:DATA:354:.:250:QUIT:250' LOG: MAIN => x@srv27.test.ex R=r1 T=t1 H=localhost.test.ex [127.0.0.1]:1224 C="250 OK" LOG: MAIN diff --git a/test/stderr/0473 b/test/stderr/0473 index d9bdd31dc..ad6ff23a2 100644 --- a/test/stderr/0473 +++ b/test/stderr/0473 @@ -22,6 +22,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP(Connection timed out)<< SMTP timeout SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT' wrote callout cache domain record for two.test.ex: result=1 postmaster=0 random=0 LOG: MAIN REJECT @@ -46,6 +47,7 @@ interface=NULL port=1224 Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP(Connection timed out)<< SMTP(close)>> +cmdlog: '(unset)' SMTP timeout LOG: MAIN REJECT U=CALLER F=<x11@two.test.ex> temporarily rejected RCPT r11@two.test.ex: Could not complete recipient verify callout: 127.0.0.1 [127.0.0.1] : SMTP timeout after initial connection diff --git a/test/stderr/0476 b/test/stderr/0476 index 98baf5120..ea51b3f53 100644 --- a/test/stderr/0476 +++ b/test/stderr/0476 @@ -48,6 +48,7 @@ cmd buf flush ddd bytes SMTP(closed)<< H=127.0.0.1 [127.0.0.1] Remote host closed connection in response to RSET SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT|:DATA:250:550: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) diff --git a/test/stderr/0525 b/test/stderr/0525 index 21bc7e064..cb4aae266 100644 --- a/test/stderr/0525 +++ b/test/stderr/0525 @@ -15,6 +15,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP<< 354 SEND SMTP>> writing message and terminating "." SMTP(close)>> +cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:DATA:354' LOG: MAIN H=127.0.0.1 [127.0.0.1]: SMTP timeout after sending data block (ddd bytes written): Connection timed out LOG: MAIN diff --git a/test/stderr/0543 b/test/stderr/0543 index 4a12a9b90..8aa6d862d 100644 --- a/test/stderr/0543 +++ b/test/stderr/0543 @@ -33,6 +33,7 @@ After routing: Deferred addresses: locking TESTSUITE/spool/db/retry.lockfile locking TESTSUITE/spool/db/wait-smtp.lockfile +cmdlog: '220:EHLO:250-:MAIL:250:RCPT:250:DATA:354:.:250:QUIT:250' LOG: MAIN => userx@domain1 R=smarthost T=smtp H=thisloop.test.ex [127.0.0.1] C="250 OK" LOG: MAIN diff --git a/test/stderr/0554 b/test/stderr/0554 index 3ddb40ee2..3c72f6683 100644 --- a/test/stderr/0554 +++ b/test/stderr/0554 @@ -19,6 +19,7 @@ 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 +cmdlog: '220:EHLO:250:MAIL:250:RCPT:451:QUIT:250' reading retry information for R:x@y:<CALLER@myhost.test.ex> from subprocess added retry item LOG: MAIN @@ -62,6 +63,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 +cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:DATA:354:.:250:QUIT:250' reading retry information for R:x@y from subprocess existing delete item dropped added delete item diff --git a/test/stderr/0578 b/test/stderr/0578 index 3be9e2a1c..94f44370e 100644 --- a/test/stderr/0578 +++ b/test/stderr/0578 @@ -25,6 +25,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:250:QUIT:250' wrote callout cache domain record for localhost: result=1 postmaster=0 random=0 wrote positive callout cache address record for ok@localhost @@ -98,6 +99,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:550:QUIT:250' wrote callout cache domain record for localhost: result=1 postmaster=0 random=0 wrote negative callout cache address record for bad@localhost @@ -156,6 +158,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:550:530:QUIT:250' wrote callout cache domain record for localhost: result=3 postmaster=0 random=0 LOG: MAIN REJECT @@ -219,6 +222,7 @@ Cutthrough cancelled by presence of postmaster verify SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:250:RSET:250:MAIL|:RCPT:250:550:QUIT:250' wrote callout cache domain record for otherhost: result=1 postmaster=2 random=0 wrote positive callout cache address record for ok@otherhost @@ -283,6 +287,7 @@ Cutthrough cancelled by presence of postmaster verify SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:250:RSET:250:MAIL|:RCPT:250:250:QUIT:250' wrote callout cache domain record for otherhost2: result=1 postmaster=1 random=0 wrote positive callout cache address record for ok@otherhost2 @@ -334,6 +339,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:250:QUIT:250' wrote callout cache domain record for otherhost3: result=1 postmaster=0 random=1 LOG: MAIN @@ -386,6 +392,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:250:QUIT:250' wrote callout cache domain record for otherhost4: result=1 postmaster=0 random=1 LOG: MAIN @@ -451,6 +458,7 @@ Cutthrough cancelled by presence of postmaster verify SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:550:RSET:250:MAIL|:RCPT:250:250:RSET:250:MAIL|:RCPT:250:250:QUIT:250' wrote callout cache domain record for otherhost41: result=1 postmaster=1 random=2 wrote positive callout cache address record for ok@otherhost41 @@ -510,6 +518,7 @@ Cutthrough cancelled by presence of postmaster verify SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:250:RSET:250:MAIL|:RCPT:250:250:QUIT:250' wrote callout cache domain record for otherhost21: result=1 postmaster=1 random=0 wrote positive callout cache address record for ok@otherhost21 @@ -544,6 +553,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:250:QUIT:250' wrote callout cache domain record for otherhost21: result=1 postmaster=1 random=0 wrote positive callout cache address record for ok2@otherhost21 @@ -583,6 +593,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:550:RSET:250:MAIL|:RCPT:250:250:QUIT:250' wrote callout cache domain record for otherhost31: result=1 postmaster=0 random=2 wrote positive callout cache address record for ok@otherhost31 @@ -617,6 +628,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:250:QUIT:250' wrote callout cache domain record for otherhost31: result=1 postmaster=0 random=2 wrote positive callout cache address record for okok@otherhost31 @@ -656,6 +668,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:550:RSET:250:MAIL|:RCPT:250:250:QUIT:250' wrote callout cache domain record for otherhost31: result=1 postmaster=0 random=2 wrote positive callout cache address record for okokok@otherhost31 @@ -688,6 +701,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP(Connection timed out)<< SMTP timeout SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250' wrote callout cache domain record for otherhost51: result=1 postmaster=0 random=0 LOG: MAIN REJECT @@ -731,6 +745,7 @@ Cutthrough cancelled by presence of postmaster verify SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:250:RSET:250:MAIL|:RCPT:250:250:QUIT:250' wrote callout cache domain record for otherhost52: result=1 postmaster=1 random=0 wrote positive callout cache address record for okokok@otherhost52 @@ -765,6 +780,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:250:QUIT:250' wrote callout cache domain record for x.y.z: result=1 postmaster=0 random=0 wrote positive callout cache address record for abcd@x.y.z/<somesender@a.domain> @@ -800,6 +816,7 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP(Connection timed out)<< SMTP timeout SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250' wrote callout cache domain record for x.y.z: result=1 postmaster=0 random=0 LOG: MAIN @@ -843,6 +860,7 @@ Cutthrough cancelled by presence of postmaster verify SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:250:RSET:250:MAIL|:RCPT:250:550:RCPT:250:QUIT:250' wrote callout cache domain record for otherhost9: result=1 postmaster=1 random=0 wrote positive callout cache address record for ok@otherhost9 @@ -889,6 +907,7 @@ Cutthrough cancelled by presence of postmaster verify SMTP>> QUIT SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:550:RSET:250:MAIL|:RCPT:250:250:RSET:250:MAIL|:RCPT:250:250:QUIT:250' wrote callout cache domain record for test.ex: result=1 postmaster=1 random=2 wrote positive callout cache address record for z@test.ex/<postmaster@myhost.test.ex> diff --git a/test/stderr/0623 b/test/stderr/0623 index 8abd7b075..b98d9285c 100644 --- a/test/stderr/0623 +++ b/test/stderr/0623 @@ -43,6 +43,7 @@ transport_check_waiting entered transport_check_waiting: FALSE will pipeline QUIT cannot use sendfile for body: spoolfile not wireformat + SMTP>> . writing data block fd=dddd size=sss timeout=300 (more expected) SMTP+> QUIT cmd buf flush ddd bytes (more expected) @@ -53,6 +54,7 @@ LOG: MAIN ok=0 send_quit=0 send_rset=1 continue_more=0 yield=0 first_address is NULL SMTP<< 221 Closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT|:DATA:250:250:300:.:QUIT:451:221' added retry item for T:127.0.0.1:127.0.0.1:1225:10HmaZ-0005vi-00: errno=-46 more_errno=dd,A flags=6 all IP addresses skipped or deferred at least one address Leaving send_to_server transport @@ -107,6 +109,7 @@ transport_check_waiting entered transport_check_waiting: FALSE will pipeline QUIT cannot use sendfile for body: spoolfile not wireformat + SMTP>> . writing data block fd=dddd size=sss timeout=300 (more expected) SMTP+> QUIT cmd buf flush ddd bytes (more expected) @@ -115,6 +118,7 @@ cmd buf flush ddd bytes (more expected) ok=0 send_quit=0 send_rset=1 continue_more=0 yield=0 first_address is NULL SMTP<< 221 Closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT|:DATA:250:250:300:.:QUIT:550:221' Leaving send_to_server transport LOG: MAIN ** permreject@test.ex R=client T=send_to_server H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after end of data: 550 content rejected @@ -171,6 +175,7 @@ transport_check_waiting entered transport_check_waiting: FALSE will pipeline QUIT cannot use sendfile for body: spoolfile not wireformat + SMTP>> . writing data block fd=dddd size=sss timeout=300 (more expected) SMTP+> QUIT cmd buf flush ddd bytes (more expected) @@ -181,6 +186,7 @@ LOG: MAIN ok=0 send_quit=0 send_rset=1 continue_more=0 yield=0 first_address is NULL SMTP(closed)<< SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT|:DATA:250:250:300:.:QUIT' added retry item for T:127.0.0.1:127.0.0.1:1225:10HmbB-0005vi-00: errno=-18 more_errno=dd,A flags=6 all IP addresses skipped or deferred at least one address Leaving send_to_server transport diff --git a/test/stderr/0911 b/test/stderr/0911 index 9ea7f1f25..2f78100f1 100644 --- a/test/stderr/0911 +++ b/test/stderr/0911 @@ -55,6 +55,7 @@ sync_responses expect rcpt for good@test.ex ok=1 send_quit=0 send_rset=0 continue_more=0 yield=0 first_address is NULL SMTP<< 221 Closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT|:BDAT:QUIT:250:250:250:221' Leaving send_to_server transport LOG: MAIN => good@test.ex R=client T=send_to_server H=127.0.0.1 [127.0.0.1] L K C="250 OK chunked message data" @@ -119,6 +120,7 @@ cmd buf flush ddd bytes (more expected) SMTP(shutdown)>> SMTP<< 221 Closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL:250:RCPT:250:BDAT:250:QUIT:221' Leaving send_to_server transport LOG: MAIN => nopipe@test.ex R=client T=send_to_server H=127.0.0.1 [127.0.0.1] K C="250 OK chunked message data" @@ -186,6 +188,7 @@ LOG: MAIN ok=0 send_quit=0 send_rset=1 continue_more=0 yield=0 first_address is NULL SMTP<< 221 Closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT|:BDAT:QUIT:250:250:451:221' added retry item for T:127.0.0.1:127.0.0.1:1225:10HmaZ-0005vi-00: errno=-46 more_errno=dd,A flags=6 all IP addresses skipped or deferred at least one address Leaving send_to_server transport @@ -253,6 +256,7 @@ sync_responses expect rcpt for permreject@test.ex ok=0 send_quit=0 send_rset=1 continue_more=0 yield=0 first_address is NULL SMTP<< 221 Closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT|:BDAT:QUIT:250:250:550:221' Leaving send_to_server transport LOG: MAIN ** permreject@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 end of data: 550 content rejected @@ -324,6 +328,7 @@ LOG: MAIN ok=0 send_quit=0 send_rset=1 continue_more=0 yield=0 first_address is NULL SMTP(closed)<< SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT|:BDAT:QUIT:250:250' added retry item for T:127.0.0.1:127.0.0.1:1225:10HmbB-0005vi-00: errno=-18 more_errno=dd,A flags=6 all IP addresses skipped or deferred at least one address Leaving send_to_server transport diff --git a/test/stderr/1150 b/test/stderr/1150 index 9ba4234e7..7c53000c2 100644 --- a/test/stderr/1150 +++ b/test/stderr/1150 @@ -25,10 +25,12 @@ Connecting to 127.0.0.1 [127.0.0.1]:1225 ... connected SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself SMTP>> writing message and terminating "." + SMTP>> . SMTP>> QUIT SMTP<< 250 OK id=10HmaZ-0005vi-00 SMTP<< 221 myhost.test.ex closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:STARTTLS:220:EHLO:250-:MAIL|:RCPT|:DATA:250:250:354:.:QUIT:250:221' LOG: MAIN => CALLER@test.ex R=client T=send_to_server1 H=127.0.0.1 [127.0.0.1] X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=yes C="250 OK id=10HmaZ-0005vi-00" LOG: MAIN @@ -60,10 +62,12 @@ Connecting to 127.0.0.1 [127.0.0.1]:1225 ... connected SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself SMTP>> writing message and terminating "." + SMTP>> . SMTP>> QUIT SMTP<< 250 OK id=10HmbA-0005vi-00 SMTP<< 221 myhost.test.ex closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:STARTTLS:220:EHLO:250-:MAIL|:RCPT|:RCPT|:DATA:250:250:250:354:.:QUIT:250:221' LOG: MAIN => CALLER@test.ex R=client T=send_to_server1 H=127.0.0.1 [127.0.0.1] X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=yes C="250 OK id=10HmbA-0005vi-00" LOG: MAIN @@ -92,10 +96,12 @@ Connecting to ip4.ip4.ip4.ip4 [ip4.ip4.ip4.ip4]:1225 ... connected SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself SMTP>> writing message and terminating "." + SMTP>> . SMTP>> QUIT SMTP<< 250 OK id=10HmbB-0005vi-00 SMTP<< 221 myhost.test.ex closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:STARTTLS:220:EHLO:250-:MAIL|:RCPT|:DATA:250:250:354:.:QUIT:250:221' LOG: MAIN => abcd@test.ex R=client T=send_to_server2 H=ip4.ip4.ip4.ip4 [ip4.ip4.ip4.ip4] X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=yes C="250 OK id=10HmbB-0005vi-00" LOG: MAIN diff --git a/test/stderr/1157 b/test/stderr/1157 index d5274fb8e..2eecddf91 100644 --- a/test/stderr/1157 +++ b/test/stderr/1157 @@ -34,6 +34,7 @@ cmd buf flush ddd bytes SMTP<< 250 OK SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself + SMTP>> . SMTP<< 250 OK id=10HmbA-0005vi-00 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=yes C="250 OK id=10HmbA-0005vi-00" @@ -52,8 +53,10 @@ cmd buf flush ddd bytes SMTP<< 250 OK SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself + SMTP>> . SMTP<< 250 OK id=10HmbB-0005vi-00 SMTP(close)>> +cmdlog: 'MAIL|:RCPT|:DATA:250:250:354:.:250' 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" LOG: MAIN @@ -71,6 +74,7 @@ cmd buf flush ddd bytes SMTP<< 250 OK SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself + SMTP>> . SMTP+> QUIT cmd buf flush ddd bytes (more expected) SMTP(shutdown)>> @@ -78,6 +82,7 @@ cmd buf flush ddd bytes (more expected) SMTP<< 250 OK id=10HmbC-0005vi-00 SMTP<< 221 myhost.test.ex closing connection SMTP(close)>> +cmdlog: 'MAIL|:RCPT|:DATA:250:250:354:.:QUIT:250:221' 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" LOG: MAIN @@ -123,6 +128,7 @@ cmd buf flush ddd bytes SMTP<< 250 OK SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself + SMTP>> . SMTP<< 250 OK id=10HmbG-0005vi-00 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=yes C="250 OK id=10HmbG-0005vi-00" @@ -141,8 +147,10 @@ cmd buf flush ddd bytes SMTP<< 250 OK SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself + SMTP>> . SMTP<< 250 OK id=10HmbH-0005vi-00 SMTP(close)>> +cmdlog: 'MAIL|:RCPT|:DATA:250:250:354:.:250' 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" LOG: MAIN @@ -160,6 +168,7 @@ cmd buf flush ddd bytes SMTP<< 250 OK SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself + SMTP>> . SMTP+> QUIT cmd buf flush ddd bytes (more expected) SMTP(shutdown)>> @@ -167,6 +176,7 @@ cmd buf flush ddd bytes (more expected) SMTP<< 250 OK id=10HmbI-0005vi-00 SMTP<< 221 myhost.test.ex closing connection SMTP(close)>> +cmdlog: 'MAIL|:RCPT|:DATA:250:250:354:.:QUIT:250:221' 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" LOG: MAIN @@ -212,6 +222,7 @@ cmd buf flush ddd bytes SMTP<< 250 OK SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself + SMTP>> . SMTP<< 250 OK id=10HmbM-0005vi-00 SMTP>> EHLO myhost.test.ex cmd buf flush ddd bytes @@ -222,6 +233,7 @@ cmd buf flush ddd bytes 250-STARTTLS 250 HELP SMTP(close)>> +cmdlog: '220:EHLO:250-:STARTTLS:220:EHLO:250-:MAIL|:RCPT|:DATA:250:250:354:.:250:EHLO:250-' LOG: MAIN => user_p@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=yes C="250 OK id=10HmbM-0005vi-00" LOG: MAIN @@ -249,6 +261,7 @@ cmd buf flush ddd bytes SMTP<< 250 OK SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself + SMTP>> . SMTP<< 250 OK id=10HmbN-0005vi-00 SMTP>> EHLO myhost.test.ex cmd buf flush ddd bytes @@ -259,6 +272,7 @@ cmd buf flush ddd bytes 250-STARTTLS 250 HELP SMTP(close)>> +cmdlog: 'STARTTLS:220:EHLO:250-:MAIL|:RCPT|:DATA:250:250:354:.:250:EHLO:250-' LOG: MAIN => user_r@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=yes C="250 OK id=10HmbN-0005vi-00" LOG: MAIN @@ -286,11 +300,13 @@ cmd buf flush ddd bytes SMTP<< 250 OK SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself + SMTP>> . SMTP>> QUIT cmd buf flush ddd bytes SMTP<< 250 OK id=10HmbO-0005vi-00 SMTP<< 221 myhost.test.ex closing connection SMTP(close)>> +cmdlog: 'STARTTLS:220:EHLO:250-:MAIL|:RCPT|:DATA:250:250:354:.:QUIT:250:221' LOG: MAIN => user_q@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=yes C="250 OK id=10HmbO-0005vi-00" LOG: MAIN diff --git a/test/stderr/1160 b/test/stderr/1160 index cdbad3614..a4fabf385 100644 --- a/test/stderr/1160 +++ b/test/stderr/1160 @@ -16,10 +16,12 @@ Connecting to 127.0.0.1 [127.0.0.1]:1225 ... connected SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself SMTP>> writing message and terminating "." + SMTP>> . SMTP>> QUIT SMTP<< 250 OK id=10HmaZ-0005vi-00 SMTP<< 221 myhost.test.ex closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT|:DATA:250:250:354:.:QUIT:250:221' LOG: MAIN => CALLER@test.ex R=client T=send_to_server1 H=127.0.0.1 [127.0.0.1] X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=yes C="250 OK id=10HmaZ-0005vi-00" LOG: MAIN @@ -42,10 +44,12 @@ Connecting to 127.0.0.1 [127.0.0.1]:1225 ... connected SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself SMTP>> writing message and terminating "." + SMTP>> . SMTP>> QUIT SMTP<< 250 OK id=10HmbA-0005vi-00 SMTP<< 221 myhost.test.ex closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT|:RCPT|:DATA:250:250:250:354:.:QUIT:250:221' LOG: MAIN => CALLER@test.ex R=client T=send_to_server1 H=127.0.0.1 [127.0.0.1] X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=yes C="250 OK id=10HmbA-0005vi-00" LOG: MAIN @@ -65,10 +69,12 @@ Connecting to ip4.ip4.ip4.ip4 [ip4.ip4.ip4.ip4]:1225 ... connected SMTP<< 250 Accepted SMTP<< 354 Enter message, ending with "." on a line by itself SMTP>> writing message and terminating "." + SMTP>> . SMTP>> QUIT SMTP<< 250 OK id=10HmbB-0005vi-00 SMTP<< 221 myhost.test.ex closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT|:DATA:250:250:354:.:QUIT:250:221' LOG: MAIN => abcd@test.ex R=client T=send_to_server2 H=ip4.ip4.ip4.ip4 [ip4.ip4.ip4.ip4] X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=yes C="250 OK id=10HmbB-0005vi-00" LOG: MAIN diff --git a/test/stderr/2035 b/test/stderr/2035 index c15645ce0..308b3358d 100644 --- a/test/stderr/2035 +++ b/test/stderr/2035 @@ -59,6 +59,7 @@ sync_responses expect data SMTP<< 354 Enter message, ending with "." on a line by itself SMTP>> writing message and terminating "." cannot use sendfile for body: spoolfile not wireformat + SMTP>> . writing data block fd=dddd size=sss timeout=300 SMTP<< 250 OK id=10HmaY-0005vi-00 ok=1 send_quit=1 send_rset=0 continue_more=0 yield=0 first_address is NULL @@ -68,6 +69,7 @@ cmd buf flush ddd bytes (more expected) SMTP(TLS shutdown)>> SMTP<< 221 myhost.test.ex closing connection SMTP(close)>> +cmdlog: 'DATA:354:.:250:QUIT:221' Leaving t1 transport LOG: MAIN => userb@test.ex R=client T=t1 H=127.0.0.1 [127.0.0.1]:1225 X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=no C="250 OK id=10HmaY-0005vi-00" diff --git a/test/stderr/2135 b/test/stderr/2135 index c15645ce0..308b3358d 100644 --- a/test/stderr/2135 +++ b/test/stderr/2135 @@ -59,6 +59,7 @@ sync_responses expect data SMTP<< 354 Enter message, ending with "." on a line by itself SMTP>> writing message and terminating "." cannot use sendfile for body: spoolfile not wireformat + SMTP>> . writing data block fd=dddd size=sss timeout=300 SMTP<< 250 OK id=10HmaY-0005vi-00 ok=1 send_quit=1 send_rset=0 continue_more=0 yield=0 first_address is NULL @@ -68,6 +69,7 @@ cmd buf flush ddd bytes (more expected) SMTP(TLS shutdown)>> SMTP<< 221 myhost.test.ex closing connection SMTP(close)>> +cmdlog: 'DATA:354:.:250:QUIT:221' Leaving t1 transport LOG: MAIN => userb@test.ex R=client T=t1 H=127.0.0.1 [127.0.0.1]:1225 X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=no C="250 OK id=10HmaY-0005vi-00" diff --git a/test/stderr/3404 b/test/stderr/3404 index ea3f7e0a9..17af167bc 100644 --- a/test/stderr/3404 +++ b/test/stderr/3404 @@ -16,11 +16,13 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> DATA SMTP<< 354 Send data SMTP>> writing message and terminating "." + SMTP>> . SMTP<< 250 OK SMTP+> QUIT SMTP(shutdown)>> SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:AUTH:235:MAIL:250:RCPT:250:DATA:354:.:250:QUIT:250' LOG: MAIN => userx@domain.com R=all T=smtp H=127.0.0.1 [127.0.0.1] A=plain C="250 OK" LOG: MAIN @@ -43,11 +45,13 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> DATA SMTP<< 354 Send data SMTP>> writing message and terminating "." + SMTP>> . SMTP<< 250 OK SMTP+> QUIT SMTP(shutdown)>> SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:AUTH:235:MAIL:250:RCPT:250:DATA:354:.:250:QUIT:250' LOG: MAIN => userx@domain.com R=all T=smtp H=127.0.0.1 [127.0.0.1] A=plain C="250 OK" LOG: MAIN @@ -74,11 +78,13 @@ Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected SMTP>> DATA SMTP<< 354 Send data SMTP>> writing message and terminating "." + SMTP>> . SMTP<< 250 OK SMTP+> QUIT SMTP(shutdown)>> SMTP<< 250 OK SMTP(close)>> +cmdlog: '220:EHLO:250-:AUTH:300:********:300:********:235:MAIL:250:RCPT:250:DATA:354:.:250:QUIT:250' LOG: MAIN => userx@domain.com R=all T=smtp H=127.0.0.1 [127.0.0.1] A=login C="250 OK" LOG: MAIN diff --git a/test/stderr/4510 b/test/stderr/4510 index cfdbe6e29..f6a04869f 100644 --- a/test/stderr/4510 +++ b/test/stderr/4510 @@ -47,12 +47,14 @@ DKIM-Signature:{SP}v=1;{SP}a=rsa-sha256;{SP}q=dns/txt;{SP}c=relaxed/relaxed;{SP} DKIM >> Signed DKIM-Signature header, canonicalized (relaxed) >>>>>>> dkim-signature:v=1;{SP}a=rsa-sha256;{SP}q=dns/txt;{SP}c=relaxed/relaxed;{SP}d=test.ex;{SP}s=sel_bad;{SP}h=From;{SP}bh=/Ab0giHZitYQbDhFszoqQRUkgqueaX9zatJttIU/plc=;{SP}b=; DKIM [test.ex] Header sha256 computed: 241e16230df5723d899cfae9474c6b376a2ab1f81d1094e358f50ffd0e0067b3 + SMTP>> . SMTP+> QUIT cmd buf flush ddd bytes (more expected) SMTP(shutdown)>> SMTP<< 250 OK id=10HmbL-0005vi-00 SMTP<< 221 myhost.test.ex closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT|:DATA:250:250:354:.:QUIT:250:221' LOG: MAIN => d@test.ex R=client T=send_to_server H=ip4.ip4.ip4.ip4 [ip4.ip4.ip4.ip4] C="250 OK id=10HmbL-0005vi-00" LOG: MAIN diff --git a/test/stderr/4530 b/test/stderr/4530 index 4b93222f0..62a7b7bb0 100644 --- a/test/stderr/4530 +++ b/test/stderr/4530 @@ -58,11 +58,13 @@ DKIM-Signature:{SP}v=1;{SP}a=rsa-sha256;{SP}q=dns/txt;{SP}c=relaxed/relaxed;{SP} DKIM >> Signed DKIM-Signature header, canonicalized (relaxed) >>>>>>> dkim-signature:v=1;{SP}a=rsa-sha256;{SP}q=dns/txt;{SP}c=relaxed/relaxed;{SP}d=test.ex;{SP}s=sel_bad;{SP}h=From;{SP}bh=/Ab0giHZitYQbDhFszoqQRUkgqueaX9zatJttIU/plc=;{SP}b=; DKIM [test.ex] Header sha256 computed: 241e16230df5723d899cfae9474c6b376a2ab1f81d1094e358f50ffd0e0067b3 + SMTP>> . SMTP>> QUIT cmd buf flush ddd bytes SMTP<< 250 OK id=10HmbL-0005vi-00 SMTP<< 221 myhost.test.ex closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:STARTTLS:220:EHLO:250-:MAIL|:RCPT|:DATA:250:250:354:.:QUIT:250:221' LOG: MAIN => d@test.ex R=client T=send_to_server H=ip4.ip4.ip4.ip4 [ip4.ip4.ip4.ip4] X=TLS1.x:ke-RSA-AES256-SHAnnn:xxx CV=yes C="250 OK id=10HmbL-0005vi-00" LOG: MAIN diff --git a/test/stderr/5403 b/test/stderr/5403 index e7c605a01..17296572a 100644 --- a/test/stderr/5403 +++ b/test/stderr/5403 @@ -91,5 +91,6 @@ MUNGED: ::1 will be omitted in what follows >>> SMTP>> QUIT >>> SMTP<< 220 OK >>> SMTP(close)>> +>>> cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:QUIT:220' >>> ----------- cutthrough shutdown (host-checking mode) ------------ LOG: 10HmaY-0005vi-00 <= sender@myhost.test.ex H=(myhost.test.ex) [1.2.3.4] P=esmtp S=sss for verify@domain.com diff --git a/test/stderr/5410 b/test/stderr/5410 index 99a829e2b..8599c878a 100644 --- a/test/stderr/5410 +++ b/test/stderr/5410 @@ -513,6 +513,7 @@ LOG: MAIN SMTP>> QUIT SMTP<< 221 myhost.test.ex closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:STARTTLS:220:EHLO:250-:MAIL|:RCPT:250:250:DATA:354:250:QUIT:221' ----------- cutthrough shutdown (delivered) ------------ LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local-esmtp S=sss @@ -997,6 +998,7 @@ LOG: MAIN SMTP>> QUIT SMTP<< 221 myhost.test.ex closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:250:DATA:354:250:QUIT:221' ----------- cutthrough shutdown (delivered) ------------ LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local-esmtp S=sss @@ -1481,6 +1483,7 @@ LOG: MAIN SMTP>> QUIT SMTP<< 221 myhost.test.ex closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:250:DATA:354:250:QUIT:221' ----------- cutthrough shutdown (delivered) ------------ LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local-esmtp S=sss diff --git a/test/stderr/5420 b/test/stderr/5420 index ff97dbbc7..384a11736 100644 --- a/test/stderr/5420 +++ b/test/stderr/5420 @@ -514,6 +514,7 @@ LOG: MAIN SMTP>> QUIT SMTP<< 221 myhost.test.ex closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:STARTTLS:220:EHLO:250-:MAIL|:RCPT:250:250:DATA:354:250:QUIT:221' ----------- cutthrough shutdown (delivered) ------------ LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local-esmtp S=sss @@ -998,6 +999,7 @@ LOG: MAIN SMTP>> QUIT SMTP<< 221 myhost.test.ex closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:250:DATA:354:250:QUIT:221' ----------- cutthrough shutdown (delivered) ------------ LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local-esmtp S=sss @@ -1482,6 +1484,7 @@ LOG: MAIN SMTP>> QUIT SMTP<< 221 myhost.test.ex closing connection SMTP(close)>> +cmdlog: '220:EHLO:250-:MAIL|:RCPT:250:250:DATA:354:250:QUIT:221' ----------- cutthrough shutdown (delivered) ------------ LOG: MAIN <= CALLER@myhost.test.ex U=CALLER P=local-esmtp S=sss diff --git a/test/stderr/5820 b/test/stderr/5820 index f5dbbfa2a..53291edf4 100644 --- a/test/stderr/5820 +++ b/test/stderr/5820 @@ -57,6 +57,7 @@ >>> cmd buf flush 6 bytes >>> SMTP<< 221 myhost.test.ex closing connection >>> SMTP(close)>> +>>> cmdlog: '220:EHLO:250-:STARTTLS:220:EHLO:250-:MAIL|:RCPT:250:250:QUIT:221' >>> wrote callout cache domain record for dane256ee.test.ex: >>> result=1 postmaster=0 random=0 >>> wrote positive callout cache address record for rcptuser@dane256ee.test.ex diff --git a/test/stderr/5840 b/test/stderr/5840 index 633d7c693..93a7bfd2c 100644 --- a/test/stderr/5840 +++ b/test/stderr/5840 @@ -57,6 +57,7 @@ >>> cmd buf flush 6 bytes >>> SMTP<< 221 myhost.test.ex closing connection >>> SMTP(close)>> +>>> cmdlog: '220:EHLO:250-:STARTTLS:220:EHLO:250-:MAIL|:RCPT:250:250:QUIT:221' >>> wrote callout cache domain record for dane256ee.test.ex: >>> result=1 postmaster=0 random=0 >>> wrote positive callout cache address record for rcptuser@dane256ee.test.ex |