ARC: enhance debug for signing; explicitly init signing context
[users/heiko/exim.git] / test / log / 4560
1
2 ******** SERVER ********
3 1999-03-02 09:44:33 exim x.yz daemon started: pid=pppp, no queue runs, listening for SMTP on port 1225
4 1999-03-02 09:44:33 10HmaX-0005vi-00 arc_state: <pass>
5 1999-03-02 09:44:33 10HmaX-0005vi-00 <= CALLER@bloggs.com H=(xxx) [127.0.0.1] P=smtp S=sss ARC id=qwerty1234@disco-zombie.net for a@test.ex
6 1999-03-02 09:44:33 Start queue run: pid=pppp
7 1999-03-02 09:44:33 10HmaX-0005vi-00 => a <a@test.ex> R=d1 T=tfile
8 1999-03-02 09:44:33 10HmaX-0005vi-00 Completed
9 1999-03-02 09:44:33 End queue run: pid=pppp
10 1999-03-02 09:44:33 10HmaY-0005vi-00 arc_state: <none>
11 1999-03-02 09:44:33 10HmaY-0005vi-00 <= CALLER@bloggs.com H=(xxx) [127.0.0.1] P=smtp S=sss for za@test.ex
12 1999-03-02 09:44:33 Start queue run: pid=pppp
13 1999-03-02 09:44:33 10HmaZ-0005vi-00 arc_state: <pass>
14 1999-03-02 09:44:33 10HmaZ-0005vi-00 <= CALLER@bloggs.com H=localhost (test.ex) [127.0.0.1] P=esmtp S=sss ARC for a@test.ex
15 1999-03-02 09:44:33 10HmaY-0005vi-00 => a@test.ex <za@test.ex> R=fwd T=tsmtp H=127.0.0.1 [127.0.0.1] C="250 OK id=10HmaZ-0005vi-00"
16 1999-03-02 09:44:33 10HmaY-0005vi-00 Completed
17 1999-03-02 09:44:33 End queue run: pid=pppp
18 1999-03-02 09:44:33 Start queue run: pid=pppp
19 1999-03-02 09:44:33 10HmaZ-0005vi-00 => a <a@test.ex> R=d1 T=tfile
20 1999-03-02 09:44:33 10HmaZ-0005vi-00 Completed
21 1999-03-02 09:44:33 End queue run: pid=pppp
22 1999-03-02 09:44:33 10HmbA-0005vi-00 arc_state: <none>
23 1999-03-02 09:44:33 10HmbA-0005vi-00 <= CALLER@bloggs.com H=(xxx) [127.0.0.1] P=smtp S=sss for zza@test.ex
24 1999-03-02 09:44:33 Start queue run: pid=pppp
25 1999-03-02 09:44:33 10HmbB-0005vi-00 arc_state: <pass>
26 1999-03-02 09:44:33 10HmbB-0005vi-00 <= CALLER@bloggs.com H=localhost (test.ex) [127.0.0.1] P=esmtp S=sss ARC for za@test.ex
27 1999-03-02 09:44:33 10HmbA-0005vi-00 => za@test.ex <zza@test.ex> R=fwd T=tsmtp H=127.0.0.1 [127.0.0.1] C="250 OK id=10HmbB-0005vi-00"
28 1999-03-02 09:44:33 10HmbA-0005vi-00 Completed
29 1999-03-02 09:44:33 End queue run: pid=pppp
30 1999-03-02 09:44:33 Start queue run: pid=pppp
31 1999-03-02 09:44:33 10HmbC-0005vi-00 arc_state: <pass>
32 1999-03-02 09:44:33 10HmbC-0005vi-00 <= CALLER@bloggs.com H=localhost (test.ex) [127.0.0.1] P=esmtp S=sss ARC for a@test.ex
33 1999-03-02 09:44:33 10HmbB-0005vi-00 => a@test.ex <za@test.ex> R=fwd T=tsmtp H=127.0.0.1 [127.0.0.1] C="250 OK id=10HmbC-0005vi-00"
34 1999-03-02 09:44:33 10HmbB-0005vi-00 Completed
35 1999-03-02 09:44:33 End queue run: pid=pppp
36 1999-03-02 09:44:33 Start queue run: pid=pppp
37 1999-03-02 09:44:33 10HmbC-0005vi-00 => a <a@test.ex> R=d1 T=tfile
38 1999-03-02 09:44:33 10HmbC-0005vi-00 Completed
39 1999-03-02 09:44:33 End queue run: pid=pppp
40 1999-03-02 09:44:33 10HmbD-0005vi-00 arc_state: <none>
41 1999-03-02 09:44:33 10HmbD-0005vi-00 <= CALLER@bloggs.com H=(xxx) [127.0.0.1] P=smtp S=sss for zmza@test.ex
42 1999-03-02 09:44:33 Start queue run: pid=pppp
43 1999-03-02 09:44:33 10HmbE-0005vi-00 arc_state: <pass>
44 1999-03-02 09:44:33 10HmbE-0005vi-00 <= CALLER@bloggs.com H=localhost (test.ex) [127.0.0.1] P=esmtp S=sss ARC for mza@test.ex
45 1999-03-02 09:44:33 10HmbD-0005vi-00 => mza@test.ex <zmza@test.ex> R=fwd T=tsmtp H=127.0.0.1 [127.0.0.1] C="250 OK id=10HmbE-0005vi-00"
46 1999-03-02 09:44:33 10HmbD-0005vi-00 Completed
47 1999-03-02 09:44:33 End queue run: pid=pppp
48 1999-03-02 09:44:33 Start queue run: pid=pppp
49 1999-03-02 09:44:33 10HmbF-0005vi-00 arc_state: <pass>
50 1999-03-02 09:44:33 10HmbF-0005vi-00 <= CALLER@bloggs.com H=localhost (test.ex) [127.0.0.1] P=esmtp S=sss ARC for za@test.ex
51 1999-03-02 09:44:33 10HmbE-0005vi-00 => za@test.ex <mza@test.ex> R=mlist T=tmlist H=127.0.0.1 [127.0.0.1] C="250 OK id=10HmbF-0005vi-00"
52 1999-03-02 09:44:33 10HmbE-0005vi-00 Completed
53 1999-03-02 09:44:33 End queue run: pid=pppp
54 1999-03-02 09:44:33 Start queue run: pid=pppp
55 1999-03-02 09:44:33 10HmbG-0005vi-00 arc_state: <pass>
56 1999-03-02 09:44:33 10HmbG-0005vi-00 <= CALLER@bloggs.com H=localhost (test.ex) [127.0.0.1] P=esmtp S=sss ARC for a@test.ex
57 1999-03-02 09:44:33 10HmbF-0005vi-00 => a@test.ex <za@test.ex> R=fwd T=tsmtp H=127.0.0.1 [127.0.0.1] C="250 OK id=10HmbG-0005vi-00"
58 1999-03-02 09:44:33 10HmbF-0005vi-00 Completed
59 1999-03-02 09:44:33 End queue run: pid=pppp
60 1999-03-02 09:44:33 Start queue run: pid=pppp
61 1999-03-02 09:44:33 10HmbG-0005vi-00 => a <a@test.ex> R=d1 T=tfile
62 1999-03-02 09:44:33 10HmbG-0005vi-00 Completed
63 1999-03-02 09:44:33 End queue run: pid=pppp
64 1999-03-02 09:44:33 10HmbH-0005vi-00 arc_state: <none>
65 1999-03-02 09:44:33 10HmbH-0005vi-00 <= CALLER@bloggs.com H=(xxx) [127.0.0.1] P=smtp S=sss for zzmza@test.ex
66 1999-03-02 09:44:33 Start queue run: pid=pppp
67 1999-03-02 09:44:33 10HmbI-0005vi-00 arc_state: <pass>
68 1999-03-02 09:44:33 10HmbI-0005vi-00 <= CALLER@bloggs.com H=localhost (test.ex) [127.0.0.1] P=esmtp S=sss ARC for zmza@test.ex
69 1999-03-02 09:44:33 10HmbH-0005vi-00 => zmza@test.ex <zzmza@test.ex> R=fwd T=tsmtp H=127.0.0.1 [127.0.0.1] C="250 OK id=10HmbI-0005vi-00"
70 1999-03-02 09:44:33 10HmbH-0005vi-00 Completed
71 1999-03-02 09:44:33 End queue run: pid=pppp
72 1999-03-02 09:44:33 Start queue run: pid=pppp
73 1999-03-02 09:44:33 10HmbJ-0005vi-00 arc_state: <pass>
74 1999-03-02 09:44:33 10HmbJ-0005vi-00 <= CALLER@bloggs.com H=localhost (test.ex) [127.0.0.1] P=esmtp S=sss ARC for mza@test.ex
75 1999-03-02 09:44:33 10HmbI-0005vi-00 => mza@test.ex <zmza@test.ex> R=fwd T=tsmtp H=127.0.0.1 [127.0.0.1] C="250 OK id=10HmbJ-0005vi-00"
76 1999-03-02 09:44:33 10HmbI-0005vi-00 Completed
77 1999-03-02 09:44:33 End queue run: pid=pppp
78 1999-03-02 09:44:33 Start queue run: pid=pppp
79 1999-03-02 09:44:33 10HmbK-0005vi-00 arc_state: <fail>
80 1999-03-02 09:44:33 10HmbK-0005vi-00 reason:    <AMS body hash miscompare>
81 1999-03-02 09:44:33 10HmbK-0005vi-00 <= CALLER@bloggs.com H=localhost (test.ex) [127.0.0.1] P=esmtp S=sss for za@test.ex
82 1999-03-02 09:44:33 10HmbJ-0005vi-00 => za@test.ex <mza@test.ex> R=mlist T=tmlist H=127.0.0.1 [127.0.0.1] C="250 OK id=10HmbK-0005vi-00"
83 1999-03-02 09:44:33 10HmbJ-0005vi-00 Completed
84 1999-03-02 09:44:33 End queue run: pid=pppp
85 1999-03-02 09:44:33 Start queue run: pid=pppp
86 1999-03-02 09:44:33 10HmbL-0005vi-00 arc_state: <fail>
87 1999-03-02 09:44:33 10HmbL-0005vi-00 reason:    <i=3 (cv, sequence or missing header)>
88 1999-03-02 09:44:33 10HmbL-0005vi-00 <= CALLER@bloggs.com H=localhost (test.ex) [127.0.0.1] P=esmtp S=sss for a@test.ex
89 1999-03-02 09:44:33 10HmbK-0005vi-00 => a@test.ex <za@test.ex> R=fwd T=tsmtp H=127.0.0.1 [127.0.0.1] C="250 OK id=10HmbL-0005vi-00"
90 1999-03-02 09:44:33 10HmbK-0005vi-00 Completed
91 1999-03-02 09:44:33 End queue run: pid=pppp
92 1999-03-02 09:44:33 Start queue run: pid=pppp
93 1999-03-02 09:44:33 10HmbL-0005vi-00 => a <a@test.ex> R=d1 T=tfile
94 1999-03-02 09:44:33 10HmbL-0005vi-00 Completed
95 1999-03-02 09:44:33 End queue run: pid=pppp
96 1999-03-02 09:44:33 10HmbM-0005vi-00 arc_state: <none>
97 1999-03-02 09:44:33 10HmbM-0005vi-00 <= CALLER@bloggs.com H=(xxx) [127.0.0.1] P=smtp S=sss for zza@test.ex
98 1999-03-02 09:44:33 Start queue run: pid=pppp
99 1999-03-02 09:44:33 10HmbN-0005vi-00 arc_state: <pass>
100 1999-03-02 09:44:33 10HmbN-0005vi-00 <= CALLER@bloggs.com H=localhost (test.ex) [127.0.0.1] P=esmtp S=sss ARC for za@test.ex
101 1999-03-02 09:44:33 10HmbM-0005vi-00 => za@test.ex <zza@test.ex> R=fwd T=tsmtp H=127.0.0.1 [127.0.0.1] C="250 OK id=10HmbN-0005vi-00"
102 1999-03-02 09:44:33 10HmbM-0005vi-00 Completed
103 1999-03-02 09:44:33 End queue run: pid=pppp
104 1999-03-02 09:44:33 Start queue run: pid=pppp
105 1999-03-02 09:44:33 10HmbO-0005vi-00 arc_state: <pass>
106 1999-03-02 09:44:33 10HmbO-0005vi-00 <= CALLER@bloggs.com H=localhost (test.ex) [127.0.0.1] P=esmtp S=sss ARC for a@test.ex
107 1999-03-02 09:44:33 10HmbN-0005vi-00 => a@test.ex <za@test.ex> R=fwd T=tsmtp H=127.0.0.1 [127.0.0.1] C="250 OK id=10HmbO-0005vi-00"
108 1999-03-02 09:44:33 10HmbN-0005vi-00 Completed
109 1999-03-02 09:44:33 End queue run: pid=pppp
110 1999-03-02 09:44:33 Start queue run: pid=pppp
111 1999-03-02 09:44:33 10HmbO-0005vi-00 => a <a@test.ex> R=d1 T=tfile
112 1999-03-02 09:44:33 10HmbO-0005vi-00 Completed
113 1999-03-02 09:44:33 End queue run: pid=pppp
114 1999-03-02 09:44:33 10HmbP-0005vi-00 DKIM: d=dmarc.org s=clochette c=simple/simple a=rsa-sha256 b=1024 t=1517535263 [verification succeeded]
115 1999-03-02 09:44:33 10HmbP-0005vi-00 DKIM: d=convivian.com s=default c=simple/simple a=rsa-sha256 b=1024 t=1517535248 [verification failed - body hash mismatch (body probably modified in transit)]
116 1999-03-02 09:44:33 10HmbP-0005vi-00 arc_state: <fail>
117 1999-03-02 09:44:33 10HmbP-0005vi-00 reason:    <AMS body hash miscompare>
118 1999-03-02 09:44:33 10HmbP-0005vi-00 <= CALLER@bloggs.com H=(xxx) [127.0.0.1] P=smtp S=sss DKIM=dmarc.org id=1426665656.110316.1517535248039.JavaMail.zimbra@convivian.com for za@test.ex
119 1999-03-02 09:44:33 Start queue run: pid=pppp
120 1999-03-02 09:44:33 10HmbQ-0005vi-00 DKIM: d=dmarc.org s=clochette c=simple/simple a=rsa-sha256 b=1024 t=1517535263 [verification succeeded]
121 1999-03-02 09:44:33 10HmbQ-0005vi-00 DKIM: d=convivian.com s=default c=simple/simple a=rsa-sha256 b=1024 t=1517535248 [verification failed - body hash mismatch (body probably modified in transit)]
122 1999-03-02 09:44:33 10HmbQ-0005vi-00 arc_state: <fail>
123 1999-03-02 09:44:33 10HmbQ-0005vi-00 reason:    <i=2 (cv, sequence or missing header)>
124 1999-03-02 09:44:33 10HmbQ-0005vi-00 <= CALLER@bloggs.com H=localhost (test.ex) [127.0.0.1] P=esmtp S=sss DKIM=dmarc.org id=1426665656.110316.1517535248039.JavaMail.zimbra@convivian.com for a@test.ex
125 1999-03-02 09:44:33 10HmbP-0005vi-00 => a@test.ex <za@test.ex> R=fwd T=tsmtp H=127.0.0.1 [127.0.0.1] C="250 OK id=10HmbQ-0005vi-00"
126 1999-03-02 09:44:33 10HmbP-0005vi-00 Completed
127 1999-03-02 09:44:33 End queue run: pid=pppp
128 1999-03-02 09:44:33 Start queue run: pid=pppp
129 1999-03-02 09:44:33 10HmbQ-0005vi-00 => a <a@test.ex> R=d1 T=tfile
130 1999-03-02 09:44:33 10HmbQ-0005vi-00 Completed
131 1999-03-02 09:44:33 End queue run: pid=pppp
132 1999-03-02 09:44:33 exim x.yz daemon started: pid=pppp, no queue runs, listening for SMTP on port 1225
133 1999-03-02 09:44:33 10HmbR-0005vi-00 H=(xxx) [127.0.0.1] Warning: ARC-FAIL
134 1999-03-02 09:44:33 10HmbR-0005vi-00 arc_state: <none>
135 1999-03-02 09:44:33 10HmbR-0005vi-00 <= CALLER@bloggs.com H=(xxx) [127.0.0.1] P=smtp S=sss for a@test.ex