05:45:11 22430 Exim version 4.92 uid=0 gid=0 pid=22430 D=fff9ffff
Support for: crypteq iconv() IPv6 PAM Perl Expand_dlfunc GnuTLS move_frozen_messages Content_Scanning DANE DKIM DNSSEC Event OCSP PRDR PROXY SOCKS TCP_Fast_Open
Lookups (built-in): lsearch wildlsearch nwildlsearch iplsearch cdb dbm dbmjz dbmnz dnsdb dsearch ldap ldapdn ldapm mysql nis nis0 passwd pgsql sqlite
Authenticators: cram_md5 cyrus_sasl dovecot plaintext spa tls
Routers: accept dnslookup ipliteral iplookup manualroute queryprogram redirect
Transports: appendfile/maildir/mailstore/mbx autoreply lmtp pipe smtp
Malware: f-protd f-prot6d drweb fsecure sophie clamd avast sock cmdline
Fixed never_users: 0
Configure owner: 0:0
Size of off_t: 8
Compiler: GCC [8.2.0]
Library version: Glibc: Compile: 2.28
                        Runtime: 2.28
Library version: BDB: Compile: Berkeley DB 5.3.28: (September  9, 2013)
                      Runtime: Berkeley DB 5.3.28: (September  9, 2013)
Library version: GnuTLS: Compile: 3.6.6
                         Runtime: 3.6.6
Library version: Cyrus SASL: Compile: 2.1.27
                             Runtime: 2.1.27 [Cyrus SASL]
Library version: PCRE: Compile: 8.39
                       Runtime: 8.39 2016-06-14
05:45:11 22430 Total 19 lookups
Library version: MySQL: Compile: 100312 10.3.12 [mariadb-10.3]
                        Runtime: 100313 10.3.13
Library version: SQLite: Compile: 3.27.1
                         Runtime: 3.27.2
WHITELIST_D_MACROS: "OUTGOING"
TRUSTED_CONFIG_LIST: "/etc/exim4/trusted_configs"
05:45:11 22430 changed uid/gid: forcing real = effective
05:45:11 22430   uid=0 gid=0 pid=22430
05:45:11 22430   auxiliary group list: <none>
05:45:11 22430 seeking password data for user "uucp": cache not available
05:45:11 22430 getpwnam() succeeded uid=10 gid=10
05:45:11 22430 configuration file is /var/lib/exim4/config.autogenerated
05:45:11 22430 log selectors = 0000cffc c6401022 00000001
05:45:11 22430 cwd=/root 7 args: /usr/sbin/exim4 -bd -d+all -C /var/lib/exim4/config.autogenerated -bd -d+all
05:45:11 22430 trusted user
05:45:11 22430 admin user
05:45:11 22430 seeking password data for user "mail": cache not available
05:45:11 22430 getpwnam() succeeded uid=8 gid=8
05:45:11 22430  ┌considering: $1
05:45:11 22430  ├──expanding: $1
05:45:11 22430  └─────result: root
05:45:11 22430 user name "root" extracted from gecos field "root"
05:45:11 22430 originator: uid=0 gid=0 login=root name=root
05:45:11 22430 listening on all interfaces (IPv4) port 25
05:45:11 22430 listening on ::1 port 25
05:45:11 22430 pid written to /run/exim4/exim.pid
05:45:11 22430 changed uid/gid: running as a daemon
05:45:11 22430   uid=107 gid=112 pid=22430
05:45:11 22430   auxiliary group list: 112
05:45:11 22430 LOG: MAIN
05:45:11 22430   exim 4.92 daemon started: pid=22430, no queue runs, listening for SMTP on port 25 (IPv4) [::1]:25
05:45:11 22430 set_process_info: 22430 daemon(4.92): no queue runs, listening for SMTP on port 25 (IPv4) [::1]:25
05:45:11 22430 daemon running with uid=107 gid=112 euid=107 egid=112
05:45:11 22430 Listening...
05:45:18 22430 Connection request from 136.243.149.87 port 60966
05:45:18 22430 interface address=95.216.35.87 port=25
05:45:18 22430 search_tidyup called
05:45:18 22430 1 SMTP accept process running
05:45:18 22430 Listening...
05:45:18 22431 sender_fullhost = [136.243.149.87]
05:45:18 22431 sender_rcvhost = [136.243.149.87]
05:45:18 22431 Process 22431 is handling incoming connection from [136.243.149.87]
05:45:18 22431 host in host_lookup? yes (matched "*")
05:45:18 22431 looking up host name for 136.243.149.87
05:45:18 22431 Coerced resolver DNSSEC support on.
05:45:18 22431 DNS lookup of 87.149.243.136.in-addr.arpa (PTR) succeeded
05:45:18 22431 Reverse DNS security status: unverified
05:45:18 22431 IP address lookup yielded "amorp.openlib.org"
05:45:18 22431 Coerced resolver DNSSEC support on.
05:45:18 22431 DNS lookup of amorp.openlib.org (AAAA) succeeded
05:45:18 22431 DNS lookup of amorp.openlib.org (A) succeeded
05:45:18 22431 Actual local interface address is 127.0.0.1 (lo)
05:45:18 22431 Actual local interface address is 95.216.35.87 (enp0s31f6)
05:45:18 22431 Actual local interface address is 2a01:4f9:2a:23a8::2 (enp0s31f6)
05:45:18 22431 Actual local interface address is ::1 (lo)
05:45:18 22431 Actual local interface address is fe80::921b:eff:fefb:a95c (enp0s31f6)
05:45:18 22431 Configured local interface: address=::1
05:45:18 22431 amorp.openlib.org 2a01:4f8:171:17d6::2 mx=-1 sort=-797 
05:45:18 22431 amorp.openlib.org 136.243.149.87 mx=-1 sort=-24 
05:45:18 22431 Coerced resolver DNSSEC support on.
05:45:18 22431 checking addresses for amorp.openlib.org
05:45:18 22431 Forward DNS security status: unverified
05:45:18 22431   2a01:4f8:171:17d6::2
05:45:18 22431   136.243.149.87 OK
05:45:18 22431 sender_fullhost = amorp.openlib.org [136.243.149.87]
05:45:18 22431 sender_rcvhost = amorp.openlib.org ([136.243.149.87])
05:45:18 22431 set_process_info: 22431 handling incoming connection from amorp.openlib.org [136.243.149.87]
05:45:18 22431 host in host_reject_connection? no (option unset)
05:45:18 22431 host in sender_unqualified_hosts? no (option unset)
05:45:18 22431 host in recipient_unqualified_hosts? no (option unset)
05:45:18 22431 host in helo_verify_hosts? no (option unset)
05:45:18 22431 host in helo_try_verify_hosts? no (option unset)
05:45:18 22431 host in helo_accept_junk_hosts? no (option unset)
05:45:18 22431 host in hosts_proxy? no (option unset)
05:45:18 22431  ┌considering: $smtp_active_hostname ESMTP Exim $version_number $tod_full
05:45:18 22431  ├──expanding: $smtp_active_hostname ESMTP Exim $version_number $tod_full
05:45:18 22431  └─────result: darni ESMTP Exim 4.92 Fri, 29 Mar 2019 05:45:18 +0000
05:45:18 22431 SMTP>> 220 darni ESMTP Exim 4.92 Fri, 29 Mar 2019 05:45:18 +0000
05:45:18 22431 Process 22431 is ready for new message
05:45:18 22431 smtp_setup_msg entered
05:45:18 22431 SMTP<< EHLO amorp.openlib.org
05:45:18 22431 sender_fullhost = amorp.openlib.org [136.243.149.87]
05:45:18 22431 sender_rcvhost = amorp.openlib.org ([136.243.149.87])
05:45:18 22431 set_process_info: 22431 handling incoming connection from amorp.openlib.org [136.243.149.87]
05:45:18 22431 host in dsn_advertise_hosts? no (option unset)
05:45:18 22431 host in pipelining_advertise_hosts? yes (matched "*")
05:45:18 22431 host in auth_advertise_hosts? yes (matched "*")
05:45:18 22431 host in chunking_advertise_hosts? yes (matched "*")
05:45:18 22431 host in tls_advertise_hosts? no (end of list)
05:45:18 22431 SMTP>> 250-darni Hello amorp.openlib.org [136.243.149.87]
05:45:18 22431 250-SIZE 52428800
05:45:18 22431 250-8BITMIME
05:45:18 22431 250-PIPELINING
05:45:18 22431 250-CHUNKING
05:45:18 22431 250-PRDR
05:45:18 22431 250 HELP
05:45:19 22431 SMTP<< MAIL FROM:<krichel@openlib.org> SIZE=1702
05:45:19 22431 spool directory space = 1524289700K inodes = 229582690 check_space = 10240K inodes = 100 msg_size = 6702
05:45:19 22431 log directory space = 1524289700K inodes = 229582690 check_space = 10240K inodes = 100
05:45:19 22431 using ACL "acl_check_mail"
05:45:19 22431 processing "accept"
05:45:19 22431 accept: condition test succeeded in ACL "acl_check_mail"
05:45:19 22431 end of ACL "acl_check_mail": ACCEPT
05:45:19 22431 SMTP>> 250 OK
05:45:19 22431 SMTP<< RCPT TO:<krichel@darni.openlib.org>
05:45:19 22431 using ACL "acl_check_rcpt"
05:45:19 22431 processing "accept"
05:45:19 22431 check hosts = :
05:45:19 22431 host in ":"? no (end of list)
05:45:19 22431 accept: condition test failed in ACL "acl_check_rcpt"
05:45:19 22431 processing "deny"
05:45:19 22431 check domains = +local_domains
05:45:19 22431 darni.openlib.org in "@:localhost:3lib.org:darni.openlib.org:lists.openlib.org:authorclaim.org"? yes (matched "darni.openlib.org")
05:45:19 22431 darni.openlib.org in "+local_domains"? yes (matched "+local_domains")
05:45:19 22431 check local_parts = ^[.] : ^.*[@%!/|`#&?]
05:45:19 22431 krichel in "^[.] : ^.*[@%!/|`#&?]"? no (end of list)
05:45:19 22431 deny: condition test failed in ACL "acl_check_rcpt"
05:45:19 22431 processing "deny"
05:45:19 22431 check domains = !+local_domains
05:45:19 22431 cached yes match for +local_domains
05:45:19 22431 cached lookup data = NULL
05:45:19 22431 darni.openlib.org in "!+local_domains"? no (matched "!+local_domains" - cached)
05:45:19 22431 deny: condition test failed in ACL "acl_check_rcpt"
05:45:19 22431 processing "accept"
05:45:19 22431 check local_parts = postmaster
05:45:19 22431 krichel in "postmaster"? no (end of list)
05:45:19 22431 accept: condition test failed in ACL "acl_check_rcpt"
05:45:19 22431 processing "deny"
05:45:19 22431 check !acl = acl_local_deny_exceptions
05:45:19 22431  using ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check hosts = ${if exists{/etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431    ┌considering: /etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/host_local_deny_exceptions
05:45:19 22431    └─────result: /etc/exim4/host_local_deny_exceptions
05:45:19 22431   ├──condition: exists{/etc/exim4/host_local_deny_exceptions}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/host_local_deny_exceptions
05:45:19 22431    ├─────result: /etc/exim4/host_local_deny_exceptions
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 host in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check senders = ${if exists{/etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431    ┌considering: /etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431    └─────result: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431   ├──condition: exists{/etc/exim4/sender_local_deny_exceptions}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431    ├─────result: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 krichel@openlib.org in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check hosts = ${if exists{/etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431    ┌considering: /etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_host_whitelist
05:45:19 22431    └─────result: /etc/exim4/local_host_whitelist
05:45:19 22431   ├──condition: exists{/etc/exim4/local_host_whitelist}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/local_host_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_host_whitelist
05:45:19 22431    ├─────result: /etc/exim4/local_host_whitelist
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 host in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check senders = ${if exists{/etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431    ┌considering: /etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_sender_whitelist
05:45:19 22431    └─────result: /etc/exim4/local_sender_whitelist
05:45:19 22431   ├──condition: exists{/etc/exim4/local_sender_whitelist}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/local_sender_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_sender_whitelist
05:45:19 22431    ├─────result: /etc/exim4/local_sender_whitelist
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 krichel@openlib.org in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  end of ACL "acl_local_deny_exceptions": implicit DENY
05:45:19 22431 check senders = ${if exists{/etc/exim4/local_sender_callout}{/etc/exim4/local_sender_callout}{}}
05:45:19 22431  ┌considering: ${if exists{/etc/exim4/local_sender_callout}{/etc/exim4/local_sender_callout}{}}
05:45:19 22431   ┌considering: /etc/exim4/local_sender_callout}{/etc/exim4/local_sender_callout}{}}
05:45:19 22431   ├──expanding: /etc/exim4/local_sender_callout
05:45:19 22431   └─────result: /etc/exim4/local_sender_callout
05:45:19 22431  ├──condition: exists{/etc/exim4/local_sender_callout}
05:45:19 22431  ├─────result: false
05:45:19 22431   ┌───scanning: /etc/exim4/local_sender_callout}{}}
05:45:19 22431   ├──expanding: /etc/exim4/local_sender_callout
05:45:19 22431   ├─────result: /etc/exim4/local_sender_callout
05:45:19 22431   └───skipping: result is not used
05:45:19 22431   ┌considering: }}
05:45:19 22431   ├──expanding: 
05:45:19 22431   └─────result: 
05:45:19 22431  ├──expanding: ${if exists{/etc/exim4/local_sender_callout}{/etc/exim4/local_sender_callout}{}}
05:45:19 22431  └─────result: 
05:45:19 22431 krichel@openlib.org in ""? no (end of list)
05:45:19 22431 deny: condition test failed in ACL "acl_check_rcpt"
05:45:19 22431 processing "accept"
05:45:19 22431 check hosts = +relay_from_hosts
05:45:19 22431 host in ": 127.0.0.1 : ::::1"? no (end of list)
05:45:19 22431 host in "+relay_from_hosts"? no (end of list)
05:45:19 22431 accept: condition test failed in ACL "acl_check_rcpt"
05:45:19 22431 processing "accept"
05:45:19 22431 check authenticated = *
05:45:19 22431 accept: condition test failed in ACL "acl_check_rcpt"
05:45:19 22431 processing "require"
05:45:19 22431   message: nice hosts say HELO first
05:45:19 22431  ┌considering: ${if def:sender_helo_name}
05:45:19 22431  ├──condition: def:sender_helo_name
05:45:19 22431  ├─────result: true
05:45:19 22431  ├──expanding: ${if def:sender_helo_name}
05:45:19 22431  └─────result: true
05:45:19 22431 check condition = ${if def:sender_helo_name}
05:45:19 22431                 = true
05:45:19 22431 require: condition test succeeded in ACL "acl_check_rcpt"
05:45:19 22431 processing "require"
05:45:19 22431   message: relay not permitted
05:45:19 22431 check domains = +local_domains : +relay_to_domains
05:45:19 22431 cached yes match for +local_domains
05:45:19 22431 cached lookup data = NULL
05:45:19 22431 darni.openlib.org in "+local_domains : +relay_to_domains"? yes (matched "+local_domains" - cached)
05:45:19 22431 require: condition test succeeded in ACL "acl_check_rcpt"
05:45:19 22431 processing "require"
05:45:19 22431 check verify = recipient
05:45:19 22431 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
05:45:19 22431 Verifying krichel@darni.openlib.org
05:45:19 22431 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
05:45:19 22431 Considering krichel@darni.openlib.org
05:45:19 22431 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
05:45:19 22431 routing krichel@darni.openlib.org
05:45:19 22431 --------> hubbed_hosts router <--------
05:45:19 22431 local_part=krichel domain=darni.openlib.org
05:45:19 22431 checking domains
05:45:19 22431  ┌considering: ${if exists{/etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/hubbed_hosts}fail}
05:45:19 22431   ┌considering: /etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/hubbed_hosts}fail}
05:45:19 22431   ├──expanding: /etc/exim4/hubbed_hosts
05:45:19 22431   └─────result: /etc/exim4/hubbed_hosts
05:45:19 22431  ├──condition: exists{/etc/exim4/hubbed_hosts}
05:45:19 22431  ├─────result: false
05:45:19 22431   ┌───scanning: partial-lsearch;/etc/exim4/hubbed_hosts}fail}
05:45:19 22431   ├──expanding: partial-lsearch;/etc/exim4/hubbed_hosts
05:45:19 22431   ├─────result: partial-lsearch;/etc/exim4/hubbed_hosts
05:45:19 22431   └───skipping: result is not used
05:45:19 22431  ├failed to expand: ${if exists{/etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/hubbed_hosts}fail}
05:45:19 22431  ├───error message: "if" failed and "fail" requested
05:45:19 22431  └failure was forced
05:45:19 22431 expansion of "${if exists{/etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/hubbed_hosts}fail}" forced failure: assume not in this list
05:45:19 22431 hubbed_hosts router skipped: domains mismatch
05:45:19 22431 --------> dnslookup_relay_to_domains router <--------
05:45:19 22431 local_part=krichel domain=darni.openlib.org
05:45:19 22431 checking domains
05:45:19 22431 cached yes match for +local_domains
05:45:19 22431 cached lookup data = NULL
05:45:19 22431 darni.openlib.org in "! +local_domains : +relay_to_domains"? no (matched "! +local_domains" - cached)
05:45:19 22431 dnslookup_relay_to_domains router skipped: domains mismatch
05:45:19 22431 --------> dnslookup router <--------
05:45:19 22431 local_part=krichel domain=darni.openlib.org
05:45:19 22431 checking domains
05:45:19 22431 cached yes match for +local_domains
05:45:19 22431 cached lookup data = NULL
05:45:19 22431 darni.openlib.org in "! +local_domains"? no (matched "! +local_domains" - cached)
05:45:19 22431 dnslookup router skipped: domains mismatch
05:45:19 22431 --------> real_local router <--------
05:45:19 22431 local_part=krichel domain=darni.openlib.org
05:45:19 22431 real_local router skipped: prefix mismatch
05:45:19 22431 --------> system_aliases router <--------
05:45:19 22431 local_part=krichel domain=darni.openlib.org
05:45:19 22431 checking domains
05:45:19 22431 cached yes match for +local_domains
05:45:19 22431 cached lookup data = NULL
05:45:19 22431 darni.openlib.org in "+local_domains"? yes (matched "+local_domains" - cached)
05:45:19 22431  ┌considering: R: system_aliases for $local_part@$domain
05:45:19 22431  ├──expanding: R: system_aliases for $local_part@$domain
05:45:19 22431  └─────result: R: system_aliases for krichel@darni.openlib.org
05:45:19 22431 R: system_aliases for krichel@darni.openlib.org
05:45:19 22431 calling system_aliases router
05:45:19 22431 rda_interpret (string): ${lookup{$local_part}lsearch{/etc/aliases}}
05:45:19 22431  ┌considering: ${lookup{$local_part}lsearch{/etc/aliases}}
05:45:19 22431   ┌considering: $local_part}lsearch{/etc/aliases}}
05:45:19 22431   ├──expanding: $local_part
05:45:19 22431   └─────result: krichel
05:45:19 22431   ┌considering: /etc/aliases}}
05:45:19 22431   ├──expanding: /etc/aliases
05:45:19 22431   └─────result: /etc/aliases
05:45:19 22431 search_open: lsearch "/etc/aliases"
05:45:19 22431 search_find: file="/etc/aliases"
05:45:19 22431   key="krichel" partial=-1 affix=NULL starflags=0
05:45:19 22431 LRU list:
05:45:19 22431   :/etc/aliases
05:45:19 22431   End
05:45:19 22431 internal_search_find: file="/etc/aliases"
05:45:19 22431   type=lsearch key="krichel"
05:45:19 22431 file lookup required for krichel
05:45:19 22431   in /etc/aliases
05:45:19 22431 lookup failed
05:45:19 22431  ├──expanding: ${lookup{$local_part}lsearch{/etc/aliases}}
05:45:19 22431  └─────result: 
05:45:19 22431 expanded: 
05:45:19 22431 file is not a filter file
05:45:19 22431 parse_forward_list: 
05:45:19 22431 system_aliases router declined for krichel@darni.openlib.org
05:45:19 22431 --------> userforward router <--------
05:45:19 22431 local_part=krichel domain=darni.openlib.org
05:45:19 22431 userforward router skipped: verify 2 0 0
05:45:19 22431 --------> procmail router <--------
05:45:19 22431 local_part=krichel domain=darni.openlib.org
05:45:19 22431 procmail router skipped: verify 2 0 0
05:45:19 22431 --------> maildrop router <--------
05:45:19 22431 local_part=krichel domain=darni.openlib.org
05:45:19 22431 maildrop router skipped: verify 2 0 0
05:45:19 22431 --------> lowuid_aliases router <--------
05:45:19 22431 local_part=krichel domain=darni.openlib.org
05:45:19 22431 checking domains
05:45:19 22431 cached yes match for +local_domains
05:45:19 22431 cached lookup data = NULL
05:45:19 22431 darni.openlib.org in "+local_domains"? yes (matched "+local_domains" - cached)
05:45:19 22431 checking for local user
05:45:19 22431 seeking password data for user "krichel": cache not available
05:45:19 22431 getpwnam() succeeded uid=1007 gid=1007
05:45:19 22431  ┌considering: R: lowuid_aliases for $local_part@$domain (UID $local_user_uid)
05:45:19 22431  ├──expanding: R: lowuid_aliases for $local_part@$domain (UID $local_user_uid)
05:45:19 22431  └─────result: R: lowuid_aliases for krichel@darni.openlib.org (UID 1007)
05:45:19 22431 R: lowuid_aliases for krichel@darni.openlib.org (UID 1007)
05:45:19 22431 checking "condition" "${if and{{! match_ip{$sender_host_address}{:@[]}}{<{$local_user_uid}{0}}}{1}{0}}"...
05:45:19 22431  ┌considering: ${if and{{! match_ip{$sender_host_address}{:@[]}}{<{$local_user_uid}{0}}}{1}{0}}
05:45:19 22431   ┌considering: $sender_host_address}{:@[]}}{<{$local_user_uid}{0}}}{1}{0}}
05:45:19 22431   ├──expanding: $sender_host_address
05:45:19 22431   └─────result: 136.243.149.87
05:45:19 22431   ┌considering: :@[]}}{<{$local_user_uid}{0}}}{1}{0}}
05:45:19 22431   ├──expanding: :@[]
05:45:19 22431   └─────result: :@[]
05:45:19 22431 136.243.149.87 in ":@[]"? no (end of list)
05:45:19 22431   ┌considering: $local_user_uid}{0}}}{1}{0}}
05:45:19 22431   ├──expanding: $local_user_uid
05:45:19 22431   └─────result: 1007
05:45:19 22431   ┌considering: 0}}}{1}{0}}
05:45:19 22431   ├──expanding: 0
05:45:19 22431   └─────result: 0
05:45:19 22431  ├──condition: and{{! match_ip{$sender_host_address}{:@[]}}{<{$local_user_uid}{0}}}
05:45:19 22431  ├─────result: false
05:45:19 22431   ┌───scanning: 1}{0}}
05:45:19 22431   ├──expanding: 1
05:45:19 22431   ├─────result: 1
05:45:19 22431   └───skipping: result is not used
05:45:19 22431   ┌considering: 0}}
05:45:19 22431   ├──expanding: 0
05:45:19 22431   └─────result: 0
05:45:19 22431  ├──expanding: ${if and{{! match_ip{$sender_host_address}{:@[]}}{<{$local_user_uid}{0}}}{1}{0}}
05:45:19 22431  └─────result: 0
05:45:19 22431 lowuid_aliases router skipped: condition failure
05:45:19 22431 --------> local_user router <--------
05:45:19 22431 local_part=krichel domain=darni.openlib.org
05:45:19 22431 checking domains
05:45:19 22431 cached yes match for +local_domains
05:45:19 22431 cached lookup data = NULL
05:45:19 22431 darni.openlib.org in "+local_domains"? yes (matched "+local_domains" - cached)
05:45:19 22431 checking local_parts
05:45:19 22431 krichel in "! root"? yes (end of list)
05:45:19 22431 checking for local user
05:45:19 22431 seeking password data for user "krichel": using cached result
05:45:19 22431 getpwnam() succeeded uid=1007 gid=1007
05:45:19 22431  ┌considering: R: local_user for $local_part@$domain
05:45:19 22431  ├──expanding: R: local_user for $local_part@$domain
05:45:19 22431  └─────result: R: local_user for krichel@darni.openlib.org
05:45:19 22431 R: local_user for krichel@darni.openlib.org
05:45:19 22431 calling local_user router
05:45:19 22431 local_user router called for krichel@darni.openlib.org
05:45:19 22431   domain = darni.openlib.org
05:45:19 22431 set transport mail_spool
05:45:19 22431 queued for mail_spool transport: local_part = krichel
05:45:19 22431 domain = darni.openlib.org
05:45:19 22431   errors_to=NULL
05:45:19 22431   domain_data=NULL localpart_data=NULL
05:45:19 22431 routed by local_user router
05:45:19 22431   envelope to: krichel@darni.openlib.org
05:45:19 22431   transport: mail_spool
05:45:19 22431 ----------- end verify ------------
05:45:19 22431 require: condition test succeeded in ACL "acl_check_rcpt"
05:45:19 22431 processing "deny"
05:45:19 22431 check !acl = acl_local_deny_exceptions
05:45:19 22431  using ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check hosts = ${if exists{/etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431    ┌considering: /etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/host_local_deny_exceptions
05:45:19 22431    └─────result: /etc/exim4/host_local_deny_exceptions
05:45:19 22431   ├──condition: exists{/etc/exim4/host_local_deny_exceptions}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/host_local_deny_exceptions
05:45:19 22431    ├─────result: /etc/exim4/host_local_deny_exceptions
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 host in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check senders = ${if exists{/etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431    ┌considering: /etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431    └─────result: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431   ├──condition: exists{/etc/exim4/sender_local_deny_exceptions}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431    ├─────result: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 krichel@openlib.org in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check hosts = ${if exists{/etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431    ┌considering: /etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_host_whitelist
05:45:19 22431    └─────result: /etc/exim4/local_host_whitelist
05:45:19 22431   ├──condition: exists{/etc/exim4/local_host_whitelist}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/local_host_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_host_whitelist
05:45:19 22431    ├─────result: /etc/exim4/local_host_whitelist
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 host in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check senders = ${if exists{/etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431    ┌considering: /etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_sender_whitelist
05:45:19 22431    └─────result: /etc/exim4/local_sender_whitelist
05:45:19 22431   ├──condition: exists{/etc/exim4/local_sender_whitelist}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/local_sender_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_sender_whitelist
05:45:19 22431    ├─────result: /etc/exim4/local_sender_whitelist
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 krichel@openlib.org in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  end of ACL "acl_local_deny_exceptions": implicit DENY
05:45:19 22431 check recipients = ${if exists{/etc/exim4/local_rcpt_callout}{/etc/exim4/local_rcpt_callout}{}}
05:45:19 22431  ┌considering: ${if exists{/etc/exim4/local_rcpt_callout}{/etc/exim4/local_rcpt_callout}{}}
05:45:19 22431   ┌considering: /etc/exim4/local_rcpt_callout}{/etc/exim4/local_rcpt_callout}{}}
05:45:19 22431   ├──expanding: /etc/exim4/local_rcpt_callout
05:45:19 22431   └─────result: /etc/exim4/local_rcpt_callout
05:45:19 22431  ├──condition: exists{/etc/exim4/local_rcpt_callout}
05:45:19 22431  ├─────result: false
05:45:19 22431   ┌───scanning: /etc/exim4/local_rcpt_callout}{}}
05:45:19 22431   ├──expanding: /etc/exim4/local_rcpt_callout
05:45:19 22431   ├─────result: /etc/exim4/local_rcpt_callout
05:45:19 22431   └───skipping: result is not used
05:45:19 22431   ┌considering: }}
05:45:19 22431   ├──expanding: 
05:45:19 22431   └─────result: 
05:45:19 22431  ├──expanding: ${if exists{/etc/exim4/local_rcpt_callout}{/etc/exim4/local_rcpt_callout}{}}
05:45:19 22431  └─────result: 
05:45:19 22431 krichel@darni.openlib.org in ""? no (end of list)
05:45:19 22431 deny: condition test failed in ACL "acl_check_rcpt"
05:45:19 22431 processing "deny"
05:45:19 22431   message: sender envelope address $sender_address is locally blacklisted here. If you think this is wrong, get in touch with postmaster
05:45:19 22431 l_message: sender envelope address is locally blacklisted.
05:45:19 22431 check !acl = acl_local_deny_exceptions
05:45:19 22431  using ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check hosts = ${if exists{/etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431    ┌considering: /etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/host_local_deny_exceptions
05:45:19 22431    └─────result: /etc/exim4/host_local_deny_exceptions
05:45:19 22431   ├──condition: exists{/etc/exim4/host_local_deny_exceptions}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/host_local_deny_exceptions
05:45:19 22431    ├─────result: /etc/exim4/host_local_deny_exceptions
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 host in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check senders = ${if exists{/etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431    ┌considering: /etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431    └─────result: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431   ├──condition: exists{/etc/exim4/sender_local_deny_exceptions}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431    ├─────result: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 krichel@openlib.org in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check hosts = ${if exists{/etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431    ┌considering: /etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_host_whitelist
05:45:19 22431    └─────result: /etc/exim4/local_host_whitelist
05:45:19 22431   ├──condition: exists{/etc/exim4/local_host_whitelist}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/local_host_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_host_whitelist
05:45:19 22431    ├─────result: /etc/exim4/local_host_whitelist
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 host in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check senders = ${if exists{/etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431    ┌considering: /etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_sender_whitelist
05:45:19 22431    └─────result: /etc/exim4/local_sender_whitelist
05:45:19 22431   ├──condition: exists{/etc/exim4/local_sender_whitelist}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/local_sender_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_sender_whitelist
05:45:19 22431    ├─────result: /etc/exim4/local_sender_whitelist
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 krichel@openlib.org in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  end of ACL "acl_local_deny_exceptions": implicit DENY
05:45:19 22431 check senders = ${if exists{/etc/exim4/local_sender_blacklist}{/etc/exim4/local_sender_blacklist}{}}
05:45:19 22431  ┌considering: ${if exists{/etc/exim4/local_sender_blacklist}{/etc/exim4/local_sender_blacklist}{}}
05:45:19 22431   ┌considering: /etc/exim4/local_sender_blacklist}{/etc/exim4/local_sender_blacklist}{}}
05:45:19 22431   ├──expanding: /etc/exim4/local_sender_blacklist
05:45:19 22431   └─────result: /etc/exim4/local_sender_blacklist
05:45:19 22431  ├──condition: exists{/etc/exim4/local_sender_blacklist}
05:45:19 22431  ├─────result: false
05:45:19 22431   ┌───scanning: /etc/exim4/local_sender_blacklist}{}}
05:45:19 22431   ├──expanding: /etc/exim4/local_sender_blacklist
05:45:19 22431   ├─────result: /etc/exim4/local_sender_blacklist
05:45:19 22431   └───skipping: result is not used
05:45:19 22431   ┌considering: }}
05:45:19 22431   ├──expanding: 
05:45:19 22431   └─────result: 
05:45:19 22431  ├──expanding: ${if exists{/etc/exim4/local_sender_blacklist}{/etc/exim4/local_sender_blacklist}{}}
05:45:19 22431  └─────result: 
05:45:19 22431 krichel@openlib.org in ""? no (end of list)
05:45:19 22431 deny: condition test failed in ACL "acl_check_rcpt"
05:45:19 22431 processing "deny"
05:45:19 22431   message: sender IP address $sender_host_address is locally blacklisted here. If you think this is wrong, get in touch with postmaster
05:45:19 22431 l_message: sender IP address is locally blacklisted.
05:45:19 22431 check !acl = acl_local_deny_exceptions
05:45:19 22431  using ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check hosts = ${if exists{/etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431    ┌considering: /etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/host_local_deny_exceptions
05:45:19 22431    └─────result: /etc/exim4/host_local_deny_exceptions
05:45:19 22431   ├──condition: exists{/etc/exim4/host_local_deny_exceptions}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/host_local_deny_exceptions
05:45:19 22431    ├─────result: /etc/exim4/host_local_deny_exceptions
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 host in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check senders = ${if exists{/etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431    ┌considering: /etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431    └─────result: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431   ├──condition: exists{/etc/exim4/sender_local_deny_exceptions}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431    ├─────result: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 krichel@openlib.org in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check hosts = ${if exists{/etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431    ┌considering: /etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_host_whitelist
05:45:19 22431    └─────result: /etc/exim4/local_host_whitelist
05:45:19 22431   ├──condition: exists{/etc/exim4/local_host_whitelist}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/local_host_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_host_whitelist
05:45:19 22431    ├─────result: /etc/exim4/local_host_whitelist
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 host in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check senders = ${if exists{/etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431    ┌considering: /etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_sender_whitelist
05:45:19 22431    └─────result: /etc/exim4/local_sender_whitelist
05:45:19 22431   ├──condition: exists{/etc/exim4/local_sender_whitelist}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/local_sender_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_sender_whitelist
05:45:19 22431    ├─────result: /etc/exim4/local_sender_whitelist
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 krichel@openlib.org in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  end of ACL "acl_local_deny_exceptions": implicit DENY
05:45:19 22431 check hosts = ${if exists{/etc/exim4/local_host_blacklist}{/etc/exim4/local_host_blacklist}{}}
05:45:19 22431  ┌considering: ${if exists{/etc/exim4/local_host_blacklist}{/etc/exim4/local_host_blacklist}{}}
05:45:19 22431   ┌considering: /etc/exim4/local_host_blacklist}{/etc/exim4/local_host_blacklist}{}}
05:45:19 22431   ├──expanding: /etc/exim4/local_host_blacklist
05:45:19 22431   └─────result: /etc/exim4/local_host_blacklist
05:45:19 22431  ├──condition: exists{/etc/exim4/local_host_blacklist}
05:45:19 22431  ├─────result: false
05:45:19 22431   ┌───scanning: /etc/exim4/local_host_blacklist}{}}
05:45:19 22431   ├──expanding: /etc/exim4/local_host_blacklist
05:45:19 22431   ├─────result: /etc/exim4/local_host_blacklist
05:45:19 22431   └───skipping: result is not used
05:45:19 22431   ┌considering: }}
05:45:19 22431   ├──expanding: 
05:45:19 22431   └─────result: 
05:45:19 22431  ├──expanding: ${if exists{/etc/exim4/local_host_blacklist}{/etc/exim4/local_host_blacklist}{}}
05:45:19 22431  └─────result: 
05:45:19 22431 host in ""? no (end of list)
05:45:19 22431 deny: condition test failed in ACL "acl_check_rcpt"
05:45:19 22431 processing "accept"
05:45:19 22431 check domains = +relay_to_domains
05:45:19 22431 darni.openlib.org in ""? no (end of list)
05:45:19 22431 darni.openlib.org in "+relay_to_domains"? no (end of list)
05:45:19 22431 accept: condition test failed in ACL "acl_check_rcpt"
05:45:19 22431 processing "accept"
05:45:19 22431 accept: condition test succeeded in ACL "acl_check_rcpt"
05:45:19 22431 end of ACL "acl_check_rcpt": ACCEPT
05:45:19 22431 SMTP>> 250 Accepted
05:45:19 22431 DSN: orcpt: NULL  flags: 0
05:45:19 22431 SMTP<< BDAT 1335 LAST
05:45:19 22431 chunking state 2, 1335 bytes
05:45:19 22431 search_tidyup called
05:45:19 22431 PDKIM >> Found sig, trying to parse >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
05:45:19 22431  v=1
05:45:19 22431  a=rsa-sha256
05:45:19 22431  q=dns/txt
05:45:19 22431  c=relaxed/relaxed
05:45:19 22431  d=openlib.org
05:45:19 22431  s=all
05:45:19 22431  h=Content-Type:MIME-Version:Message-ID:Subject:To:From:Date:Sender:Reply-To:Cc:Content-Transfer-Encoding:Content-ID:Content-Description:Resent-Date:Resent-From:Resent-Sender:Resent-To:Resent-Cc:Resent-Message-ID:In-Reply-To:References:List-Id:List-Help:List-Unsubscribe:List-Subscribe:List-Post:List-Owner:List-Archive
05:45:19 22431  bh=ivheC5/lEZppddiF3JhRg7K8952ZDtv3vk8QUg/NRW0=
05:45:19 22431  b=nRpU/PetCMUjwPVaG4Es/TkKSBKcXZdoZQqlofBzMFmzfsPG1E56pMziKZkNv4xT62wvF8PPfdgQqJYAsQgQbLrFUGLxlZ1FsgoujwyvmcC8AAHB30UcSKIPtgbduqgeNk1PY/Vhg/vUjFTNVkEHbc36dpcYTjhaPxxAUlI07Hk=
05:45:19 22431 PDKIM >> Raw signature w/o b= tag value >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
05:45:19 22431 DKIM-Signature:{SP}v=1;{SP}a=rsa-sha256;{SP}q=dns/txt;{SP}c=relaxed/relaxed;{SP}d=openlib.org{CR}{LF}{TB};{SP}s=all;{SP}h=Content-Type:MIME-Version:Message-ID:Subject:To:From:Date:Sender:{CR}{LF}{TB}Reply-To:Cc:Content-Transfer-Encoding:Content-ID:Content-Description:{CR}{LF}{TB}Resent-Date:Resent-From:Resent-Sender:Resent-To:Resent-Cc:Resent-Message-ID:{CR}{LF}{TB}In-Reply-To:References:List-Id:List-Help:List-Unsubscribe:List-Subscribe:{CR}{LF}{TB}List-Post:List-Owner:List-Archive;{CR}{LF}{TB}bh=ivheC5/lEZppddiF3JhRg7K8952ZDtv3vk8QUg/NRW0=;{SP}b=;
05:45:19 22431 PDKIM >> Sig size: 1024 bits
05:45:19 22431 PDKIM <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<
05:45:19 22431 PDKIM: new bodyhash 1/1/-1
05:45:19 22431 PDKIM >> Body data for hash, canonicalized >>>>>>>>>>>>>>>>>>>>>>>>>>>>
05:45:19 22431 test10{CR}{LF}
05:45:19 22431 host in ignore_fromline_hosts? no (option unset)
05:45:19 22431 >>Headers received:
05:45:19 22431 DKIM-Signature: v=1; a=rsa-sha256; q=dns/txt; c=relaxed/relaxed; d=openlib.org
05:45:19 22431 	; s=all; h=Content-Type:MIME-Version:Message-ID:Subject:To:From:Date:Sender:
05:45:19 22431 	Reply-To:Cc:Content-Transfer-Encoding:Content-ID:Content-Description:
05:45:19 22431 	Resent-Date:Resent-From:Resent-Sender:Resent-To:Resent-Cc:Resent-Message-ID:
05:45:19 22431 	In-Reply-To:References:List-Id:List-Help:List-Unsubscribe:List-Subscribe:
05:45:19 22431 	List-Post:List-Owner:List-Archive;
05:45:19 22431 	bh=ivheC5/lEZppddiF3JhRg7K8952ZDtv3vk8QUg/NRW0=; b=nRpU/PetCMUjwPVaG4Es/TkKSB
05:45:19 22431 	KcXZdoZQqlofBzMFmzfsPG1E56pMziKZkNv4xT62wvF8PPfdgQqJYAsQgQbLrFUGLxlZ1Fsgoujwy
05:45:19 22431 	vmcC8AAHB30UcSKIPtgbduqgeNk1PY/Vhg/vUjFTNVkEHbc36dpcYTjhaPxxAUlI07Hk=;
05:45:19 22431 Received: from krichel by amorp.openlib.org with local (Exim 4.91)
05:45:19 22431 	(envelope-from <krichel@openlib.org>)
05:45:19 22431 	id 1h9kKM-0007af-Px
05:45:19 22431 	for krichel@darni.openlib.org; Fri, 29 Mar 2019 05:45:18 +0000
05:45:19 22431 Date: Fri, 29 Mar 2019 05:45:18 +0000
05:45:19 22431 From: Thomas Krichel <krichel@openlib.org>
05:45:19 22431 To: krichel@darni.openlib.org
05:45:19 22431 Subject: test5
05:45:19 22431 Message-ID: <20190329054518.GA29152@openlib.org>
05:45:19 22431 MIME-Version: 1.0
05:45:19 22431 Content-Type: text/plain; charset=us-ascii
05:45:19 22431 Content-Disposition: inline
05:45:19 22431 User-Agent: Mutt/1.10.1 (2018-07-13)
05:45:19 22431 X-SA-Exim-Connect-IP: <locally generated>
05:45:19 22431 X-SA-Exim-Mail-From: krichel@openlib.org
05:45:19 22431 X-SA-Exim-Scanned: No (on amorp.openlib.org); SAEximRunCond expanded to false
05:45:19 22431 
05:45:19 22431 address match test: subject=krichel@openlib.org pattern=*@+local_domains
05:45:19 22431 openlib.org in "@:localhost:3lib.org:darni.openlib.org:lists.openlib.org:authorclaim.org"? no (end of list)
05:45:19 22431 openlib.org in "+local_domains"? no (end of list)
05:45:19 22431 krichel@openlib.org in "*@+local_domains"? no (end of list)
05:45:19 22431 address match test: subject=krichel@openlib.org pattern=*@darni
05:45:19 22431 openlib.org in "darni"? no (end of list)
05:45:19 22431 krichel@openlib.org in "*@darni"? no (end of list)
05:45:19 22431 rewritten sender = krichel@openlib.org
05:45:19 22431 rewrite_one_header: type=F:
05:45:19 22431   From: Thomas Krichel <krichel@openlib.org>
05:45:19 22431 address match test: subject=krichel@openlib.org pattern=*@+local_domains
05:45:19 22431 openlib.org in "@:localhost:3lib.org:darni.openlib.org:lists.openlib.org:authorclaim.org"? no (end of list)
05:45:19 22431 openlib.org in "+local_domains"? no (end of list)
05:45:19 22431 krichel@openlib.org in "*@+local_domains"? no (end of list)
05:45:19 22431 address match test: subject=krichel@openlib.org pattern=*@darni
05:45:19 22431 openlib.org in "darni"? no (end of list)
05:45:19 22431 krichel@openlib.org in "*@darni"? no (end of list)
05:45:19 22431 rewrite_one_header: type=T:
05:45:19 22431   To: krichel@darni.openlib.org
05:45:19 22431 search_tidyup called
05:45:19 22431 >>Headers after rewriting and local additions:
05:45:19 22431   DKIM-Signature: v=1; a=rsa-sha256; q=dns/txt; c=relaxed/relaxed; d=openlib.org
05:45:19 22431 	; s=all; h=Content-Type:MIME-Version:Message-ID:Subject:To:From:Date:Sender:
05:45:19 22431 	Reply-To:Cc:Content-Transfer-Encoding:Content-ID:Content-Description:
05:45:19 22431 	Resent-Date:Resent-From:Resent-Sender:Resent-To:Resent-Cc:Resent-Message-ID:
05:45:19 22431 	In-Reply-To:References:List-Id:List-Help:List-Unsubscribe:List-Subscribe:
05:45:19 22431 	List-Post:List-Owner:List-Archive;
05:45:19 22431 	bh=ivheC5/lEZppddiF3JhRg7K8952ZDtv3vk8QUg/NRW0=; b=nRpU/PetCMUjwPVaG4Es/TkKSB
05:45:19 22431 	KcXZdoZQqlofBzMFmzfsPG1E56pMziKZkNv4xT62wvF8PPfdgQqJYAsQgQbLrFUGLxlZ1Fsgoujwy
05:45:19 22431 	vmcC8AAHB30UcSKIPtgbduqgeNk1PY/Vhg/vUjFTNVkEHbc36dpcYTjhaPxxAUlI07Hk=;
05:45:19 22431 P Received: from krichel by amorp.openlib.org with local (Exim 4.91)
05:45:19 22431 	(envelope-from <krichel@openlib.org>)
05:45:19 22431 	id 1h9kKM-0007af-Px
05:45:19 22431 	for krichel@darni.openlib.org; Fri, 29 Mar 2019 05:45:18 +0000
05:45:19 22431   Date: Fri, 29 Mar 2019 05:45:18 +0000
05:45:19 22431 F From: Thomas Krichel <krichel@openlib.org>
05:45:19 22431 T To: krichel@darni.openlib.org
05:45:19 22431   Subject: test5
05:45:19 22431 I Message-ID: <20190329054518.GA29152@openlib.org>
05:45:19 22431   MIME-Version: 1.0
05:45:19 22431   Content-Type: text/plain; charset=us-ascii
05:45:19 22431   Content-Disposition: inline
05:45:19 22431   User-Agent: Mutt/1.10.1 (2018-07-13)
05:45:19 22431   X-SA-Exim-Connect-IP: <locally generated>
05:45:19 22431   X-SA-Exim-Mail-From: krichel@openlib.org
05:45:19 22431   X-SA-Exim-Scanned: No (on amorp.openlib.org); SAEximRunCond expanded to false
05:45:19 22431 
05:45:19 22431 Data file name: /var/spool/exim4//input//1h9kKN-0005pn-0n-D
05:45:19 22431 Data file written for message 1h9kKN-0005pn-0n
05:45:19 22431  ┌considering: ${tod_full}
05:45:19 22431  ├──expanding: ${tod_full}
05:45:19 22431  └─────result: Fri, 29 Mar 2019 05:45:19 +0000
05:45:19 22431  ┌considering: Received: ${if def:sender_rcvhost {from $sender_rcvhost
05:45:19 22431  	}{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
05:45:19 22431  	}}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
05:45:19 22431  	}}(Exim $version_number)
05:45:19 22431  	${if def:sender_address {(envelope-from <$sender_address>)
05:45:19 22431  	}}id $message_exim_id${if def:received_for {
05:45:19 22431  	for $received_for}}
05:45:19 22431  ├──condition: def:sender_rcvhost
05:45:19 22431  ├─────result: true
05:45:19 22431   ┌considering: from $sender_rcvhost
05:45:19 22431   	}{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
05:45:19 22431   	}}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
05:45:19 22431   	}}(Exim $version_number)
05:45:19 22431   	${if def:sender_address {(envelope-from <$sender_address>)
05:45:19 22431   	}}id $message_exim_id${if def:received_for {
05:45:19 22431   	for $received_for}}
05:45:19 22431   ├──expanding: from $sender_rcvhost
05:45:19 22431   	
05:45:19 22431   └─────result: from amorp.openlib.org ([136.243.149.87])
05:45:19 22431   	
05:45:19 22431   ┌───scanning: ${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
05:45:19 22431   	}}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
05:45:19 22431   	}}(Exim $version_number)
05:45:19 22431   	${if def:sender_address {(envelope-from <$sender_address>)
05:45:19 22431   	}}id $message_exim_id${if def:received_for {
05:45:19 22431   	for $received_for}}
05:45:19 22431   ├──condition: def:sender_ident
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
05:45:19 22431    	}}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
05:45:19 22431    	}}(Exim $version_number)
05:45:19 22431    	${if def:sender_address {(envelope-from <$sender_address>)
05:45:19 22431    	}}id $message_exim_id${if def:received_for {
05:45:19 22431    	for $received_for}}
05:45:19 22431    ╎┌───scanning: $sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
05:45:19 22431    ╎	}}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
05:45:19 22431    ╎	}}(Exim $version_number)
05:45:19 22431    ╎	${if def:sender_address {(envelope-from <$sender_address>)
05:45:19 22431    ╎	}}id $message_exim_id${if def:received_for {
05:45:19 22431    ╎	for $received_for}}
05:45:19 22431    ╎├──expanding: $sender_ident
05:45:19 22431    ╎├─────result: 
05:45:19 22431    ╎└───skipping: result is not used
05:45:19 22431    ├──expanding: from ${quote_local_part:$sender_ident} 
05:45:19 22431    ├─────result: from  
05:45:19 22431    └───skipping: result is not used
05:45:19 22431   ├──condition: def:sender_helo_name
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: (helo=$sender_helo_name)
05:45:19 22431    	}}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
05:45:19 22431    	}}(Exim $version_number)
05:45:19 22431    	${if def:sender_address {(envelope-from <$sender_address>)
05:45:19 22431    	}}id $message_exim_id${if def:received_for {
05:45:19 22431    	for $received_for}}
05:45:19 22431    ├──expanding: (helo=$sender_helo_name)
05:45:19 22431    	
05:45:19 22431    ├─────result: (helo=)
05:45:19 22431    	
05:45:19 22431    └───skipping: result is not used
05:45:19 22431   ├──expanding: ${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
05:45:19 22431   	}}
05:45:19 22431   ├─────result: 
05:45:19 22431   └───skipping: result is not used
05:45:19 22431  ├──condition: def:received_protocol
05:45:19 22431  ├─────result: true
05:45:19 22431   ┌considering: with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
05:45:19 22431   	}}(Exim $version_number)
05:45:19 22431   	${if def:sender_address {(envelope-from <$sender_address>)
05:45:19 22431   	}}id $message_exim_id${if def:received_for {
05:45:19 22431   	for $received_for}}
05:45:19 22431   ├──expanding: with $received_protocol
05:45:19 22431   └─────result: with esmtp
05:45:19 22431  ├──condition: def:tls_cipher
05:45:19 22431  ├─────result: false
05:45:19 22431   ┌───scanning: ($tls_cipher)
05:45:19 22431   	}}(Exim $version_number)
05:45:19 22431   	${if def:sender_address {(envelope-from <$sender_address>)
05:45:19 22431   	}}id $message_exim_id${if def:received_for {
05:45:19 22431   	for $received_for}}
05:45:19 22431   ├──expanding: ($tls_cipher)
05:45:19 22431   	
05:45:19 22431   ├─────result: ()
05:45:19 22431   	
05:45:19 22431   └───skipping: result is not used
05:45:19 22431  ├──condition: def:sender_address
05:45:19 22431  ├─────result: true
05:45:19 22431   ┌considering: (envelope-from <$sender_address>)
05:45:19 22431   	}}id $message_exim_id${if def:received_for {
05:45:19 22431   	for $received_for}}
05:45:19 22431   ├──expanding: (envelope-from <$sender_address>)
05:45:19 22431   	
05:45:19 22431   └─────result: (envelope-from <krichel@openlib.org>)
05:45:19 22431   	
05:45:19 22431  ├──condition: def:received_for
05:45:19 22431  ├─────result: true
05:45:19 22431   ┌considering: 
05:45:19 22431   	for $received_for}}
05:45:19 22431   ├──expanding: 
05:45:19 22431   	for $received_for
05:45:19 22431   └─────result: 
05:45:19 22431   	for krichel@darni.openlib.org
05:45:19 22431  ├──expanding: Received: ${if def:sender_rcvhost {from $sender_rcvhost
05:45:19 22431  	}{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
05:45:19 22431  	}}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
05:45:19 22431  	}}(Exim $version_number)
05:45:19 22431  	${if def:sender_address {(envelope-from <$sender_address>)
05:45:19 22431  	}}id $message_exim_id${if def:received_for {
05:45:19 22431  	for $received_for}}
05:45:19 22431  └─────result: Received: from amorp.openlib.org ([136.243.149.87])
05:45:19 22431  	by darni with esmtp (Exim 4.92)
05:45:19 22431  	(envelope-from <krichel@openlib.org>)
05:45:19 22431  	id 1h9kKN-0005pn-0n
05:45:19 22431  	for krichel@darni.openlib.org
05:45:19 22431 >>Generated Received: header line
05:45:19 22431 P Received: from amorp.openlib.org ([136.243.149.87])
05:45:19 22431 	by darni with esmtp (Exim 4.92)
05:45:19 22431 	(envelope-from <krichel@openlib.org>)
05:45:19 22431 	id 1h9kKN-0005pn-0n
05:45:19 22431 	for krichel@darni.openlib.org; Fri, 29 Mar 2019 05:45:19 +0000
05:45:19 22431 PDKIM <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<
05:45:19 22431 PDKIM: finish bodyhash 1/1/-1 len 8
05:45:19 22431 PDKIM [openlib.org] Body bytes (relaxed) hashed: 8
05:45:19 22431 PDKIM [openlib.org] Body sha256 computed: 8af85e0b9fe5119a6975d885dc985183b2bcf79d990edbf7be4f10520fcd456d
05:45:19 22431 PDKIM [openlib.org] Body hash compared OK
05:45:19 22431 PDKIM >> Header data for hash, canonicalized (relaxed), in sequence >>
05:45:19 22431 content-type:text/plain;{SP}charset=us-ascii{CR}{LF}
05:45:19 22431 mime-version:1.0{CR}{LF}
05:45:19 22431 message-id:<20190329054518.GA29152@openlib.org>{CR}{LF}
05:45:19 22431 subject:test5{CR}{LF}
05:45:19 22431 to:krichel@darni.openlib.org{CR}{LF}
05:45:19 22431 from:Thomas{SP}Krichel{SP}<krichel@openlib.org>{CR}{LF}
05:45:19 22431 date:Fri,{SP}29{SP}Mar{SP}2019{SP}05:45:18{SP}+0000{CR}{LF}
05:45:19 22431 PDKIM <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<
05:45:19 22431 PDKIM >> Signed DKIM-Signature header, pre-canonicalized >>>>>>>>>>>>>
05:45:19 22431 DKIM-Signature:{SP}v=1;{SP}a=rsa-sha256;{SP}q=dns/txt;{SP}c=relaxed/relaxed;{SP}d=openlib.org{CR}{LF}{TB};{SP}s=all;{SP}h=Content-Type:MIME-Version:Message-ID:Subject:To:From:Date:Sender:{CR}{LF}{TB}Reply-To:Cc:Content-Transfer-Encoding:Content-ID:Content-Description:{CR}{LF}{TB}Resent-Date:Resent-From:Resent-Sender:Resent-To:Resent-Cc:Resent-Message-ID:{CR}{LF}{TB}In-Reply-To:References:List-Id:List-Help:List-Unsubscribe:List-Subscribe:{CR}{LF}{TB}List-Post:List-Owner:List-Archive;{CR}{LF}{TB}bh=ivheC5/lEZppddiF3JhRg7K8952ZDtv3vk8QUg/NRW0=;{SP}b=;
05:45:19 22431 PDKIM <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<
05:45:19 22431 PDKIM >> Signed DKIM-Signature header, canonicalized (relaxed) >>>>>>>
05:45:19 22431 dkim-signature:v=1;{SP}a=rsa-sha256;{SP}q=dns/txt;{SP}c=relaxed/relaxed;{SP}d=openlib.org{SP};{SP}s=all;{SP}h=Content-Type:MIME-Version:Message-ID:Subject:To:From:Date:Sender:{SP}Reply-To:Cc:Content-Transfer-Encoding:Content-ID:Content-Description:{SP}Resent-Date:Resent-From:Resent-Sender:Resent-To:Resent-Cc:Resent-Message-ID:{SP}In-Reply-To:References:List-Id:List-Help:List-Unsubscribe:List-Subscribe:{SP}List-Post:List-Owner:List-Archive;{SP}bh=ivheC5/lEZppddiF3JhRg7K8952ZDtv3vk8QUg/NRW0=;{SP}b=;
05:45:19 22431 PDKIM <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<
05:45:19 22431 PDKIM [openlib.org] Header sha256 computed: 9c43869d233e7e923c19ae85056ba8c9dfbe3acb00d958ca87bee80e6ffe7cd6
05:45:19 22431 PDKIM [openlib.org] b from mail: 9d1a54fcf7ad08c523c0f55a1b812cfd390a48129c5d9768650aa5a1f0733059b37ec3c6d44e7aa4cce229990dbf8c53eb6c2f17c3cf7dd810a89600b108106cbac55062f1959d45b20a2e8f0caf99c0bc0001c1df451c48a20fb606ddbaa81e364d4f63f56183fbd48c54cd5641076dcdfa7697184e385a3f1c40525234ec79
05:45:19 22431 DNS lookup of all._domainkey.openlib.org. (TXT) succeeded
05:45:19 22431 PDKIM >> Parsing public key record >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
05:45:19 22431  all._domainkey.openlib.org.
05:45:19 22431  Raw record: v=DKIM1;{SP}o=-;{SP}k=rsa;{SP}p=MIGfMA0GCSqGSIb3DQEBAQUAA4GNADCBiQKBgQDgTxlyXX8PoIv6bVVvXluOXeugfHlYOE4sULpRLdleq/lflmi1mNcrdC6Z1QaYvvIRsP6wFDyXuREn0Ubussoqh2iJvnp55IYq1b68eNEA3lnhqKc9WylAZ+xpTioU8mhH8ewFxdmY4v3oYm/r2pwuKAr1AA4piGguT94KYL510QIDAQAB
05:45:19 22431  v=DKIM1
05:45:19 22431  o=-
05:45:19 22431  Unknown tag encountered
05:45:19 22431  k=rsa
05:45:19 22431  p=MIGfMA0GCSqGSIb3DQEBAQUAA4GNADCBiQKBgQDgTxlyXX8PoIv6bVVvXluOXeugfHlYOE4sULpRLdleq/lflmi1mNcrdC6Z1QaYvvIRsP6wFDyXuREn0Ubussoqh2iJvnp55IYq1b68eNEA3lnhqKc9WylAZ+xpTioU8mhH8ewFxdmY4v3oYm/r2pwuKAr1AA4piGguT94KYL510QIDAQAB
05:45:19 22431 PDKIM <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<
05:45:19 22431 PDKIM [openlib.org] rsa-sha256 signature status: PDKIM_VERIFY_PASS
05:45:19 22431 using ACL "acl_check_data"
05:45:19 22431 processing "deny"
05:45:19 22431   message: maximum allowed line length is 998 octets, got $max_received_linelength
05:45:19 22431  ┌considering: ${if > {$max_received_linelength}{998}}
05:45:19 22431   ┌considering: $max_received_linelength}{998}}
05:45:19 22431   ├──expanding: $max_received_linelength
05:45:19 22431   └─────result: 78
05:45:19 22431   ┌considering: 998}}
05:45:19 22431   ├──expanding: 998
05:45:19 22431   └─────result: 998
05:45:19 22431  ├──condition: > {$max_received_linelength}{998}
05:45:19 22431  ├─────result: false
05:45:19 22431  ├──expanding: ${if > {$max_received_linelength}{998}}
05:45:19 22431  └─────result: 
05:45:19 22431 check condition = ${if > {$max_received_linelength}{998}}
05:45:19 22431                 = 
05:45:19 22431 deny: condition test failed in ACL "acl_check_data"
05:45:19 22431 processing "deny"
05:45:19 22431 check !acl = acl_local_deny_exceptions
05:45:19 22431  using ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check hosts = ${if exists{/etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431    ┌considering: /etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/host_local_deny_exceptions
05:45:19 22431    └─────result: /etc/exim4/host_local_deny_exceptions
05:45:19 22431   ├──condition: exists{/etc/exim4/host_local_deny_exceptions}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/host_local_deny_exceptions
05:45:19 22431    ├─────result: /etc/exim4/host_local_deny_exceptions
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 host in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check senders = ${if exists{/etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431    ┌considering: /etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431    └─────result: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431   ├──condition: exists{/etc/exim4/sender_local_deny_exceptions}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431    ├──expanding: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431    ├─────result: /etc/exim4/sender_local_deny_exceptions
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 krichel@openlib.org in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check hosts = ${if exists{/etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431    ┌considering: /etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_host_whitelist
05:45:19 22431    └─────result: /etc/exim4/local_host_whitelist
05:45:19 22431   ├──condition: exists{/etc/exim4/local_host_whitelist}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/local_host_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_host_whitelist
05:45:19 22431    ├─────result: /etc/exim4/local_host_whitelist
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 host in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  processing "accept"
05:45:19 22431  check senders = ${if exists{/etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431   ┌considering: ${if exists{/etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431    ┌considering: /etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_sender_whitelist
05:45:19 22431    └─────result: /etc/exim4/local_sender_whitelist
05:45:19 22431   ├──condition: exists{/etc/exim4/local_sender_whitelist}
05:45:19 22431   ├─────result: false
05:45:19 22431    ┌───scanning: /etc/exim4/local_sender_whitelist}{}}
05:45:19 22431    ├──expanding: /etc/exim4/local_sender_whitelist
05:45:19 22431    ├─────result: /etc/exim4/local_sender_whitelist
05:45:19 22431    └───skipping: result is not used
05:45:19 22431    ┌considering: }}
05:45:19 22431    ├──expanding: 
05:45:19 22431    └─────result: 
05:45:19 22431   ├──expanding: ${if exists{/etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
05:45:19 22431   └─────result: 
05:45:19 22431 krichel@openlib.org in ""? no (end of list)
05:45:19 22431  accept: condition test failed in ACL "acl_local_deny_exceptions"
05:45:19 22431  end of ACL "acl_local_deny_exceptions": implicit DENY
05:45:19 22431 check !verify = header_syntax
05:45:19 22431 deny: condition test failed in ACL "acl_check_data"
05:45:19 22431 processing "accept"
05:45:19 22431 accept: condition test succeeded in ACL "acl_check_data"
05:45:19 22431 end of ACL "acl_check_data": ACCEPT
05:45:19 22431  ┌considering: ${tod_full}
05:45:19 22431  ├──expanding: ${tod_full}
05:45:19 22431  └─────result: Fri, 29 Mar 2019 05:45:19 +0000
05:45:19 22431 Writing spool header file: /var/spool/exim4//input//hdr.22431
05:45:19 22431 DSN: Write SPOOL :-dsn_envid NULL
05:45:19 22431 DSN: Write SPOOL :-dsn_ret 0
05:45:19 22431 DSN: Flags :0
05:45:19 22431 DSN: **** SPOOL_OUT - address: |krichel@darni.openlib.org| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
05:45:19 22431 Renaming spool header file: /var/spool/exim4//input//1h9kKN-0005pn-0n-H
05:45:19 22431 Size of headers = 1509
05:45:19 22431 LOG: MAIN
05:45:19 22431   <= krichel@openlib.org H=amorp.openlib.org [136.243.149.87] P=esmtp K S=1517 DKIM=openlib.org id=20190329054518.GA29152@openlib.org
05:45:19 22431 SMTP>> 250- 1335 byte chunk, total 1335
05:45:19 22431 250 OK id=1h9kKN-0005pn-0n
05:45:19 22431 search_tidyup called
05:45:19 22431 Sender: krichel@openlib.org
05:45:19 22431 Recipients:
05:45:19 22431   krichel@darni.openlib.org
05:45:19 22431 forked delivery process 22432
05:45:19 22431 Process 22431 is ready for new message
05:45:19 22431 smtp_setup_msg entered
05:45:19 22432 exec /usr/sbin/exim4 -C /var/lib/exim4/config.autogenerated -d=0xfff9ffff -Mc 1h9kKN-0005pn-0n
05:45:19 22432 Exim version 4.92 uid=107 gid=112 pid=22432 D=fff9ffff
Support for: crypteq iconv() IPv6 PAM Perl Expand_dlfunc GnuTLS move_frozen_messages Content_Scanning DANE DKIM DNSSEC Event OCSP PRDR PROXY SOCKS TCP_Fast_Open
Lookups (built-in): lsearch wildlsearch nwildlsearch iplsearch cdb dbm dbmjz dbmnz dnsdb dsearch ldap ldapdn ldapm mysql nis nis0 passwd pgsql sqlite
Authenticators: cram_md5 cyrus_sasl dovecot plaintext spa tls
Routers: accept dnslookup ipliteral iplookup manualroute queryprogram redirect
Transports: appendfile/maildir/mailstore/mbx autoreply lmtp pipe smtp
Malware: f-protd f-prot6d drweb fsecure sophie clamd avast sock cmdline
Fixed never_users: 0
Configure owner: 0:0
Size of off_t: 8
Compiler: GCC [8.2.0]
Library version: Glibc: Compile: 2.28
                        Runtime: 2.28
Library version: BDB: Compile: Berkeley DB 5.3.28: (September  9, 2013)
                      Runtime: Berkeley DB 5.3.28: (September  9, 2013)
Library version: GnuTLS: Compile: 3.6.6
                         Runtime: 3.6.6
Library version: Cyrus SASL: Compile: 2.1.27
                             Runtime: 2.1.27 [Cyrus SASL]
Library version: PCRE: Compile: 8.39
                       Runtime: 8.39 2016-06-14
05:45:19 22432 Total 19 lookups
Library version: MySQL: Compile: 100312 10.3.12 [mariadb-10.3]
                        Runtime: 100313 10.3.13
Library version: SQLite: Compile: 3.27.1
                         Runtime: 3.27.2
WHITELIST_D_MACROS: "OUTGOING"
TRUSTED_CONFIG_LIST: "/etc/exim4/trusted_configs"
05:45:19 22432 changed uid/gid: -C, -D, -be or -bf forces real uid
05:45:19 22432   uid=107 gid=112 pid=22432
05:45:19 22432   auxiliary group list: 112
05:45:19 22432 seeking password data for user "uucp": cache not available
05:45:19 22432 getpwnam() succeeded uid=10 gid=10
05:45:19 22432 configuration file is /var/lib/exim4/config.autogenerated
05:45:19 22432 log selectors = 0000cffc c6401022 00000001
05:45:19 22432 LOG: MAIN PANIC
05:45:19 22432   exim user lost privilege for using -C option
05:45:19 22432 cwd=/var/spool/exim4 6 args: /usr/sbin/exim4 -C /var/lib/exim4/config.autogenerated -d=0xfff9ffff -Mc 1h9kKN-0005pn-0n
05:45:19 22432 trusted user
05:45:19 22432 admin user
05:45:19 22432 seeking password data for user "mail": cache not available
05:45:19 22432 getpwnam() succeeded uid=8 gid=8
05:45:19 22432 set_process_info: 22432 delivering specified messages
05:45:19 22432 set_process_info: 22432 delivering 1h9kKN-0005pn-0n
05:45:19 22432 Trying spool file /var/spool/exim4//input//1h9kKN-0005pn-0n-D
05:45:19 22432 reading spool file 1h9kKN-0005pn-0n-H
05:45:19 22432 user=Debian-exim uid=107 gid=112 sender=krichel@openlib.org
05:45:19 22432 sender_fullhost = amorp.openlib.org [136.243.149.87]
05:45:19 22432 sender_rcvhost = amorp.openlib.org ([136.243.149.87])
05:45:19 22432 sender_local=0 ident=unset
05:45:19 22432 Non-recipients:
05:45:19 22432 Empty Tree
05:45:19 22432 ---- End of tree ----
05:45:19 22432 recipients_count=1
05:45:19 22432 **** SPOOL_IN - No additional fields
05:45:19 22432 body_linecount=1 message_linecount=30
05:45:19 22432 DSN: set orcpt:   flags: 0
05:45:19 22432 Delivery address list:
05:45:19 22432   krichel@darni.openlib.org 
05:45:19 22432  locking /var/spool/exim4/db/retry.lockfile
05:45:19 22432  locked  /var/spool/exim4/db/retry.lockfile
05:45:19 22432  EXIM_DBOPEN: file </var/spool/exim4/db/retry> dir </var/spool/exim4/db> flags=O_RDONLY
05:45:19 22432  returned from EXIM_DBOPEN: 0x55fd94e876e0
05:45:19 22432  opened hints database /var/spool/exim4/db/retry: flags=O_RDONLY
05:45:19 22432 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
05:45:19 22432 Considering: krichel@darni.openlib.org
05:45:19 22432 unique = krichel@darni.openlib.org
05:45:19 22432  dbfn_read: key=R:darni.openlib.org
05:45:19 22432  dbfn_read: key=R:krichel@darni.openlib.org
05:45:19 22432  dbfn_read: key=R:krichel@darni.openlib.org:<krichel@openlib.org>
05:45:19 22432 no   domain  retry record
05:45:19 22432 no   address retry record
05:45:19 22432 krichel@darni.openlib.org: queued for routing
05:45:19 22432  EXIM_DBCLOSE(0x55fd94e876e0)
05:45:19 22432  closed hints database and lockfile
05:45:19 22432 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
05:45:19 22432 routing krichel@darni.openlib.org
05:45:19 22432 --------> hubbed_hosts router <--------
05:45:19 22432 local_part=krichel domain=darni.openlib.org
05:45:19 22432 checking domains
05:45:19 22432  ┌considering: ${if exists{/etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/hubbed_hosts}fail}
05:45:19 22432   ┌considering: /etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/hubbed_hosts}fail}
05:45:19 22432   ├──expanding: /etc/exim4/hubbed_hosts
05:45:19 22432   └─────result: /etc/exim4/hubbed_hosts
05:45:19 22432  ├──condition: exists{/etc/exim4/hubbed_hosts}
05:45:19 22432  ├─────result: false
05:45:19 22432   ┌───scanning: partial-lsearch;/etc/exim4/hubbed_hosts}fail}
05:45:19 22432   ├──expanding: partial-lsearch;/etc/exim4/hubbed_hosts
05:45:19 22432   ├─────result: partial-lsearch;/etc/exim4/hubbed_hosts
05:45:19 22432   └───skipping: result is not used
05:45:19 22432  ├failed to expand: ${if exists{/etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/hubbed_hosts}fail}
05:45:19 22432  ├───error message: "if" failed and "fail" requested
05:45:19 22432  └failure was forced
05:45:19 22432 expansion of "${if exists{/etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/hubbed_hosts}fail}" forced failure: assume not in this list
05:45:19 22432 hubbed_hosts router skipped: domains mismatch
05:45:19 22432 --------> dnslookup_relay_to_domains router <--------
05:45:19 22432 local_part=krichel domain=darni.openlib.org
05:45:19 22432 checking domains
05:45:19 22432 darni.openlib.org in "@:localhost:3lib.org:darni.openlib.org:lists.openlib.org:authorclaim.org"? yes (matched "darni.openlib.org")
05:45:19 22432 darni.openlib.org in "! +local_domains : +relay_to_domains"? no (matched "! +local_domains")
05:45:19 22432 dnslookup_relay_to_domains router skipped: domains mismatch
05:45:19 22432 --------> dnslookup router <--------
05:45:19 22432 local_part=krichel domain=darni.openlib.org
05:45:19 22432 checking domains
05:45:19 22432 cached yes match for +local_domains
05:45:19 22432 cached lookup data = NULL
05:45:19 22432 darni.openlib.org in "! +local_domains"? no (matched "! +local_domains" - cached)
05:45:19 22432 dnslookup router skipped: domains mismatch
05:45:19 22432 --------> real_local router <--------
05:45:19 22432 local_part=krichel domain=darni.openlib.org
05:45:19 22432 real_local router skipped: prefix mismatch
05:45:19 22432 --------> system_aliases router <--------
05:45:19 22432 local_part=krichel domain=darni.openlib.org
05:45:19 22432 checking domains
05:45:19 22432 cached yes match for +local_domains
05:45:19 22432 cached lookup data = NULL
05:45:19 22432 darni.openlib.org in "+local_domains"? yes (matched "+local_domains" - cached)
05:45:19 22432  ┌considering: R: system_aliases for $local_part@$domain
05:45:19 22432  ├──expanding: R: system_aliases for $local_part@$domain
05:45:19 22432  └─────result: R: system_aliases for krichel@darni.openlib.org
05:45:19 22432 R: system_aliases for krichel@darni.openlib.org
05:45:19 22432 calling system_aliases router
05:45:19 22432 rda_interpret (string): ${lookup{$local_part}lsearch{/etc/aliases}}
05:45:19 22432  ┌considering: ${lookup{$local_part}lsearch{/etc/aliases}}
05:45:19 22432   ┌considering: $local_part}lsearch{/etc/aliases}}
05:45:19 22432   ├──expanding: $local_part
05:45:19 22432   └─────result: krichel
05:45:19 22432   ┌considering: /etc/aliases}}
05:45:19 22432   ├──expanding: /etc/aliases
05:45:19 22432   └─────result: /etc/aliases
05:45:19 22432 search_open: lsearch "/etc/aliases"
05:45:19 22432 search_find: file="/etc/aliases"
05:45:19 22432   key="krichel" partial=-1 affix=NULL starflags=0
05:45:19 22432 LRU list:
05:45:19 22432   :/etc/aliases
05:45:19 22432   End
05:45:19 22432 internal_search_find: file="/etc/aliases"
05:45:19 22432   type=lsearch key="krichel"
05:45:19 22432 file lookup required for krichel
05:45:19 22432   in /etc/aliases
05:45:19 22432 lookup failed
05:45:19 22432  ├──expanding: ${lookup{$local_part}lsearch{/etc/aliases}}
05:45:19 22432  └─────result: 
05:45:19 22432 expanded: 
05:45:19 22432 file is not a filter file
05:45:19 22432 parse_forward_list: 
05:45:19 22432 system_aliases router declined for krichel@darni.openlib.org
05:45:19 22432 --------> userforward router <--------
05:45:19 22432 local_part=krichel domain=darni.openlib.org
05:45:19 22432 checking domains
05:45:19 22432 cached yes match for +local_domains
05:45:19 22432 cached lookup data = NULL
05:45:19 22432 darni.openlib.org in "+local_domains"? yes (matched "+local_domains" - cached)
05:45:19 22432 checking for local user
05:45:19 22432 seeking password data for user "krichel": cache not available
05:45:19 22432 getpwnam() succeeded uid=1007 gid=1007
05:45:19 22432  ┌considering: R: userforward for $local_part@$domain
05:45:19 22432  ├──expanding: R: userforward for $local_part@$domain
05:45:19 22432  └─────result: R: userforward for krichel@darni.openlib.org
05:45:19 22432 R: userforward for krichel@darni.openlib.org
05:45:19 22432 checking require_files
05:45:19 22432  ┌considering: $local_part
05:45:19 22432  ├──expanding: $local_part
05:45:19 22432  └─────result: krichel
05:45:19 22432 seeking password data for user "krichel": using cached result
05:45:19 22432 getpwnam() succeeded uid=1007 gid=1007
05:45:19 22432 check subsequent files for access by krichel
05:45:19 22432  ┌considering: $home/.forward
05:45:19 22432  ├──expanding: $home/.forward
05:45:19 22432  └─────result: /home/krichel/.forward
05:45:19 22432 file check: $home/.forward
05:45:19 22432 expanded file: /home/krichel/.forward
05:45:19 22432 stat() yielded -1
05:45:19 22432 errno = 2
05:45:19 22432 userforward router skipped: file check
05:45:19 22432 --------> procmail router <--------
05:45:19 22432 local_part=krichel domain=darni.openlib.org
05:45:19 22432 checking domains
05:45:19 22432 cached yes match for +local_domains
05:45:19 22432 cached lookup data = NULL
05:45:19 22432 darni.openlib.org in "+local_domains"? yes (matched "+local_domains" - cached)
05:45:19 22432 checking for local user
05:45:19 22432 seeking password data for user "krichel": using cached result
05:45:19 22432 getpwnam() succeeded uid=1007 gid=1007
05:45:19 22432  ┌considering: R: procmail for $local_part@$domain
05:45:19 22432  ├──expanding: R: procmail for $local_part@$domain
05:45:19 22432  └─────result: R: procmail for krichel@darni.openlib.org
05:45:19 22432 R: procmail for krichel@darni.openlib.org
05:45:19 22432 checking require_files
05:45:19 22432  ┌considering: ${local_part}
05:45:19 22432  ├──expanding: ${local_part}
05:45:19 22432  └─────result: krichel
05:45:19 22432 seeking password data for user "krichel": using cached result
05:45:19 22432 getpwnam() succeeded uid=1007 gid=1007
05:45:19 22432 check subsequent files for access by krichel
05:45:19 22432  ┌considering: ${if exists{/etc/procmailrc}{/etc/procmailrc}{${home}/.procmailrc}}
05:45:19 22432   ┌considering: /etc/procmailrc}{/etc/procmailrc}{${home}/.procmailrc}}
05:45:19 22432   ├──expanding: /etc/procmailrc
05:45:19 22432   └─────result: /etc/procmailrc
05:45:19 22432  ├──condition: exists{/etc/procmailrc}
05:45:19 22432  ├─────result: false
05:45:19 22432   ┌───scanning: /etc/procmailrc}{${home}/.procmailrc}}
05:45:19 22432   ├──expanding: /etc/procmailrc
05:45:19 22432   ├─────result: /etc/procmailrc
05:45:19 22432   └───skipping: result is not used
05:45:19 22432   ┌considering: ${home}/.procmailrc}}
05:45:19 22432   ├──expanding: ${home}/.procmailrc
05:45:19 22432   └─────result: /home/krichel/.procmailrc
05:45:19 22432  ├──expanding: ${if exists{/etc/procmailrc}{/etc/procmailrc}{${home}/.procmailrc}}
05:45:19 22432  └─────result: /home/krichel/.procmailrc
05:45:19 22432 file check: ${if exists{/etc/procmailrc}{/etc/procmailrc}{${home}/.procmailrc}}
05:45:19 22432 expanded file: /home/krichel/.procmailrc
05:45:19 22432 stat() yielded -1
05:45:19 22432 errno = 2
05:45:19 22432 procmail router skipped: file check
05:45:19 22432 --------> maildrop router <--------
05:45:19 22432 local_part=krichel domain=darni.openlib.org
05:45:19 22432 checking domains
05:45:19 22432 cached yes match for +local_domains
05:45:19 22432 cached lookup data = NULL
05:45:19 22432 darni.openlib.org in "+local_domains"? yes (matched "+local_domains" - cached)
05:45:19 22432 checking for local user
05:45:19 22432 seeking password data for user "krichel": using cached result
05:45:19 22432 getpwnam() succeeded uid=1007 gid=1007
05:45:19 22432  ┌considering: R: maildrop for $local_part@$domain
05:45:19 22432  ├──expanding: R: maildrop for $local_part@$domain
05:45:19 22432  └─────result: R: maildrop for krichel@darni.openlib.org
05:45:19 22432 R: maildrop for krichel@darni.openlib.org
05:45:19 22432 checking require_files
05:45:19 22432  ┌considering: ${local_part}
05:45:19 22432  ├──expanding: ${local_part}
05:45:19 22432  └─────result: krichel
05:45:19 22432 seeking password data for user "krichel": using cached result
05:45:19 22432 getpwnam() succeeded uid=1007 gid=1007
05:45:19 22432 check subsequent files for access by krichel
05:45:19 22432  ┌considering: ${home}/.mailfilter
05:45:19 22432  ├──expanding: ${home}/.mailfilter
05:45:19 22432  └─────result: /home/krichel/.mailfilter
05:45:19 22432 file check: ${home}/.mailfilter
05:45:19 22432 expanded file: /home/krichel/.mailfilter
05:45:19 22432 stat() yielded -1
05:45:19 22432 errno = 2
05:45:19 22432 maildrop router skipped: file check
05:45:19 22432 --------> lowuid_aliases router <--------
05:45:19 22432 local_part=krichel domain=darni.openlib.org
05:45:19 22432 checking domains
05:45:19 22432 cached yes match for +local_domains
05:45:19 22432 cached lookup data = NULL
05:45:19 22432 darni.openlib.org in "+local_domains"? yes (matched "+local_domains" - cached)
05:45:19 22432 checking for local user
05:45:19 22432 seeking password data for user "krichel": using cached result
05:45:19 22432 getpwnam() succeeded uid=1007 gid=1007
05:45:19 22432  ┌considering: R: lowuid_aliases for $local_part@$domain (UID $local_user_uid)
05:45:19 22432  ├──expanding: R: lowuid_aliases for $local_part@$domain (UID $local_user_uid)
05:45:19 22432  └─────result: R: lowuid_aliases for krichel@darni.openlib.org (UID 1007)
05:45:19 22432 R: lowuid_aliases for krichel@darni.openlib.org (UID 1007)
05:45:19 22432 checking "condition" "${if and{{! match_ip{$sender_host_address}{:@[]}}{<{$local_user_uid}{0}}}{1}{0}}"...
05:45:19 22432  ┌considering: ${if and{{! match_ip{$sender_host_address}{:@[]}}{<{$local_user_uid}{0}}}{1}{0}}
05:45:19 22432   ┌considering: $sender_host_address}{:@[]}}{<{$local_user_uid}{0}}}{1}{0}}
05:45:19 22432   ├──expanding: $sender_host_address
05:45:19 22432   └─────result: 136.243.149.87
05:45:19 22432   ┌considering: :@[]}}{<{$local_user_uid}{0}}}{1}{0}}
05:45:19 22432   ├──expanding: :@[]
05:45:19 22432   └─────result: :@[]
05:45:19 22432 Actual local interface address is 127.0.0.1 (lo)
05:45:19 22432 Actual local interface address is 95.216.35.87 (enp0s31f6)
05:45:19 22432 Actual local interface address is 2a01:4f9:2a:23a8::2 (enp0s31f6)
05:45:19 22432 Actual local interface address is ::1 (lo)
05:45:19 22432 Actual local interface address is fe80::921b:eff:fefb:a95c (enp0s31f6)
05:45:19 22432 Configured local interface: address=::1
05:45:19 22432 136.243.149.87 in ":@[]"? no (end of list)
05:45:19 22432   ┌considering: $local_user_uid}{0}}}{1}{0}}
05:45:19 22432   ├──expanding: $local_user_uid
05:45:19 22432   └─────result: 1007
05:45:19 22432   ┌considering: 0}}}{1}{0}}
05:45:19 22432   ├──expanding: 0
05:45:19 22432   └─────result: 0
05:45:19 22432  ├──condition: and{{! match_ip{$sender_host_address}{:@[]}}{<{$local_user_uid}{0}}}
05:45:19 22432  ├─────result: false
05:45:19 22432   ┌───scanning: 1}{0}}
05:45:19 22432   ├──expanding: 1
05:45:19 22432   ├─────result: 1
05:45:19 22432   └───skipping: result is not used
05:45:19 22432   ┌considering: 0}}
05:45:19 22432   ├──expanding: 0
05:45:19 22432   └─────result: 0
05:45:19 22432  ├──expanding: ${if and{{! match_ip{$sender_host_address}{:@[]}}{<{$local_user_uid}{0}}}{1}{0}}
05:45:19 22432  └─────result: 0
05:45:19 22432 lowuid_aliases router skipped: condition failure
05:45:19 22432 --------> local_user router <--------
05:45:19 22432 local_part=krichel domain=darni.openlib.org
05:45:19 22432 checking domains
05:45:19 22432 cached yes match for +local_domains
05:45:19 22432 cached lookup data = NULL
05:45:19 22432 darni.openlib.org in "+local_domains"? yes (matched "+local_domains" - cached)
05:45:19 22432 checking local_parts
05:45:19 22432 krichel in "! root"? yes (end of list)
05:45:19 22432 checking for local user
05:45:19 22432 seeking password data for user "krichel": using cached result
05:45:19 22432 getpwnam() succeeded uid=1007 gid=1007
05:45:19 22432  ┌considering: R: local_user for $local_part@$domain
05:45:19 22432  ├──expanding: R: local_user for $local_part@$domain
05:45:19 22432  └─────result: R: local_user for krichel@darni.openlib.org
05:45:19 22432 R: local_user for krichel@darni.openlib.org
05:45:19 22432 calling local_user router
05:45:19 22432 local_user router called for krichel@darni.openlib.org
05:45:19 22432   domain = darni.openlib.org
05:45:19 22432 set transport mail_spool
05:45:19 22432 queued for mail_spool transport: local_part = krichel
05:45:19 22432 domain = darni.openlib.org
05:45:19 22432   errors_to=NULL
05:45:19 22432   domain_data=NULL localpart_data=NULL
05:45:19 22432 routed by local_user router
05:45:19 22432   envelope to: krichel@darni.openlib.org
05:45:19 22432   transport: mail_spool
05:45:19 22432 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
05:45:19 22432 After routing:
05:45:19 22432   Local deliveries:
05:45:19 22432     krichel@darni.openlib.org
05:45:19 22432   Remote deliveries:
05:45:19 22432   Failed addresses:
05:45:19 22432   Deferred addresses:
05:45:19 22432 search_tidyup called
05:45:19 22432 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
05:45:19 22432 --------> krichel@darni.openlib.org <--------
05:45:19 22432  locking /var/spool/exim4/db/retry.lockfile
05:45:19 22432  locked  /var/spool/exim4/db/retry.lockfile
05:45:19 22432  EXIM_DBOPEN: file </var/spool/exim4/db/retry> dir </var/spool/exim4/db> flags=O_RDONLY
05:45:19 22432  returned from EXIM_DBOPEN: 0x55fd94ec4260
05:45:19 22432  opened hints database /var/spool/exim4/db/retry: flags=O_RDONLY
05:45:19 22432  dbfn_read: key=T:krichel@darni.openlib.org
05:45:19 22432 retry record exists: age=11m30s (max 1w)
05:45:19 22432   time to retry = 3m30s expired = 0
05:45:19 22432  EXIM_DBCLOSE(0x55fd94ec4260)
05:45:19 22432  closed hints database and lockfile
05:45:19 22432 search_tidyup called
05:45:19 22433 LOG: MAIN PANIC DIE
05:45:19 22433   unable to set gid=8 or uid=1007 (euid=107): local delivery to krichel <krichel@darni.openlib.org> transport=mail_spool
05:45:19 22433 search_tidyup called
05:45:19 22433 >>>>>>>>>>>>>>>> Exim pid=22433 NULLterminating with rc=1 >>>>>>>>>>>>>>>>
05:45:19 22432 LOG: MAIN PANIC
05:45:19 22432   failed to read delivery status for krichel@darni.openlib.org from delivery subprocess
05:45:19 22432 LOG: MAIN PANIC
05:45:19 22432   appendfile transport process returned non-zero status 0x0100: exit code 1
05:45:19 22432 mail_spool transport returned DEFER for krichel@darni.openlib.org
05:45:19 22432 added retry item for T:krichel@darni.openlib.org: errno=-1 more_errno=0 flags=0
05:45:19 22432 post-process krichel@darni.openlib.org (1)
05:45:19 22432 LOG: MAIN
05:45:19 22432   == krichel@darni.openlib.org R=local_user T=mail_spool defer (-1)
05:45:19 22432 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
05:45:19 22432 changed uid/gid: post-delivery tidying
05:45:19 22432   uid=107 gid=112 pid=22432
05:45:19 22432   auxiliary group list: 112
05:45:19 22432 set_process_info: 22432 tidying up after delivering 1h9kKN-0005pn-0n
05:45:19 22432 Processing retry items
05:45:19 22432 Succeeded addresses:
05:45:19 22432 Failed addresses:
05:45:19 22432 Deferred addresses:
05:45:19 22432  krichel@darni.openlib.org
05:45:19 22432  locking /var/spool/exim4/db/retry.lockfile
05:45:19 22432  locked  /var/spool/exim4/db/retry.lockfile
05:45:19 22432  EXIM_DBOPEN: file </var/spool/exim4/db/retry> dir </var/spool/exim4/db> flags=O_RDWR
05:45:19 22432  returned from EXIM_DBOPEN: 0x55fd94ec4260
05:45:19 22432  opened hints database /var/spool/exim4/db/retry: flags=O_RDWR
05:45:19 22432 address match test: subject=krichel@darni.openlib.org pattern=*
05:45:19 22432 darni.openlib.org in "*"? yes (matched "*")
05:45:19 22432 krichel@darni.openlib.org in "*"? yes (matched "*")
05:45:19 22432 retry for T:krichel@darni.openlib.org = * 0 0
05:45:19 22432  dbfn_read: key=T:krichel@darni.openlib.org
05:45:19 22432 failing_interval=690 message_age=0
05:45:19 22432 Writing retry data for T:krichel@darni.openlib.org
05:45:19 22432   first failed=1553837629 last try=1553838319 next try=1553839219 expired=0
05:45:19 22432   errno=-1 more_errno=0 unknown error
05:45:19 22432  dbfn_write: key=T:krichel@darni.openlib.org
05:45:19 22432  EXIM_DBCLOSE(0x55fd94ec4260)
05:45:19 22432  closed hints database and lockfile
05:45:19 22432 end of retry processing
05:45:19 22432  ┌considering: ${if or {{ !eq{$h_list-id:$h_list-post:$h_list-subscribe:}{} }{ match{$h_precedence:}{(?i)bulk|list|junk} }{ match{$h_auto-submitted:}{(?i)auto-generated|auto-replied} }} {no}{yes}}
05:45:19 22432   ┌considering: $h_list-id:$h_list-post:$h_list-subscribe:}{} }{ match{$h_precedence:}{(?i)bulk|list|junk} }{ match{$h_auto-submitted:}{(?i)auto-generated|auto-replied} }} {no}{yes}}
05:45:19 22432   ├──expanding: $h_list-id:$h_list-post:$h_list-subscribe:
05:45:19 22432   └─────result: 
05:45:19 22432   ┌considering: } }{ match{$h_precedence:}{(?i)bulk|list|junk} }{ match{$h_auto-submitted:}{(?i)auto-generated|auto-replied} }} {no}{yes}}
05:45:19 22432   ├──expanding: 
05:45:19 22432   └─────result: 
05:45:19 22432   ┌considering: $h_precedence:}{(?i)bulk|list|junk} }{ match{$h_auto-submitted:}{(?i)auto-generated|auto-replied} }} {no}{yes}}
05:45:19 22432   ├──expanding: $h_precedence:
05:45:19 22432   └─────result: 
05:45:19 22432   ┌considering: (?i)bulk|list|junk} }{ match{$h_auto-submitted:}{(?i)auto-generated|auto-replied} }} {no}{yes}}
05:45:19 22432   ├──expanding: (?i)bulk|list|junk
05:45:19 22432   └─────result: (?i)bulk|list|junk
05:45:19 22432   ┌considering: $h_auto-submitted:}{(?i)auto-generated|auto-replied} }} {no}{yes}}
05:45:19 22432   ├──expanding: $h_auto-submitted:
05:45:19 22432   └─────result: 
05:45:19 22432   ┌considering: (?i)auto-generated|auto-replied} }} {no}{yes}}
05:45:19 22432   ├──expanding: (?i)auto-generated|auto-replied
05:45:19 22432   └─────result: (?i)auto-generated|auto-replied
05:45:19 22432  ├──condition: or {{ !eq{$h_list-id:$h_list-post:$h_list-subscribe:}{} }{ match{$h_precedence:}{(?i)bulk|list|junk} }{ match{$h_auto-submitted:}{(?i)auto-generated|auto-replied} }}
05:45:19 22432  ├─────result: false
05:45:19 22432   ┌───scanning: no}{yes}}
05:45:19 22432   ├──expanding: no
05:45:19 22432   ├─────result: no
05:45:19 22432   └───skipping: result is not used
05:45:19 22432   ┌considering: yes}}
05:45:19 22432   ├──expanding: yes
05:45:19 22432   └─────result: yes
05:45:19 22432  ├──expanding: ${if or {{ !eq{$h_list-id:$h_list-post:$h_list-subscribe:}{} }{ match{$h_precedence:}{(?i)bulk|list|junk} }{ match{$h_auto-submitted:}{(?i)auto-generated|auto-replied} }} {no}{yes}}
05:45:19 22432  └─────result: yes
05:45:19 22432 time on queue = 0s  id 1h9kKN-0005pn-0n  addr krichel@darni.openlib.org
05:45:19 22432 warning counts: required 0 done 0
05:45:19 22432  ┌considering: Mail Delivery System <Mailer-Daemon@$qualify_domain>
05:45:19 22432  ├──expanding: Mail Delivery System <Mailer-Daemon@$qualify_domain>
05:45:19 22432  └─────result: Mail Delivery System <Mailer-Daemon@darni>
05:45:19 22434 exec /usr/sbin/exim4 -C /var/lib/exim4/config.autogenerated -d=0xfff9ffff -t -oem -oi -f <> -E1h9kKN-0005pn-0n
05:45:19 22431 SMTP<< QUIT
05:45:19 22431 SMTP>> 221 darni closing connection
05:45:19 22431 LOG: smtp_connection MAIN
05:45:19 22431   SMTP connection from amorp.openlib.org [136.243.149.87] closed by QUIT
05:45:19 22431 search_tidyup called
05:45:19 22431 SMTP>>(close on process exit)
05:45:19 22430 child 22431 ended: status=0x0
05:45:19 22430   normal exit, 0
05:45:19 22430 0 SMTP accept processes now running
05:45:19 22430 Listening...
05:45:19 22434 Exim version 4.92 uid=107 gid=112 pid=22434 D=fff9ffff
Support for: crypteq iconv() IPv6 PAM Perl Expand_dlfunc GnuTLS move_frozen_messages Content_Scanning DANE DKIM DNSSEC Event OCSP PRDR PROXY SOCKS TCP_Fast_Open
Lookups (built-in): lsearch wildlsearch nwildlsearch iplsearch cdb dbm dbmjz dbmnz dnsdb dsearch ldap ldapdn ldapm mysql nis nis0 passwd pgsql sqlite
Authenticators: cram_md5 cyrus_sasl dovecot plaintext spa tls
Routers: accept dnslookup ipliteral iplookup manualroute queryprogram redirect
Transports: appendfile/maildir/mailstore/mbx autoreply lmtp pipe smtp
Malware: f-protd f-prot6d drweb fsecure sophie clamd avast sock cmdline
Fixed never_users: 0
Configure owner: 0:0
Size of off_t: 8
Compiler: GCC [8.2.0]
Library version: Glibc: Compile: 2.28
                        Runtime: 2.28
Library version: BDB: Compile: Berkeley DB 5.3.28: (September  9, 2013)
                      Runtime: Berkeley DB 5.3.28: (September  9, 2013)
Library version: GnuTLS: Compile: 3.6.6
                         Runtime: 3.6.6
Library version: Cyrus SASL: Compile: 2.1.27
                             Runtime: 2.1.27 [Cyrus SASL]
Library version: PCRE: Compile: 8.39
                       Runtime: 8.39 2016-06-14
05:45:19 22434 Total 19 lookups
Library version: MySQL: Compile: 100312 10.3.12 [mariadb-10.3]
                        Runtime: 100313 10.3.13
Library version: SQLite: Compile: 3.27.1
                         Runtime: 3.27.2
WHITELIST_D_MACROS: "OUTGOING"
TRUSTED_CONFIG_LIST: "/etc/exim4/trusted_configs"
05:45:19 22434 changed uid/gid: -C, -D, -be or -bf forces real uid
05:45:19 22434   uid=107 gid=112 pid=22434
05:45:19 22434   auxiliary group list: 112
05:45:19 22434 seeking password data for user "uucp": cache not available
05:45:19 22434 getpwnam() succeeded uid=10 gid=10
05:45:19 22434 configuration file is /var/lib/exim4/config.autogenerated
05:45:19 22434 log selectors = 0000cffc c6401022 00000001
05:45:19 22434 LOG: MAIN PANIC
05:45:19 22434   exim user lost privilege for using -C option
05:45:19 22434 cwd=/var/spool/exim4 10 args: /usr/sbin/exim4 -C /var/lib/exim4/config.autogenerated -d=0xfff9ffff -t -oem -oi -f <> -E1h9kKN-0005pn-0n
05:45:19 22434 trusted user
05:45:19 22434 admin user
05:45:19 22434 seeking password data for user "mail": cache not available
05:45:19 22434 getpwnam() succeeded uid=8 gid=8
05:45:19 22434 originator: uid=107 gid=112 login=Debian-exim name=
05:45:19 22434 sender address = 
05:45:19 22434 set_process_info: 22434 accepting a local non-SMTP message from <>
05:45:19 22434 spool directory space = 1524289592K inodes = 229582686 check_space = 10240K inodes = 100 msg_size = 0
05:45:19 22434 log directory space = 1524289592K inodes = 229582686 check_space = 10240K inodes = 100
05:45:19 22434 Sender: 
05:45:19 22434 search_tidyup called
05:45:19 22434 >>Headers received:
05:45:19 22434 Auto-Submitted: auto-replied
05:45:19 22434 From: Mail Delivery System <Mailer-Daemon@darni>
05:45:19 22434 To: postmaster
05:45:19 22434 Subject: Message frozen
05:45:19 22434 
05:45:19 22434 rewrite_one_header: type=F:
05:45:19 22434   From: Mail Delivery System <Mailer-Daemon@darni>
05:45:19 22434 address match test: subject=Mailer-Daemon@darni pattern=*@+local_domains
05:45:19 22434 darni in "@:localhost:3lib.org:darni.openlib.org:lists.openlib.org:authorclaim.org"? yes (matched "@")
05:45:19 22434 darni in "+local_domains"? yes (matched "+local_domains")
05:45:19 22434 Mailer-Daemon@darni in "*@+local_domains"? yes (matched "*@+local_domains")
05:45:19 22434  ┌considering: ${lookup{${local_part}}lsearch{/etc/email-addresses}{$value}fail}
05:45:19 22434   ┌considering: ${local_part}}lsearch{/etc/email-addresses}{$value}fail}
05:45:19 22434   ├──expanding: ${local_part}
05:45:19 22434   └─────result: Mailer-Daemon
05:45:19 22434   ┌considering: /etc/email-addresses}{$value}fail}
05:45:19 22434   ├──expanding: /etc/email-addresses
05:45:19 22434   └─────result: /etc/email-addresses
05:45:19 22434 search_open: lsearch "/etc/email-addresses"
05:45:19 22434 search_find: file="/etc/email-addresses"
05:45:19 22434   key="Mailer-Daemon" partial=-1 affix=NULL starflags=0
05:45:19 22434 LRU list:
05:45:19 22434   :/etc/email-addresses
05:45:19 22434   End
05:45:19 22434 internal_search_find: file="/etc/email-addresses"
05:45:19 22434   type=lsearch key="Mailer-Daemon"
05:45:19 22434 file lookup required for Mailer-Daemon
05:45:19 22434   in /etc/email-addresses
05:45:19 22434 lookup failed
05:45:19 22434   ┌───scanning: $value}fail}
05:45:19 22434   ├──expanding: $value
05:45:19 22434   ├─────result: 
05:45:19 22434   └───skipping: result is not used
05:45:19 22434  ├failed to expand: ${lookup{${local_part}}lsearch{/etc/email-addresses}{$value}fail}
05:45:19 22434  ├───error message: "lookup" failed and "fail" requested
05:45:19 22434  └failure was forced
05:45:19 22434 address match test: subject=Mailer-Daemon@darni pattern=*@darni
05:45:19 22434 darni in "darni"? yes (matched "darni")
05:45:19 22434 Mailer-Daemon@darni in "*@darni"? yes (matched "*@darni")
05:45:19 22434  ┌considering: ${lookup{${local_part}}lsearch{/etc/email-addresses}{$value}fail}
05:45:19 22434   ┌considering: ${local_part}}lsearch{/etc/email-addresses}{$value}fail}
05:45:19 22434   ├──expanding: ${local_part}
05:45:19 22434   └─────result: Mailer-Daemon
05:45:19 22434   ┌considering: /etc/email-addresses}{$value}fail}
05:45:19 22434   ├──expanding: /etc/email-addresses
05:45:19 22434   └─────result: /etc/email-addresses
05:45:19 22434 search_open: lsearch "/etc/email-addresses"
05:45:19 22434   cached open
05:45:19 22434 search_find: file="/etc/email-addresses"
05:45:19 22434   key="Mailer-Daemon" partial=-1 affix=NULL starflags=0
05:45:19 22434 LRU list:
05:45:19 22434   :/etc/email-addresses
05:45:19 22434   End
05:45:19 22434 internal_search_find: file="/etc/email-addresses"
05:45:19 22434   type=lsearch key="Mailer-Daemon"
05:45:19 22434 cached data used for lookup of Mailer-Daemon
05:45:19 22434   in /etc/email-addresses
05:45:19 22434 lookup failed
05:45:19 22434   ┌───scanning: $value}fail}
05:45:19 22434   ├──expanding: $value
05:45:19 22434   ├─────result: 
05:45:19 22434   └───skipping: result is not used
05:45:19 22434  ├failed to expand: ${lookup{${local_part}}lsearch{/etc/email-addresses}{$value}fail}
05:45:19 22434  ├───error message: "lookup" failed and "fail" requested
05:45:19 22434  └failure was forced
05:45:19 22434 rewrite_one_header: type=T:
05:45:19 22434   To: postmaster
05:45:19 22434 newlen=21 newtype=T newtext:
05:45:19 22434 To: postmaster@darni
05:45:19 22434 remainder: 
05:45:19 22434 search_tidyup called
05:45:19 22434 >>Headers after rewriting and local additions:
05:45:19 22434   Auto-Submitted: auto-replied
05:45:19 22434 F From: Mail Delivery System <Mailer-Daemon@darni>
05:45:19 22434 * To: postmaster
05:45:19 22434 T To: postmaster@darni
05:45:19 22434   Subject: Message frozen
05:45:19 22434 I Message-Id: <E1h9kKN-0005pq-8l@darni>
05:45:19 22434   Date: Fri, 29 Mar 2019 05:45:19 +0000
05:45:19 22434 
05:45:19 22434 Data file name: /var/spool/exim4//input//1h9kKN-0005pq-8l-D
05:45:19 22434 Data file written for message 1h9kKN-0005pq-8l
05:45:19 22434  ┌considering: ${tod_full}
05:45:19 22434  ├──expanding: ${tod_full}
05:45:19 22434  └─────result: Fri, 29 Mar 2019 05:45:19 +0000
05:45:19 22434  ┌considering: Received: ${if def:sender_rcvhost {from $sender_rcvhost
05:45:19 22434  	}{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
05:45:19 22434  	}}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
05:45:19 22434  	}}(Exim $version_number)
05:45:19 22434  	${if def:sender_address {(envelope-from <$sender_address>)
05:45:19 22434  	}}id $message_exim_id${if def:received_for {
05:45:19 22434  	for $received_for}}
05:45:19 22434  ├──condition: def:sender_rcvhost
05:45:19 22434  ├─────result: false
05:45:19 22434   ┌───scanning: from $sender_rcvhost
05:45:19 22434   	}{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
05:45:19 22434   	}}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
05:45:19 22434   	}}(Exim $version_number)
05:45:19 22434   	${if def:sender_address {(envelope-from <$sender_address>)
05:45:19 22434   	}}id $message_exim_id${if def:received_for {
05:45:19 22434   	for $received_for}}
05:45:19 22434   ├──expanding: from $sender_rcvhost
05:45:19 22434   	
05:45:19 22434   ├─────result: from 
05:45:19 22434   	
05:45:19 22434   └───skipping: result is not used
05:45:19 22434   ┌considering: ${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
05:45:19 22434   	}}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
05:45:19 22434   	}}(Exim $version_number)
05:45:19 22434   	${if def:sender_address {(envelope-from <$sender_address>)
05:45:19 22434   	}}id $message_exim_id${if def:received_for {
05:45:19 22434   	for $received_for}}
05:45:19 22434   ├──condition: def:sender_ident
05:45:19 22434   ├─────result: true
05:45:19 22434    ┌considering: from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
05:45:19 22434    	}}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
05:45:19 22434    	}}(Exim $version_number)
05:45:19 22434    	${if def:sender_address {(envelope-from <$sender_address>)
05:45:19 22434    	}}id $message_exim_id${if def:received_for {
05:45:19 22434    	for $received_for}}
05:45:19 22434    ╎┌considering: $sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
05:45:19 22434    ╎	}}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
05:45:19 22434    ╎	}}(Exim $version_number)
05:45:19 22434    ╎	${if def:sender_address {(envelope-from <$sender_address>)
05:45:19 22434    ╎	}}id $message_exim_id${if def:received_for {
05:45:19 22434    ╎	for $received_for}}
05:45:19 22434    ╎├──expanding: $sender_ident
05:45:19 22434    ╎└─────result: Debian-exim
05:45:19 22434    ├──expanding: from ${quote_local_part:$sender_ident} 
05:45:19 22434    └─────result: from Debian-exim 
05:45:19 22434   ├──condition: def:sender_helo_name
05:45:19 22434   ├─────result: false
05:45:19 22434    ┌───scanning: (helo=$sender_helo_name)
05:45:19 22434    	}}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
05:45:19 22434    	}}(Exim $version_number)
05:45:19 22434    	${if def:sender_address {(envelope-from <$sender_address>)
05:45:19 22434    	}}id $message_exim_id${if def:received_for {
05:45:19 22434    	for $received_for}}
05:45:19 22434    ├──expanding: (helo=$sender_helo_name)
05:45:19 22434    	
05:45:19 22434    ├─────result: (helo=)
05:45:19 22434    	
05:45:19 22434    └───skipping: result is not used
05:45:19 22434   ├──expanding: ${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
05:45:19 22434   	}}
05:45:19 22434   └─────result: from Debian-exim 
05:45:19 22434  ├──condition: def:received_protocol
05:45:19 22434  ├─────result: true
05:45:19 22434   ┌considering: with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
05:45:19 22434   	}}(Exim $version_number)
05:45:19 22434   	${if def:sender_address {(envelope-from <$sender_address>)
05:45:19 22434   	}}id $message_exim_id${if def:received_for {
05:45:19 22434   	for $received_for}}
05:45:19 22434   ├──expanding: with $received_protocol
05:45:19 22434   └─────result: with local
05:45:19 22434  ├──condition: def:tls_cipher
05:45:19 22434  ├─────result: false
05:45:19 22434   ┌───scanning: ($tls_cipher)
05:45:19 22434   	}}(Exim $version_number)
05:45:19 22434   	${if def:sender_address {(envelope-from <$sender_address>)
05:45:19 22434   	}}id $message_exim_id${if def:received_for {
05:45:19 22434   	for $received_for}}
05:45:19 22434   ├──expanding: ($tls_cipher)
05:45:19 22434   	
05:45:19 22434   ├─────result: ()
05:45:19 22434   	
05:45:19 22434   └───skipping: result is not used
05:45:19 22434  ├──condition: def:sender_address
05:45:19 22434  ├─────result: false
05:45:19 22434   ┌───scanning: (envelope-from <$sender_address>)
05:45:19 22434   	}}id $message_exim_id${if def:received_for {
05:45:19 22434   	for $received_for}}
05:45:19 22434   ├──expanding: (envelope-from <$sender_address>)
05:45:19 22434   	
05:45:19 22434   ├─────result: (envelope-from <>)
05:45:19 22434   	
05:45:19 22434   └───skipping: result is not used
05:45:19 22434  ├──condition: def:received_for
05:45:19 22434  ├─────result: true
05:45:19 22434   ┌considering: 
05:45:19 22434   	for $received_for}}
05:45:19 22434   ├──expanding: 
05:45:19 22434   	for $received_for
05:45:19 22434   └─────result: 
05:45:19 22434   	for postmaster@darni
05:45:19 22434  ├──expanding: Received: ${if def:sender_rcvhost {from $sender_rcvhost
05:45:19 22434  	}{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
05:45:19 22434  	}}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
05:45:19 22434  	}}(Exim $version_number)
05:45:19 22434  	${if def:sender_address {(envelope-from <$sender_address>)
05:45:19 22434  	}}id $message_exim_id${if def:received_for {
05:45:19 22434  	for $received_for}}
05:45:19 22434  └─────result: Received: from Debian-exim by darni with local (Exim 4.92)
05:45:19 22434  	id 1h9kKN-0005pq-8l
05:45:19 22434  	for postmaster@darni
05:45:19 22434 >>Generated Received: header line
05:45:19 22434 P Received: from Debian-exim by darni with local (Exim 4.92)
05:45:19 22434 	id 1h9kKN-0005pq-8l
05:45:19 22434 	for postmaster@darni; Fri, 29 Mar 2019 05:45:19 +0000
05:45:19 22434  ┌considering: ${tod_full}
05:45:19 22434  ├──expanding: ${tod_full}
05:45:19 22434  └─────result: Fri, 29 Mar 2019 05:45:19 +0000
05:45:19 22434 Writing spool header file: /var/spool/exim4//input//hdr.22434
05:45:19 22434 DSN: Write SPOOL :-dsn_envid NULL
05:45:19 22434 DSN: Write SPOOL :-dsn_ret 0
05:45:19 22434 DSN: Flags :0
05:45:19 22434 DSN: **** SPOOL_OUT - address: |postmaster@darni| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
05:45:19 22434 Renaming spool header file: /var/spool/exim4//input//1h9kKN-0005pq-8l-H
05:45:19 22434 Size of headers = 334
05:45:19 22434 LOG: MAIN
05:45:19 22434   <= <> R=1h9kKN-0005pn-0n U=Debian-exim P=local S=495
05:45:19 22434 search_tidyup called
05:45:19 22434 search_tidyup called
05:45:19 22434 >>>>>>>>>>>>>>>> Exim pid=22434 (main) terminating with rc=0 >>>>>>>>>>>>>>>>
05:45:19 22435 exec /usr/sbin/exim4 -C /var/lib/exim4/config.autogenerated -d=0xfff9ffff -Mc 1h9kKN-0005pq-8l
05:45:19 22432 LOG: MAIN
05:45:19 22432   Frozen
05:45:19 22432 delivery deferred: update_spool=1 header_rewritten=0
05:45:19 22432 Writing spool header file: /var/spool/exim4//input//hdr.22432
05:45:19 22432 DSN: Write SPOOL :-dsn_envid NULL
05:45:19 22432 DSN: Write SPOOL :-dsn_ret 0
05:45:19 22432 DSN: Flags :0
05:45:19 22432 DSN: **** SPOOL_OUT - address: |krichel@darni.openlib.org| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
05:45:19 22435 Exim version 4.92 uid=107 gid=112 pid=22435 D=fff9ffff
Support for: crypteq iconv() IPv6 PAM Perl Expand_dlfunc GnuTLS move_frozen_messages Content_Scanning DANE DKIM DNSSEC Event OCSP PRDR PROXY SOCKS TCP_Fast_Open
Lookups (built-in): lsearch wildlsearch nwildlsearch iplsearch cdb dbm dbmjz dbmnz dnsdb dsearch ldap ldapdn ldapm mysql nis nis0 passwd pgsql sqlite
Authenticators: cram_md5 cyrus_sasl dovecot plaintext spa tls
Routers: accept dnslookup ipliteral iplookup manualroute queryprogram redirect
Transports: appendfile/maildir/mailstore/mbx autoreply lmtp pipe smtp
Malware: f-protd f-prot6d drweb fsecure sophie clamd avast sock cmdline
Fixed never_users: 0
Configure owner: 0:0
Size of off_t: 8
Compiler: GCC [8.2.0]
Library version: Glibc: Compile: 2.28
                        Runtime: 2.28
Library version: BDB: Compile: Berkeley DB 5.3.28: (September  9, 2013)
                      Runtime: Berkeley DB 5.3.28: (September  9, 2013)
Library version: GnuTLS: Compile: 3.6.6
                         Runtime: 3.6.6
Library version: Cyrus SASL: Compile: 2.1.27
                             Runtime: 2.1.27 [Cyrus SASL]
Library version: PCRE: Compile: 8.39
                       Runtime: 8.39 2016-06-14
05:45:19 22435 Total 19 lookups
Library version: MySQL: Compile: 100312 10.3.12 [mariadb-10.3]
                        Runtime: 100313 10.3.13
Library version: SQLite: Compile: 3.27.1
                         Runtime: 3.27.2
WHITELIST_D_MACROS: "OUTGOING"
TRUSTED_CONFIG_LIST: "/etc/exim4/trusted_configs"
05:45:19 22435 changed uid/gid: -C, -D, -be or -bf forces real uid
05:45:19 22435   uid=107 gid=112 pid=22435
05:45:19 22435   auxiliary group list: 112
05:45:19 22435 seeking password data for user "uucp": cache not available
05:45:19 22435 getpwnam() succeeded uid=10 gid=10
05:45:19 22435 configuration file is /var/lib/exim4/config.autogenerated
05:45:19 22435 log selectors = 0000cffc c6401022 00000001
05:45:19 22435 LOG: MAIN PANIC
05:45:19 22435   exim user lost privilege for using -C option
05:45:19 22435 cwd=/var/spool/exim4 6 args: /usr/sbin/exim4 -C /var/lib/exim4/config.autogenerated -d=0xfff9ffff -Mc 1h9kKN-0005pq-8l
05:45:19 22435 trusted user
05:45:19 22435 admin user
05:45:19 22435 seeking password data for user "mail": cache not available
05:45:19 22435 getpwnam() succeeded uid=8 gid=8
05:45:19 22435 set_process_info: 22435 delivering specified messages
05:45:19 22435 set_process_info: 22435 delivering 1h9kKN-0005pq-8l
05:45:19 22435 Trying spool file /var/spool/exim4//input//1h9kKN-0005pq-8l-D
05:45:19 22435 reading spool file 1h9kKN-0005pq-8l-H
05:45:19 22435 user=Debian-exim uid=107 gid=112 sender=
05:45:19 22435 sender_local=0 ident=Debian-exim
05:45:19 22435 Non-recipients:
05:45:19 22435 Empty Tree
05:45:19 22435 ---- End of tree ----
05:45:19 22435 recipients_count=1
05:45:19 22435 **** SPOOL_IN - No additional fields
05:45:19 22435 body_linecount=5 message_linecount=9
05:45:19 22435 DSN: set orcpt:   flags: 0
05:45:19 22435 Delivery address list:
05:45:19 22435   postmaster@darni 
05:45:19 22435  locking /var/spool/exim4/db/retry.lockfile
05:45:19 22435  locked  /var/spool/exim4/db/retry.lockfile
05:45:19 22435  EXIM_DBOPEN: file </var/spool/exim4/db/retry> dir </var/spool/exim4/db> flags=O_RDONLY
05:45:19 22435  returned from EXIM_DBOPEN: 0x55ade6f716e0
05:45:19 22435  opened hints database /var/spool/exim4/db/retry: flags=O_RDONLY
05:45:19 22435 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
05:45:19 22435 Considering: postmaster@darni
05:45:19 22435 unique = postmaster@darni
05:45:19 22435  dbfn_read: key=R:darni
05:45:19 22435  dbfn_read: key=R:postmaster@darni
05:45:19 22435  dbfn_read: key=R:postmaster@darni:<>
05:45:19 22435 no   domain  retry record
05:45:19 22435 no   address retry record
05:45:19 22435 postmaster@darni: queued for routing
05:45:19 22435  EXIM_DBCLOSE(0x55ade6f716e0)
05:45:19 22435  closed hints database and lockfile
05:45:19 22435 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
05:45:19 22435 routing postmaster@darni
05:45:19 22435 --------> hubbed_hosts router <--------
05:45:19 22435 local_part=postmaster domain=darni
05:45:19 22435 checking domains
05:45:19 22435  ┌considering: ${if exists{/etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/hubbed_hosts}fail}
05:45:19 22435   ┌considering: /etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/hubbed_hosts}fail}
05:45:19 22435   ├──expanding: /etc/exim4/hubbed_hosts
05:45:19 22435   └─────result: /etc/exim4/hubbed_hosts
05:45:19 22435  ├──condition: exists{/etc/exim4/hubbed_hosts}
05:45:19 22435  ├─────result: false
05:45:19 22435   ┌───scanning: partial-lsearch;/etc/exim4/hubbed_hosts}fail}
05:45:19 22435   ├──expanding: partial-lsearch;/etc/exim4/hubbed_hosts
05:45:19 22435   ├─────result: partial-lsearch;/etc/exim4/hubbed_hosts
05:45:19 22435   └───skipping: result is not used
05:45:19 22435  ├failed to expand: ${if exists{/etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/hubbed_hosts}fail}
05:45:19 22435  ├───error message: "if" failed and "fail" requested
05:45:19 22435  └failure was forced
05:45:19 22435 expansion of "${if exists{/etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/hubbed_hosts}fail}" forced failure: assume not in this list
05:45:19 22435 hubbed_hosts router skipped: domains mismatch
05:45:19 22435 --------> dnslookup_relay_to_domains router <--------
05:45:19 22435 local_part=postmaster domain=darni
05:45:19 22435 checking domains
05:45:19 22435 darni in "@:localhost:3lib.org:darni.openlib.org:lists.openlib.org:authorclaim.org"? yes (matched "@")
05:45:19 22435 darni in "! +local_domains : +relay_to_domains"? no (matched "! +local_domains")
05:45:19 22435 dnslookup_relay_to_domains router skipped: domains mismatch
05:45:19 22435 --------> dnslookup router <--------
05:45:19 22435 local_part=postmaster domain=darni
05:45:19 22435 checking domains
05:45:19 22435 cached yes match for +local_domains
05:45:19 22435 cached lookup data = NULL
05:45:19 22435 darni in "! +local_domains"? no (matched "! +local_domains" - cached)
05:45:19 22435 dnslookup router skipped: domains mismatch
05:45:19 22435 --------> real_local router <--------
05:45:19 22435 local_part=postmaster domain=darni
05:45:19 22435 real_local router skipped: prefix mismatch
05:45:19 22435 --------> system_aliases router <--------
05:45:19 22435 local_part=postmaster domain=darni
05:45:19 22435 checking domains
05:45:19 22435 cached yes match for +local_domains
05:45:19 22435 cached lookup data = NULL
05:45:19 22435 darni in "+local_domains"? yes (matched "+local_domains" - cached)
05:45:19 22435  ┌considering: R: system_aliases for $local_part@$domain
05:45:19 22435  ├──expanding: R: system_aliases for $local_part@$domain
05:45:19 22435  └─────result: R: system_aliases for postmaster@darni
05:45:19 22435 R: system_aliases for postmaster@darni
05:45:19 22435 calling system_aliases router
05:45:19 22435 rda_interpret (string): ${lookup{$local_part}lsearch{/etc/aliases}}
05:45:19 22435  ┌considering: ${lookup{$local_part}lsearch{/etc/aliases}}
05:45:19 22435   ┌considering: $local_part}lsearch{/etc/aliases}}
05:45:19 22435   ├──expanding: $local_part
05:45:19 22435   └─────result: postmaster
05:45:19 22435   ┌considering: /etc/aliases}}
05:45:19 22435   ├──expanding: /etc/aliases
05:45:19 22435   └─────result: /etc/aliases
05:45:19 22435 search_open: lsearch "/etc/aliases"
05:45:19 22435 search_find: file="/etc/aliases"
05:45:19 22435   key="postmaster" partial=-1 affix=NULL starflags=0
05:45:19 22435 LRU list:
05:45:19 22435   :/etc/aliases
05:45:19 22435   End
05:45:19 22435 internal_search_find: file="/etc/aliases"
05:45:19 22435   type=lsearch key="postmaster"
05:45:19 22435 file lookup required for postmaster
05:45:19 22435   in /etc/aliases
05:45:19 22435 lookup yielded: root
05:45:19 22435  ├──expanding: ${lookup{$local_part}lsearch{/etc/aliases}}
05:45:19 22435  └─────result: root
05:45:19 22435 expanded: root
05:45:19 22435 file is not a filter file
05:45:19 22435 parse_forward_list: root
05:45:19 22435 extract item: root
05:45:19 22435 system_aliases router generated root@darni
05:45:19 22435   errors_to=NULL transport=NULL
05:45:19 22435   uid=unset gid=unset home=NULL
05:45:19 22435 routed by system_aliases router
05:45:19 22435   envelope to: postmaster@darni
05:45:19 22435   transport: <none>
05:45:19 22435  locking /var/spool/exim4/db/retry.lockfile
05:45:19 22435  locked  /var/spool/exim4/db/retry.lockfile
05:45:19 22435  EXIM_DBOPEN: file </var/spool/exim4/db/retry> dir </var/spool/exim4/db> flags=O_RDONLY
05:45:19 22435  returned from EXIM_DBOPEN: 0x55ade6f716e0
05:45:19 22435  opened hints database /var/spool/exim4/db/retry: flags=O_RDONLY
05:45:19 22435 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
05:45:19 22435 Considering: root@darni
05:45:19 22435 unique = root@darni
05:45:19 22435  dbfn_read: key=R:darni
05:45:19 22435  dbfn_read: key=R:root@darni
05:45:19 22435 no   domain  retry record
05:45:19 22435 have address retry record; next_try = now+210
05:45:19 22435 root@darni: queued for routing
05:45:19 22435  EXIM_DBCLOSE(0x55ade6f716e0)
05:45:19 22435  closed hints database and lockfile
05:45:19 22435 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
05:45:19 22435 routing root@darni
05:45:19 22435 --------> hubbed_hosts router <--------
05:45:19 22435 local_part=root domain=darni
05:45:19 22435 checking domains
05:45:19 22435  ┌considering: ${if exists{/etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/hubbed_hosts}fail}
05:45:19 22435   ┌considering: /etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/hubbed_hosts}fail}
05:45:19 22435   ├──expanding: /etc/exim4/hubbed_hosts
05:45:19 22435   └─────result: /etc/exim4/hubbed_hosts
05:45:19 22435  ├──condition: exists{/etc/exim4/hubbed_hosts}
05:45:19 22435  ├─────result: false
05:45:19 22435   ┌───scanning: partial-lsearch;/etc/exim4/hubbed_hosts}fail}
05:45:19 22435   ├──expanding: partial-lsearch;/etc/exim4/hubbed_hosts
05:45:19 22435   ├─────result: partial-lsearch;/etc/exim4/hubbed_hosts
05:45:19 22435   └───skipping: result is not used
05:45:19 22435  ├failed to expand: ${if exists{/etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/hubbed_hosts}fail}
05:45:19 22435  ├───error message: "if" failed and "fail" requested
05:45:19 22435  └failure was forced
05:45:19 22435 expansion of "${if exists{/etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/hubbed_hosts}fail}" forced failure: assume not in this list
05:45:19 22435 hubbed_hosts router skipped: domains mismatch
05:45:19 22435 --------> dnslookup_relay_to_domains router <--------
05:45:19 22435 local_part=root domain=darni
05:45:19 22435 checking domains
05:45:19 22435 darni in "@:localhost:3lib.org:darni.openlib.org:lists.openlib.org:authorclaim.org"? yes (matched "@")
05:45:19 22435 darni in "! +local_domains : +relay_to_domains"? no (matched "! +local_domains")
05:45:19 22435 dnslookup_relay_to_domains router skipped: domains mismatch
05:45:19 22435 --------> dnslookup router <--------
05:45:19 22435 local_part=root domain=darni
05:45:19 22435 checking domains
05:45:19 22435 cached yes match for +local_domains
05:45:19 22435 cached lookup data = NULL
05:45:19 22435 darni in "! +local_domains"? no (matched "! +local_domains" - cached)
05:45:19 22435 dnslookup router skipped: domains mismatch
05:45:19 22435 --------> real_local router <--------
05:45:19 22435 local_part=root domain=darni
05:45:19 22435 real_local router skipped: prefix mismatch
05:45:19 22435 --------> system_aliases router <--------
05:45:19 22435 local_part=root domain=darni
05:45:19 22435 checking domains
05:45:19 22435 cached yes match for +local_domains
05:45:19 22435 cached lookup data = NULL
05:45:19 22435 darni in "+local_domains"? yes (matched "+local_domains" - cached)
05:45:19 22435  ┌considering: R: system_aliases for $local_part@$domain
05:45:19 22435  ├──expanding: R: system_aliases for $local_part@$domain
05:45:19 22435  └─────result: R: system_aliases for root@darni
05:45:19 22435 R: system_aliases for root@darni
05:45:19 22435 calling system_aliases router
05:45:19 22435 rda_interpret (string): ${lookup{$local_part}lsearch{/etc/aliases}}
05:45:19 22435  ┌considering: ${lookup{$local_part}lsearch{/etc/aliases}}
05:45:19 22435   ┌considering: $local_part}lsearch{/etc/aliases}}
05:45:19 22435   ├──expanding: $local_part
05:45:19 22435   └─────result: root
05:45:19 22435   ┌considering: /etc/aliases}}
05:45:19 22435   ├──expanding: /etc/aliases
05:45:19 22435   └─────result: /etc/aliases
05:45:19 22435 search_open: lsearch "/etc/aliases"
05:45:19 22435   cached open
05:45:19 22435 search_find: file="/etc/aliases"
05:45:19 22435   key="root" partial=-1 affix=NULL starflags=0
05:45:19 22435 LRU list:
05:45:19 22435   :/etc/aliases
05:45:19 22435   End
05:45:19 22435 internal_search_find: file="/etc/aliases"
05:45:19 22435   type=lsearch key="root"
05:45:19 22435 file lookup required for root
05:45:19 22435   in /etc/aliases
05:45:19 22435 lookup failed
05:45:19 22435  ├──expanding: ${lookup{$local_part}lsearch{/etc/aliases}}
05:45:19 22435  └─────result: 
05:45:19 22435 expanded: 
05:45:19 22435 file is not a filter file
05:45:19 22435 parse_forward_list: 
05:45:19 22435 system_aliases router declined for root@darni
05:45:19 22435 --------> userforward router <--------
05:45:19 22435 local_part=root domain=darni
05:45:19 22435 checking domains
05:45:19 22435 cached yes match for +local_domains
05:45:19 22435 cached lookup data = NULL
05:45:19 22435 darni in "+local_domains"? yes (matched "+local_domains" - cached)
05:45:19 22435 checking for local user
05:45:19 22435 seeking password data for user "root": cache not available
05:45:19 22435 getpwnam() succeeded uid=0 gid=0
05:45:19 22435  ┌considering: R: userforward for $local_part@$domain
05:45:19 22435  ├──expanding: R: userforward for $local_part@$domain
05:45:19 22435  └─────result: R: userforward for root@darni
05:45:19 22435 R: userforward for root@darni
05:45:19 22435 checking require_files
05:45:19 22435  ┌considering: $local_part
05:45:19 22435  ├──expanding: $local_part
05:45:19 22435  └─────result: root
05:45:19 22435 seeking password data for user "root": using cached result
05:45:19 22435 getpwnam() succeeded uid=0 gid=0
05:45:19 22435 check subsequent files for access by root
05:45:19 22435  ┌considering: $home/.forward
05:45:19 22435  ├──expanding: $home/.forward
05:45:19 22435  └─────result: /root/.forward
05:45:19 22435 file check: $home/.forward
05:45:19 22435 expanded file: /root/.forward
05:45:19 22435 stat() yielded -1
05:45:19 22435 errno = 13
05:45:19 22435 require_files: error for /root/.forward: Permission denied
05:45:19 22435 userforward router deferred: file check
05:45:19 22435 added retry item for R:root@darni: errno=-1 more_errno=0 flags=0
05:45:19 22435 post-process root@darni (1)
05:45:19 22435 LOG: MAIN
05:45:19 22435   == root@darni <postmaster@darni> R=userforward defer (-1): require_files: error for /root/.forward: Permission denied
05:45:19 22435 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
05:45:19 22435 After routing:
05:45:19 22435   Local deliveries:
05:45:19 22435   Remote deliveries:
05:45:19 22435   Failed addresses:
05:45:19 22435   Deferred addresses:
05:45:19 22435     root@darni
05:45:19 22435 search_tidyup called
05:45:19 22435 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
05:45:19 22435 changed uid/gid: post-delivery tidying
05:45:19 22435   uid=107 gid=112 pid=22435
05:45:19 22435   auxiliary group list: 112
05:45:19 22435 set_process_info: 22435 tidying up after delivering 1h9kKN-0005pq-8l
05:45:19 22435 Processing retry items
05:45:19 22435 Succeeded addresses:
05:45:19 22435  postmaster@darni: no retry items
05:45:19 22435 Failed addresses:
05:45:19 22435 Deferred addresses:
05:45:19 22435  root@darni
05:45:19 22435  locking /var/spool/exim4/db/retry.lockfile
05:45:19 22435  locked  /var/spool/exim4/db/retry.lockfile
05:45:19 22435  EXIM_DBOPEN: file </var/spool/exim4/db/retry> dir </var/spool/exim4/db> flags=O_RDWR
05:45:19 22435  returned from EXIM_DBOPEN: 0x55ade6f716e0
05:45:19 22435  opened hints database /var/spool/exim4/db/retry: flags=O_RDWR
05:45:19 22435 address match test: subject=root@darni pattern=*
05:45:19 22435 darni in "*"? yes (matched "*")
05:45:19 22435 root@darni in "*"? yes (matched "*")
05:45:19 22435 retry for R:root@darni = * 0 0
05:45:19 22435  dbfn_read: key=R:root@darni
05:45:19 22435 failing_interval=690 message_age=0
05:45:19 22435 Writing retry data for R:root@darni
05:45:19 22435   first failed=1553837629 last try=1553838319 next try=1553839219 expired=0
05:45:19 22435   errno=-1 more_errno=0 require_files: error for /root/.forward: Permission denied
05:45:19 22435  dbfn_write: key=R:root@darni
05:45:19 22435  postmaster@darni: no retry items
05:45:19 22435  EXIM_DBCLOSE(0x55ade6f716e0)
05:45:19 22432 Renaming spool header file: /var/spool/exim4//input//1h9kKN-0005pn-0n-H
05:45:19 22432 Size of headers = 1509
05:45:19 22432 end delivery of 1h9kKN-0005pn-0n
05:45:19 22432 search_tidyup called
05:45:19 22432 search_tidyup called
05:45:19 22432 >>>>>>>>>>>>>>>> Exim pid=22432 (main) terminating with rc=0 >>>>>>>>>>>>>>>>
05:45:19 22435  closed hints database and lockfile
05:45:19 22435 end of retry processing
05:45:19 22435 DSN: processing router : system_aliases
05:45:19 22435 DSN: processing successful delivery address: postmaster@darni
05:45:19 22435 DSN: Sender_address: 
05:45:19 22435 DSN: orcpt: NULL  flags: 0
05:45:19 22435 DSN: envid: NULL  ret: 0
05:45:19 22435 DSN: Final recipient: postmaster@darni
05:45:19 22435 DSN: Remote SMTP server supports DSN: 0
05:45:19 22435 DSN: not sending DSN success message
05:45:19 22435 delivery deferred: update_spool=1 header_rewritten=0
05:45:19 22435 Writing spool header file: /var/spool/exim4//input//hdr.22435
05:45:19 22435 DSN: Write SPOOL :-dsn_envid NULL
05:45:19 22435 DSN: Write SPOOL :-dsn_ret 0
05:45:19 22435 DSN: Flags :0
05:45:19 22435 DSN: **** SPOOL_OUT - address: |postmaster@darni| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
05:45:19 22435 Renaming spool header file: /var/spool/exim4//input//1h9kKN-0005pq-8l-H
05:45:19 22435 Size of headers = 334
05:45:19 22435 end delivery of 1h9kKN-0005pq-8l
05:45:19 22435 search_tidyup called
05:45:19 22435 search_tidyup called
05:45:19 22435 >>>>>>>>>>>>>>>> Exim pid=22435 (main) terminating with rc=0 >>>>>>>>>>>>>>>>