Log: more info in ACL "warn statement skipped" message. Bug 2897
[exim.git] / test / stderr / 0278
index c5b9261863ae8f9f27efd345723fa7d83a9249fd..fd94ee0c007bbd621df606920ccf39633c39fd29 100644 (file)
@@ -1,4 +1,5 @@
 Exim version x.yz ....
+Hints DB:
 changed uid/gid: forcing real = effective
   uid=uuuu gid=CALLER_GID pid=p1234
 configuration file is TESTSUITE/test-config
@@ -18,7 +19,7 @@ routing CALLER@test.ex
 --------> r1 router <--------
 local_part=CALLER domain=test.ex
 checking local_parts
-CALLER in "+never_localparts : +n1_localparts : ! +local_localparts"?
+CALLER in local_parts?
  list element: +never_localparts
   start sublist never_localparts
    CALLER in "never"?
@@ -31,19 +32,19 @@ CALLER in "+never_localparts : +n1_localparts : ! +local_localparts"?
    ╎list element: never1
    CALLER in "never1"? no (end of list)
   end sublist n1_localparts
- list element: ! +local_localparts
+ list element: !+local_localparts
   start sublist local_localparts
    CALLER in "CALLER"?
    ╎list element: CALLER
    ╎CALLER in "CALLER"? yes (matched "CALLER")
   end sublist local_localparts
  data from lookup saved for cache for +local_localparts: key 'CALLER' value 'CALLER'
- CALLER in "+never_localparts : +n1_localparts : ! +local_localparts"? no (matched "! +local_localparts")
+ CALLER in local_parts? no (matched "! +local_localparts")
 r1 router skipped: local_parts mismatch
 --------> r2 router <--------
 local_part=CALLER domain=test.ex
 checking local_parts
-CALLER in "+never_localparts : +n2_localparts : !+local_localparts"?
+CALLER in local_parts?
  list element: +never_localparts
   start sublist never_localparts
  cached no match for +never_localparts
@@ -62,17 +63,17 @@ CALLER in "+never_localparts : +n2_localparts : !+local_localparts"?
   start sublist local_localparts
  cached yes match for +local_localparts
  cached lookup data = CALLER
- CALLER in "+never_localparts : +n2_localparts : !+local_localparts"? no (matched "!+local_localparts" - cached)
+ CALLER in local_parts? no (matched "!+local_localparts" - cached)
 r2 router skipped: local_parts mismatch
 --------> r3 router <--------
 local_part=CALLER domain=test.ex
 checking local_parts
-CALLER in "+local_localparts"?
+CALLER in local_parts?
  list element: +local_localparts
   start sublist local_localparts
  cached yes match for +local_localparts
  cached lookup data = CALLER
- CALLER in "+local_localparts"? yes (matched "+local_localparts" - cached)
+ CALLER in local_parts? yes (matched "+local_localparts" - cached)
 checking for local user
 seeking password data for user "CALLER": using cached result
 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
@@ -90,6 +91,7 @@ routed by r3 router
 search_tidyup called
 >>>>>>>>>>>>>>>> Exim pid=p1234 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 Exim version x.yz ....
+Hints DB:
 changed uid/gid: forcing real = effective
   uid=uuuu gid=CALLER_GID pid=p1235
 configuration file is TESTSUITE/test-config
@@ -110,15 +112,15 @@ search_tidyup called
 >>Headers received:
 
 qualify & rewrite recipients list
-global rewrite rules
-rewrite headers
+rewrite rules on sender address
+qualify and rewrite headers
  rewrite_one_header: type=F:
    From: CALLER_NAME <CALLER@test.ex>
 search_tidyup called
 >>Headers after rewriting and local additions:
-I Message-Id: <E10HmaX-000000005vi-0000@myhost.test.ex>
-F From: CALLER_NAME <CALLER@test.ex>
-  Date: Tue, 2 Mar 1999 09:44:33 +0000
+ I Message-Id: <E10HmaX-000000005vi-0000@myhost.test.ex>
+ F From: CALLER_NAME <CALLER@test.ex>
+   Date: Tue, 2 Mar 1999 09:44:33 +0000
 
 Data file name: TESTSUITE/spool//input//10HmaX-000000005vi-0000-D
 Data file written for message 10HmaX-000000005vi-0000
@@ -138,6 +140,7 @@ created log directory TESTSUITE/spool/log
 search_tidyup called
 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmaX-000000005vi-0000
 Exim version x.yz ....
+Hints DB:
 changed uid/gid: forcing real = effective
   uid=uuuu gid=EXIM_GID pid=p1236
 configuration file is TESTSUITE/test-config
@@ -161,24 +164,20 @@ body_linecount=0 message_linecount=8
 DSN: set orcpt:   flags: 0x0
 Delivery address list:
   CALLER@test.ex 
- locking TESTSUITE/spool/db/retry.lockfile
- locked  TESTSUITE/spool/db/retry.lockfile
- EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
- returned from EXIM_DBOPEN: (nil)
- failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
 no retry data available
 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 Considering: CALLER@test.ex
 unique = CALLER@test.ex
-no   domain  retry record
-no   address retry record
+checking router retry status
+ no   domain  retry record
+ no   address retry record
 CALLER@test.ex: queued for routing
 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 routing CALLER@test.ex
 --------> r1 router <--------
 local_part=CALLER domain=test.ex
 checking local_parts
-CALLER in "+never_localparts : +n1_localparts : ! +local_localparts"?
+CALLER in local_parts?
  list element: +never_localparts
   start sublist never_localparts
    CALLER in "never"?
@@ -191,19 +190,19 @@ CALLER in "+never_localparts : +n1_localparts : ! +local_localparts"?
    ╎list element: never1
    CALLER in "never1"? no (end of list)
   end sublist n1_localparts
- list element: ! +local_localparts
+ list element: !+local_localparts
   start sublist local_localparts
    CALLER in "CALLER"?
    ╎list element: CALLER
    ╎CALLER in "CALLER"? yes (matched "CALLER")
   end sublist local_localparts
  data from lookup saved for cache for +local_localparts: key 'CALLER' value 'CALLER'
- CALLER in "+never_localparts : +n1_localparts : ! +local_localparts"? no (matched "! +local_localparts")
+ CALLER in local_parts? no (matched "! +local_localparts")
 r1 router skipped: local_parts mismatch
 --------> r2 router <--------
 local_part=CALLER domain=test.ex
 checking local_parts
-CALLER in "+never_localparts : +n2_localparts : !+local_localparts"?
+CALLER in local_parts?
  list element: +never_localparts
   start sublist never_localparts
  cached no match for +never_localparts
@@ -222,17 +221,17 @@ CALLER in "+never_localparts : +n2_localparts : !+local_localparts"?
   start sublist local_localparts
  cached yes match for +local_localparts
  cached lookup data = CALLER
- CALLER in "+never_localparts : +n2_localparts : !+local_localparts"? no (matched "!+local_localparts" - cached)
+ CALLER in local_parts? no (matched "!+local_localparts" - cached)
 r2 router skipped: local_parts mismatch
 --------> r3 router <--------
 local_part=CALLER domain=test.ex
 checking local_parts
-CALLER in "+local_localparts"?
+CALLER in local_parts?
  list element: +local_localparts
   start sublist local_localparts
  cached yes match for +local_localparts
  cached lookup data = CALLER
- CALLER in "+local_localparts"? yes (matched "+local_localparts" - cached)
+ CALLER in local_parts? yes (matched "+local_localparts" - cached)
 checking for local user
 seeking password data for user "CALLER": using cached result
 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
@@ -257,11 +256,6 @@ After routing:
 search_tidyup called
 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
 --------> CALLER@test.ex <--------
- locking TESTSUITE/spool/db/retry.lockfile
- locked  TESTSUITE/spool/db/retry.lockfile
- EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
- returned from EXIM_DBOPEN: (nil)
- failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
 no retry data available
 search_tidyup called
 changed uid/gid: local delivery to CALLER <CALLER@test.ex> transport=t1
@@ -276,6 +270,7 @@ appendfile: mode=600 notify_comsat=0 quota=0 warning=0
   maildir_use_size_file=no
   locking by lockfile fcntl 
 search_tidyup called
+>>>>>>>>>>>>>>>> Exim pid=p1237 (delivery-local) terminating with rc=0 >>>>>>>>>>>>>>>>
 journalling CALLER@test.ex
 t1 transport returned OK for CALLER@test.ex
 post-process CALLER@test.ex (0)
@@ -287,10 +282,10 @@ changed uid/gid: post-delivery tidying
   uid=EXIM_UID gid=EXIM_GID pid=p1236
 set_process_info: pppp tidying up after delivering 10HmaX-000000005vi-0000
 Processing retry items
-Succeeded addresses:
- CALLER@test.ex: no retry items
-Failed addresses:
-Deferred addresses:
+ Succeeded addresses:
 CALLER@test.ex: no retry items
+ Failed addresses:
+ Deferred addresses:
 end of retry processing
 DSN: processing router : r3
 DSN: processing successful delivery address: CALLER@test.ex
@@ -309,6 +304,7 @@ search_tidyup called
 search_tidyup called
 >>>>>>>>>>>>>>>> Exim pid=p1235 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 Exim version x.yz ....
+Hints DB:
 changed uid/gid: forcing real = effective
   uid=uuuu gid=CALLER_GID pid=p1238
 configuration file is TESTSUITE/test-config
@@ -328,7 +324,7 @@ routing unknown@test.ex
 --------> r1 router <--------
 local_part=unknown domain=test.ex
 checking local_parts
-unknown in "+never_localparts : +n1_localparts : ! +local_localparts"?
+unknown in local_parts?
  list element: +never_localparts
   start sublist never_localparts
    unknown in "never"?
@@ -341,13 +337,13 @@ unknown in "+never_localparts : +n1_localparts : ! +local_localparts"?
    ╎list element: never1
    unknown in "never1"? no (end of list)
   end sublist n1_localparts
- list element: ! +local_localparts
+ list element: !+local_localparts
   start sublist local_localparts
    unknown in "CALLER"?
    ╎list element: CALLER
    unknown in "CALLER"? no (end of list)
   end sublist local_localparts
-unknown in "+never_localparts : +n1_localparts : ! +local_localparts"? yes (end of list)
+unknown in local_parts? yes (end of list)
 calling r1 router
 r1 router called for unknown@test.ex
   domain = test.ex
@@ -359,7 +355,7 @@ r1 router declined for unknown@test.ex
 --------> r2 router <--------
 local_part=unknown domain=test.ex
 checking local_parts
-unknown in "+never_localparts : +n2_localparts : !+local_localparts"?
+unknown in local_parts?
  list element: +never_localparts
   start sublist never_localparts
  cached no match for +never_localparts
@@ -378,39 +374,43 @@ unknown in "+never_localparts : +n2_localparts : !+local_localparts"?
   start sublist local_localparts
  cached no match for +local_localparts
  cached lookup data = NULL
-unknown in "+never_localparts : +n2_localparts : !+local_localparts"? yes (end of list)
+unknown in local_parts? yes (end of list)
 calling r2 router
 r2 router called for unknown@test.ex
   domain = test.ex
-test.ex in "*"?
- list element: *
- test.ex in "*"? yes (matched "*")
-DNS lookup of test.ex (MX) using fakens
-DNS lookup of test.ex (MX) gave NO_DATA
-returning DNS_NODATA
-faking res_search(MX) response length as 65535
- writing neg-cache entry for test.ex-MX-xxxx, ttl 3000
-test.ex (MX resp) DNSSEC
-DNS lookup of test.ex (A) using fakens
-DNS lookup of test.ex (A) gave NO_DATA
-returning DNS_NODATA
-faking res_search(A) response length as 65535
- writing neg-cache entry for test.ex-A-xxxx, ttl 3000
+main lookup for domain
+ check dnssec require list
+  test.ex in dnssec_require_domains? no (option unset)
+ check dnssec request list
+  test.ex in dnssec_request_domains?
+   list element: *
+   test.ex in dnssec_request_domains? yes (matched "*")
+ DNS lookup of test.ex (MX) using fakens
+ DNS lookup of test.ex (MX) gave NO_DATA
+ returning DNS_NODATA
+ faking res_search(MX) response length as 65535
+  writing neg-cache entry for test.ex-MX-xxxx, ttl 3000
+ test.ex (MX resp) DNSSEC
+ DNS lookup of test.ex (A) using fakens
+ DNS lookup of test.ex (A) gave NO_DATA
+ returning DNS_NODATA
+ faking res_search(A) response length as 65535
+  writing neg-cache entry for test.ex-A-xxxx, ttl 3000
 r2 router declined for unknown@test.ex
 --------> r3 router <--------
 local_part=unknown domain=test.ex
 checking local_parts
-unknown in "+local_localparts"?
+unknown in local_parts?
  list element: +local_localparts
   start sublist local_localparts
  cached no match for +local_localparts
  cached lookup data = NULL
-unknown in "+local_localparts"? no (end of list)
+unknown in local_parts? no (end of list)
 r3 router skipped: local_parts mismatch
 --------> r4 router <--------
 local_part=unknown domain=test.ex
 checking local_parts
-unknown in "+local_localparts : +expanded : +unexpanded"?
+unknown in local_parts?
  list element: +local_localparts
   start sublist local_localparts
  cached no match for +local_localparts
@@ -427,12 +427,12 @@ unknown in "+local_localparts : +expanded : +unexpanded"?
    ╎list element: unexpanded
    unknown in "unexpanded"? no (end of list)
   end sublist unexpanded
-unknown in "+local_localparts : +expanded : +unexpanded"? no (end of list)
+unknown in local_parts? no (end of list)
 r4 router skipped: local_parts mismatch
 --------> r5 router <--------
 local_part=unknown domain=test.ex
 checking local_parts
-unknown in "+local_localparts : +expanded : +unexpanded"?
+unknown in local_parts?
  list element: +local_localparts
   start sublist local_localparts
  cached no match for +local_localparts
@@ -447,7 +447,7 @@ unknown in "+local_localparts : +expanded : +unexpanded"?
   start sublist unexpanded
  cached no match for +unexpanded
  cached lookup data = NULL
-unknown in "+local_localparts : +expanded : +unexpanded"? no (end of list)
+unknown in local_parts? no (end of list)
 r5 router skipped: local_parts mismatch
 no more routers
 search_tidyup called