No DKIM sign in mail header when sending over webclient

Discuss your pilot or production implementation with other Zimbra admins or our engineers.
Post Reply
B3nder
Posts: 2
Joined: Sat Feb 09, 2019 11:44 am

No DKIM sign in mail header when sending over webclient

Post by B3nder »

Greetings!
Got a release 8.6.0, running on Ubuntu 14.04.
Got DKIM installed, mail sent out using any client (e.g. Thunderbird) has got a valid DKIM sign in header which is verified as correct by GMail.
But if a Zimbra web client is used to send a message, no DKIM sign is applied to header at all.
Command

Code: Select all

/opt/zimbra/libexec/zmdkimkeyutil -q -d

reports a valid record for my domain.
Adding 127.0.0.1 to opendkim-localnets.conf.in sadly brings no result.

When comparing zimbra.log records for mails sent using webclient and Thunderbird, it seems that dkim-milter is not triggered at all.

Using web client:

Code: Select all

Feb  9 14:24:46 mail postfix/smtpd[16988]: connect from mail.mydomain.com[server_ip]
Feb  9 14:24:46 mail postfix/smtpd[16988]: 379207343FC: client=mail.mydomain.com[server_ip]
Feb  9 14:24:46 mail postfix/cleanup[16993]: 379207343FC: message-id=<873830303.8151.1549715086197.JavaMail.zimbra@mydomain.com>
Feb  9 14:24:46 mail postfix/qmgr[16037]: 379207343FC: from=<sender@mydomain.com>, size=1783, nrcpt=1 (queue active)
Feb  9 14:24:46 mail postfix/smtpd[16988]: disconnect from mail.mydomain.com[server_ip]
Feb  9 14:24:46 mail amavis[16546]: (16546-01) ESMTP:[127.0.0.1]:10024 /opt/zimbra/data/amavisd/tmp/amavis-20190209T142446-16546-cbXRs_z8: <sender@mydomain.com> -> <addressee@gmail.com> SIZE=1783 Received: from mail.mydomain.com ([127.0.0.1]) by localhost (mail.mydomain.com [127.0.0.1]) (amavisd-new, port 10024) with ESMTP for <addressee@gmail.com>; Sat,  9 Feb 2019 14:24:46 +0200 (EET)
Feb  9 14:24:46 mail amavis[16546]: (16546-01) Checking: CU9yM53DMXSB MYNETS [server_ip] <sender@mydomain.com> -> <addressee@gmail.com>
Feb  9 14:24:46 mail postfix/amavisd/smtpd[17019]: connect from localhost[127.0.0.1]
Feb  9 14:24:46 mail postfix/amavisd/smtpd[17019]: 7D61A73454E: client=localhost[127.0.0.1]
Feb  9 14:24:46 mail postfix/cleanup[16993]: 7D61A73454E: message-id=<873830303.8151.1549715086197.JavaMail.zimbra@mydomain.com>
Feb  9 14:24:46 mail postfix/qmgr[16037]: 7D61A73454E: from=<sender@mydomain.com>, size=2236, nrcpt=1 (queue active)
Feb  9 14:24:46 mail amavis[16546]: (16546-01) CU9yM53DMXSB FWD from <sender@mydomain.com> -> <addressee@gmail.com>, BODY=7BIT 250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 7D61A73454E
Feb  9 14:24:46 mail amavis[16546]: (16546-01) Passed CLEAN {RelayedOutbound}, MYNETS LOCAL [server_ip]:58268 [server_ip] <sender@mydomain.com> -> <addressee@gmail.com>, Queue-ID: 379207343FC, Message-ID: <873830303.8151.1549715086197.JavaMail.zimbra@mydomain.com>, mail_id: CU9yM53DMXSB, Hits: -16.755, size: 1782, queued_as: 7D61A73454E, 289 ms
Feb  9 14:24:46 mail postfix/smtp[16994]: 379207343FC: to=<addressee@gmail.com>, relay=127.0.0.1[127.0.0.1]:10024, delay=0.3, delays=0.01/0/0.01/0.29, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 7D61A73454E)
Feb  9 14:24:46 mail postfix/qmgr[16037]: 379207343FC: removed
Feb  9 14:24:46 mail amavis[16546]: (16546-01) extra modules loaded: /opt/zimbra/zimbramon/lib/x86_64-linux-gnu-thread-multi/auto/Net/SSLeay/autosplit.ix, /opt/zimbra/zimbramon/lib/x86_64-linux-gnu-thread-multi/auto/Net/SSLeay/randomize.al, Convert/UUlib.pm, IO/Socket/SSL.pm, Net/SSLeay.pm
Feb  9 14:24:46 mail postfix/smtp[17020]: 7D61A73454E: to=<addressee@gmail.com>, relay=gmail-smtp-in.l.google.com[108.177.126.27]:25, delay=0.23, delays=0/0.01/0.11/0.11, dsn=2.0.0, status=sent (250 2.0.0 OK  1549715087 r2-v6si2290158ejg.0 - gsmtp)
Feb  9 14:24:46 mail postfix/qmgr[16037]: 7D61A73454E: removed
Using desktop mail client:

Code: Select all

Feb  9 14:24:54 mail postfix/submission/smtpd[17329]: connect from unknown[sender_ip]
Feb  9 14:24:54 mail postfix/submission/smtpd[17329]: Anonymous TLS connection established from unknown[sender_ip]: TLSv1.2 with cipher ECDHE-RSA-AES128-GCM-SHA256 (128/128 bits)
Feb  9 14:24:54 mail saslauthd[15987]: zmauth: authenticating against elected url 'https://mail.mydomain.com:7071/service/admin/soap/' ...
Feb  9 14:24:54 mail slapd[21423]: slap_queue_csn: queing 0x7ef7ca5662c0 20190209122454.649453Z#000000#000#000000
Feb  9 14:24:54 mail slapd[21423]: slap_graduate_commit_csn: removing 0x9ef05d0 20190209122454.649453Z#000000#000#000000
Feb  9 14:24:54 mail saslauthd[15987]: zmpost: url='https://mail.mydomain.com:7071/service/admin/soap/' returned buffer->data='<soap:Envelope xmlns:soap="http://www.w3.org/2003/05/soap-envelope"><soap:Header><context xmlns="urn:zimbra"><change token="47621"/></context></soap:Header><soap:Body><AuthResponse xmlns="urn:zimbraAccount"><authToken>0_082154001e058ea2e85b92bddc7c26e9e1ce7dac_69643d33363a31323061626465642d313462622d343565382d623134362d6431336238626231333962303b6578703d31333a313534393838373839343634393b76763d313a313b747970653d363a7a696d6272613b7469643d31303a313738333836343634313b76657273696f6e3d31333a382e362e305f47415f313135333b</authToken><lifetime>172799999</lifetime><skin>beach</skin></AuthResponse></soap:Body></soap:Envelope>', hti->error=''
Feb  9 14:24:54 mail saslauthd[15987]: auth_zimbra: sender@mydomain.com auth OK
Feb  9 14:24:54 mail postfix/submission/smtpd[17329]: B3E897343FC: client=unknown[sender_ip], sasl_method=PLAIN, sasl_username=sender@mydomain.com
Feb  9 14:24:54 mail postfix/cleanup[16993]: B3E897343FC: message-id=<271c70ef-4405-97c2-7104-3c0aa6c35c8c@mydomain.com>
Feb  9 14:24:54 mail postfix/qmgr[16037]: B3E897343FC: from=<sender@mydomain.com>, size=600, nrcpt=1 (queue active)
Feb  9 14:24:54 mail postfix/dkimmilter/smtpd[17331]: connect from localhost[127.0.0.1]
Feb  9 14:24:54 mail postfix/dkimmilter/smtpd[17331]: Anonymous TLS connection established from localhost[127.0.0.1]: TLSv1.2 with cipher AECDH-AES256-SHA (256/256 bits)
Feb  9 14:24:54 mail postfix/dkimmilter/smtpd[17331]: CE67373454E: client=localhost[127.0.0.1]
Feb  9 14:24:54 mail postfix/cleanup[16993]: CE67373454E: message-id=<271c70ef-4405-97c2-7104-3c0aa6c35c8c@mydomain.com>
Feb  9 14:24:54 mail postfix/qmgr[16037]: CE67373454E: from=<sender@mydomain.com>, size=826, nrcpt=1 (queue active)
Feb  9 14:24:54 mail postfix/smtp[17330]: B3E897343FC: to=<addressee@gmail.com>, relay=127.0.0.1[127.0.0.1]:10030, delay=0.24, delays=0.13/0.01/0.01/0.09, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as CE67373454E)
Feb  9 14:24:54 mail postfix/dkimmilter/smtpd[17331]: disconnect from localhost[127.0.0.1]
Feb  9 14:24:54 mail postfix/qmgr[16037]: B3E897343FC: removed
Feb  9 14:24:54 mail amavis[16558]: (16558-01) ESMTP:[127.0.0.1]:10032 /opt/zimbra/data/amavisd/tmp/amavis-20190209T142454-16558-KSKiYWm5: <sender@mydomain.com> -> <addressee@gmail.com> Received: from mail.mydomain.com ([127.0.0.1]) by localhost (mail.mydomain.com [127.0.0.1]) (amavisd-new, port 10032) with ESMTP for <addressee@gmail.com>; Sat,  9 Feb 2019 14:24:54 +0200 (EET)
Feb  9 14:24:54 mail amavis[16558]: (16558-01) Checking: 1YRCkBVdPdtY ORIGINATING_POST/MYNETS [127.0.0.1] <sender@mydomain.com> -> <addressee@gmail.com>
Feb  9 14:24:55 mail postfix/amavisd/smtpd[17334]: connect from localhost[127.0.0.1]
Feb  9 14:24:55 mail postfix/amavisd/smtpd[17334]: 047B77343FC: client=localhost[127.0.0.1]
Feb  9 14:24:55 mail postfix/cleanup[16993]: 047B77343FC: message-id=<271c70ef-4405-97c2-7104-3c0aa6c35c8c@mydomain.com>
Feb  9 14:24:55 mail amavis[16558]: (16558-01) 1YRCkBVdPdtY FWD from <sender@mydomain.com> -> <addressee@gmail.com>, BODY=7BIT 250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 047B77343FC
Feb  9 14:24:55 mail postfix/qmgr[16037]: 047B77343FC: from=<sender@mydomain.com>, size=1716, nrcpt=1 (queue active)
Feb  9 14:24:55 mail amavis[16558]: (16558-01) Passed CLEAN {RelayedOutbound}, ORIGINATING_POST/MYNETS LOCAL [127.0.0.1]:50156 [sender_ip] <sender@mydomain.com> -> <addressee@gmail.com>, Queue-ID: CE67373454E, Message-ID: <271c70ef-4405-97c2-7104-3c0aa6c35c8c@mydomain.com>, mail_id: 1YRCkBVdPdtY, Hits: -, size: 1311, queued_as: 047B77343FC, dkim_sd=938BEF28-2B26-11E9-B4BC-2BEAC8919C4F:mydomain.com, 89 ms
Feb  9 14:24:55 mail postfix/smtp[16994]: CE67373454E: to=<addressee@gmail.com>, relay=127.0.0.1[127.0.0.1]:10032, delay=0.18, delays=0.09/0/0.01/0.08, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 047B77343FC)
Feb  9 14:24:55 mail postfix/qmgr[16037]: CE67373454E: removed
Feb  9 14:24:55 mail amavis[16558]: (16558-01) extra modules loaded: /opt/zimbra/zimbramon/lib/x86_64-linux-gnu-thread-multi/auto/Net/SSLeay/autosplit.ix, /opt/zimbra/zimbramon/lib/x86_64-linux-gnu-thread-multi/auto/Net/SSLeay/randomize.al, IO/Socket/SSL.pm, Net/SSLeay.pm
Feb  9 14:24:55 mail postfix/submission/smtpd[17329]: disconnect from unknown[sender_ip]
Feb  9 14:24:55 mail postfix/smtp[17020]: 047B77343FC: to=<addressee@gmail.com>, relay=gmail-smtp-in.l.google.com[108.177.126.27]:25, delay=0.15, delays=0/0/0.08/0.07, dsn=2.0.0, status=sent (250 2.0.0 OK  1549715096 a37si2419127eda.196 - gsmtp)
Feb  9 14:24:55 mail postfix/qmgr[16037]: 047B77343FC: removed
Where should I start to solve that?
Thanks in advance.
Post Reply