Auto-response out of nowhere

Hello, Coffee here again :),

i’ve got a user without other rules than “Kategorien der E-Mails löschen (empfohlen)” shown in Outlook 2016 or Webapp . Out-of-office is disabled (enable and disabled it, just to be sure) - and here i got some strange auto-response.
If i write a mail, i get a blank e-mail back - just once per day. Every other mail gets the same mail as autoresponse. Header-information (user edited etc.)

Return-Path: <user@domain.de>
Received: from mx01.domain (127.0.0.1:33626) by mailserver-FQDN (kopano-dagent) with LMTP for <mailarchiv@domain>; Wed, 26 Apr 2017 09:01:49 +0200 (CEST)
X-Original-To: dropzone@domain
Received: from mailserverFQDN (localhost.localdomain [127.0.0.1]) by mx01.domain (Postfix) with ESMTP id 25C2222F92 for <dropzone@domain>; Wed, 26 Apr 2017 09:01:49 +0200 (CEST)
Subject: RE: test
From: =?windows-1252?Q?USER?= <user@domain>
To: =?windows-1252?Q?EMPFÄNGER?= <empfänger@domain>
Date: Wed, 26 Apr 2017 09:01:48 +0200
MIME-Version: 1.0
Content-Type: text/html; charset=windows-1252
Content-Transfer-Encoding: 7bit
X-Mailer: Kopano 8.2.1-531
Thread-Index: AdK+Wvh8su4aAb1OQuyLT0u4RTRahA==
X-Original-Mailer: Microsoft Outlook 16.0
Message-ID: <kcim.590045dc.99b.791d1c8f2db9a014@mailserverFQDN>

Nothing logged in server.log (log_level 5 - info)

Dagent.log original message (loglevel 5 info)

Wed Apr 26 11:04:49 2017: [info   ] [ 8885] Accepted connection from 127.0.0.1:33222
Wed Apr 26 11:04:49 2017: [info   ] [13490] Starting worker for LMTP request pid 13490
Wed Apr 26 11:04:50 2017: [notice ] [13490] Resolved recipient mailarchiv@domain as user mailarchiv
Wed Apr 26 11:04:50 2017: [notice ] [13490] Resolved recipient USER@DOMAIN as user username
Wed Apr 26 11:04:50 2017: [info   ] [13490] * Loading plugins started
Wed Apr 26 11:04:50 2017: [info   ] [13490] ** Checking plugins in /var/lib/kopano/dagent/plugins
Wed Apr 26 11:04:50 2017: [info   ] [13490] * Loading plugins done
Wed Apr 26 11:04:50 2017: [info   ] [13490] Mail will be delivered in Inbox
Wed Apr 26 11:04:50 2017: [info   ] [13490] * PostConverting processing started
Wed Apr 26 11:04:50 2017: [info   ] [13490] * PostConverting processing done
Wed Apr 26 11:04:50 2017: [info   ] [13490] * PreDelivery processing started
Wed Apr 26 11:04:50 2017: [info   ] [13490] * PreDelivery processing done
Wed Apr 26 11:04:50 2017: [info   ] [13490] * PreRuleProcess processing started
Wed Apr 26 11:04:50 2017: [info   ] [13490] * PreRuleProcess processing done
Wed Apr 26 11:04:50 2017: [info   ] [13490] * PostDelivery processing started
Wed Apr 26 11:04:50 2017: [info   ] [13490] * PostDelivery processing done
Wed Apr 26 11:04:50 2017: [info   ] [13490] * SendNewMailNotify processing started
Wed Apr 26 11:04:50 2017: [info   ] [13490] * SendNewMailNotify processing done
Wed Apr 26 11:04:50 2017: [info   ] [13490] Delivered message to 'mailarchiv', Subject: "test", Message-Id: <kcim.590062b1.34af.13e34e9c0f0b704f@mailserverFQDN>, size 2814
Wed Apr 26 11:04:50 2017: [info   ] [13490] Mail will be delivered in Inbox
Wed Apr 26 11:04:50 2017: [info   ] [13490] * PreDelivery processing started
Wed Apr 26 11:04:50 2017: [info   ] [13490] * PreDelivery processing done
Wed Apr 26 11:04:50 2017: [info   ] [13490] * PreRuleProcess processing started
Wed Apr 26 11:04:50 2017: [info   ] [13490] * PreRuleProcess processing done
Wed Apr 26 11:04:50 2017: [info   ] [13490] Rule Kategorien der E-Mails l?schen (empfohlen) doesn't match: 0x8004010f
Wed Apr 26 11:04:50 2017: [info   ] [13490] * PostDelivery processing started
Wed Apr 26 11:04:50 2017: [info   ] [13490] * PostDelivery processing done
Wed Apr 26 11:04:50 2017: [info   ] [13490] * SendNewMailNotify processing started
Wed Apr 26 11:04:50 2017: [info   ] [13490] * SendNewMailNotify processing done
Wed Apr 26 11:04:50 2017: [info   ] [13490] Delivered message to 'user', Subject: "test", Message-Id: <kcim.590062b1.34af.13e34e9c0f0b704f@mailserverFQDN>, size 2814
Wed Apr 26 11:04:50 2017: [info   ] [13490] Finished processing message
Wed Apr 26 11:04:50 2017: [info   ] [13490] LMTP thread exiting

dagent.log autoresponse message

Wed Apr 26 11:04:56 2017: [info   ] [ 8885] Accepted connection from 127.0.0.1:33414
Wed Apr 26 11:04:56 2017: [info   ] [13504] Starting worker for LMTP request pid 13504
Wed Apr 26 11:04:56 2017: [notice ] [13504] Resolved recipient mailarchiv@DOMAIN as user mailarchiv
Wed Apr 26 11:04:56 2017: [notice ] [13504] Resolved recipient MY_NAME@DOMAIN as user MYUSERNAME
Wed Apr 26 11:04:56 2017: [info   ] [13504] * Loading plugins started
Wed Apr 26 11:04:56 2017: [info   ] [13504] ** Checking plugins in /var/lib/kopano/dagent/plugins
Wed Apr 26 11:04:56 2017: [info   ] [13504] * Loading plugins done
Wed Apr 26 11:04:56 2017: [info   ] [13504] Mail will be delivered in Inbox
Wed Apr 26 11:04:56 2017: [info   ] [13504] * PostConverting processing started
Wed Apr 26 11:04:56 2017: [info   ] [13504] * PostConverting processing done
Wed Apr 26 11:04:56 2017: [info   ] [13504] * PreDelivery processing started
Wed Apr 26 11:04:56 2017: [info   ] [13504] * PreDelivery processing done
Wed Apr 26 11:04:56 2017: [info   ] [13504] * PreRuleProcess processing started
Wed Apr 26 11:04:56 2017: [info   ] [13504] * PreRuleProcess processing done
Wed Apr 26 11:04:56 2017: [info   ] [13504] * PostDelivery processing started
Wed Apr 26 11:04:56 2017: [info   ] [13504] * PostDelivery processing done
Wed Apr 26 11:04:56 2017: [info   ] [13504] * SendNewMailNotify processing started
Wed Apr 26 11:04:56 2017: [info   ] [13504] * SendNewMailNotify processing done
Wed Apr 26 11:04:56 2017: [info   ] [13504] Delivered message to 'mailarchiv', Subject: "RE: test", Message-Id: <kcim.590062b7.34bc.5283dfc804646518@mailserverFQDN>, size 1369
Wed Apr 26 11:04:56 2017: [info   ] [13504] Mail will be delivered in Inbox
Wed Apr 26 11:04:56 2017: [info   ] [13504] * PreDelivery processing started
Wed Apr 26 11:04:56 2017: [info   ] [13504] * PreDelivery processing done
Wed Apr 26 11:04:56 2017: [info   ] [13504] * PreRuleProcess processing started
Wed Apr 26 11:04:56 2017: [info   ] [13504] * PreRuleProcess processing done
Wed Apr 26 11:04:56 2017: [info   ] [13504] Rule Kategorien der E-Mails l?schen (empfohlen) doesn't match: 0x8004010f
Wed Apr 26 11:04:56 2017: [info   ] [13504] * PostDelivery processing started
Wed Apr 26 11:04:56 2017: [info   ] [13504] * PostDelivery processing done
Wed Apr 26 11:04:56 2017: [info   ] [13504] * SendNewMailNotify processing started
Wed Apr 26 11:04:56 2017: [info   ] [13504] * SendNewMailNotify processing done
Wed Apr 26 11:04:56 2017: [info   ] [13504] Delivered message to 'myusername', Subject: "RE: test", Message-Id: <kcim.590062b7.34bc.5283dfc804646518@mailserverFQDN>, size 1369
Wed Apr 26 11:04:56 2017: [info   ] [13504] Finished processing message
Wed Apr 26 11:04:56 2017: [info   ] [13504] LMTP thread exiting

nothing special logged in gateway.log (loglevel 5 - info)

(btw. the Ruleset “Kategorien der E-Mails l?schen (empfohlen)” is imported from times when i used ZCP - i cant find the exact error either - just the implemitation in rules.cpp to figure out that some rules are not working - but not the fix. This issue has nothing to do with the autoreply - every maildelivery having this error.)
//PS: just found out, that this message “Rule ‘some rule’ doesn’t match: 0x8004010f” is for information that this specific rule doesnt match this mail. - but its a valid rule " - a bit tricky to read with an error-code and never seen “Rule ‘some rule’ matches” :)

Thanks in advance,

Coffee_is_life

Hello @Coffee_is_life ,

if the message would have been triggered from within Kopano, then you actually should see a message like the following in the log:

Wed Apr 26 08:33:54 2017: [info   ] [ 1577] Starting autoresponder for out-of-office message

@fbartels said in Auto-response out of nowhere:

Hello @Coffee_is_life ,

if the message would have been triggered from within Kopano, then you actually should see a message like the following in the log:

Wed Apr 26 08:33:54 2017: [info   ] [ 1577] Starting autoresponder for out-of-office message

It would be nice to see this message cause that would give me a hint. - But i cant see any message in postfix, kopano-server, kopano-dagent or z-push. This occures even when the client is offline. So this must be server-based.
Any idea how i can determine which module causes this?

I will set the ad-user as “no mail client” and enable it again, so the user will be deleted and recreated in kopano-server.
This will take action today evening. - reply tomorrow for the status.

@Coffee_is_life that log would be in the dagent.log. I would recommend to up the loglevel of kopano-dagent.

@fbartels said in Auto-response out of nowhere:

@Coffee_is_life that log would be in the dagent.log. I would recommend to up the loglevel of kopano-dagent.

done:

Wed Apr 26 16:24:35 2017: [info   ] [ 8885] Accepted connection from 127.0.0.1:60860
Wed Apr 26 16:24:35 2017: [info   ] [11299] Starting worker for LMTP request pid 11299
Wed Apr 26 16:24:35 2017: [debug  ] [11299] PYTHONPATH = /usr/share/kopano-dagent/python
Wed Apr 26 16:24:36 2017: [debug  ] [11299] < 220 2.1.5 LMTP server is ready
Wed Apr 26 16:24:36 2017: [debug  ] [11299] > LHLO mx01.DOMAIN
Wed Apr 26 16:24:36 2017: [debug  ] [11299] LHLO ID: mx01.DOMAIN
Wed Apr 26 16:24:36 2017: [debug  ] [11299] < 250-SERVER ready
Wed Apr 26 16:24:36 2017: [debug  ] [11299] < 250-PIPELINING
Wed Apr 26 16:24:36 2017: [debug  ] [11299] < 250-ENHANCEDSTATUSCODE
Wed Apr 26 16:24:36 2017: [debug  ] [11299] < 250 RSET
Wed Apr 26 16:24:36 2017: [debug  ] [11299] > MAIL FROM:<ORIG-SENDER@DOMAIN>
Wed Apr 26 16:24:36 2017: [debug  ] [11299] < 250 2.1.0 Ok
Wed Apr 26 16:24:36 2017: [debug  ] [11299] > RCPT TO:<mailarchiv@DOMAIN>
Wed Apr 26 16:24:36 2017: [debug  ] [11299] Resolved command "RCPT TO:<mailarchiv@DOMAIN>" to recipient address "mailarchiv@DOMAIN"
Wed Apr 26 16:24:36 2017: [notice ] [11299] Resolved recipient mailarchiv@DOMAIN as user mailarchiv
Wed Apr 26 16:24:36 2017: [debug  ] [11299] < 250 2.1.5 Ok
Wed Apr 26 16:24:36 2017: [debug  ] [11299] > RCPT TO:<ORIG-RECEIVER@DOMAIN>
Wed Apr 26 16:24:36 2017: [debug  ] [11299] Resolved command "RCPT TO:<ORIG-RECEIVER@DOMAIN>" to recipient address "ORIG-RECEIVER@DOMAIN"
Wed Apr 26 16:24:36 2017: [notice ] [11299] Resolved recipient ORIG-RECEIVER@DOMAIN as user USERNAME-RECEIVER
Wed Apr 26 16:24:36 2017: [debug  ] [11299] < 250 2.1.5 Ok
Wed Apr 26 16:24:36 2017: [debug  ] [11299] > DATA
Wed Apr 26 16:24:36 2017: [debug  ] [11299] < 354 2.1.5 Start mail input; end with <CRLF>.<CRLF>
Wed Apr 26 16:24:36 2017: [info   ] [11299] * Loading plugins started
Wed Apr 26 16:24:36 2017: [info   ] [11299] ** Checking plugins in /var/lib/kopano/dagent/plugins
Wed Apr 26 16:24:36 2017: [info   ] [11299] * Loading plugins done
Wed Apr 26 16:24:36 2017: [info   ] [11299] Mail will be delivered in Inbox
Wed Apr 26 16:24:36 2017: [debug  ] [11299] Trying to parse alternative multipart 1 of mail body
Wed Apr 26 16:24:36 2017: [debug  ] [11299] HTML4 meta tag found: charset="text/html; charset=iso-8859-1"
Wed Apr 26 16:24:36 2017: [debug  ] [11299] HTML charset adjusted to "iso-8859-1"
Wed Apr 26 16:24:36 2017: [debug  ] [11299] MIME headers declare charset "utf-8", while HTML meta tag declares "iso-8859-1".
Wed Apr 26 16:24:36 2017: [debug  ] [11299] renovate_encoding: reading data using charset "utf-8" succeeded.
Wed Apr 26 16:24:36 2017: [info   ] [11299] * PostConverting processing started
Wed Apr 26 16:24:36 2017: [info   ] [11299] * PostConverting processing done
Wed Apr 26 16:24:36 2017: [info   ] [11299] * PreDelivery processing started
Wed Apr 26 16:24:36 2017: [info   ] [11299] * PreDelivery processing done
Wed Apr 26 16:24:36 2017: [info   ] [11299] * PreRuleProcess processing started
Wed Apr 26 16:24:36 2017: [info   ] [11299] * PreRuleProcess processing done
Wed Apr 26 16:24:36 2017: [debug  ] [11299] Target user has OOF inactive

Wed Apr 26 16:24:37 2017: [info   ] [11299] * PostDelivery processing started
Wed Apr 26 16:24:37 2017: [info   ] [11299] * PostDelivery processing done
Wed Apr 26 16:24:37 2017: [info   ] [11299] * SendNewMailNotify processing started
Wed Apr 26 16:24:37 2017: [info   ] [11299] * SendNewMailNotify processing done
Wed Apr 26 16:24:37 2017: [debug  ] [11299] Send 'New Mail' notification
Wed Apr 26 16:24:37 2017: [info   ] [11299] Delivered message to 'mailarchiv', Subject: "test", Message-Id: <kcim.5900ada3.2c1f.0db0011d360a301f@mailserverFQDN>, size 3598
Wed Apr 26 16:24:37 2017: [info   ] [11299] Mail will be delivered in Inbox
Wed Apr 26 16:24:37 2017: [info   ] [11299] * PreDelivery processing started
Wed Apr 26 16:24:37 2017: [info   ] [11299] * PreDelivery processing done
Wed Apr 26 16:24:37 2017: [info   ] [11299] * PreRuleProcess processing started
Wed Apr 26 16:24:37 2017: [info   ] [11299] * PreRuleProcess processing done
Wed Apr 26 16:24:37 2017: [debug  ] [11299] Processing rule Kategorien der E-Mails l?schen (empfohlen) for USERNAME-RECEIVER
Wed Apr 26 16:24:37 2017: [info   ] [11299] Rule Kategorien der E-Mails l?schen (empfohlen) doesn't match: 0x8004010f
Wed Apr 26 16:24:37 2017: [debug  ] [11299] Target user has OOF inactive

Wed Apr 26 16:24:37 2017: [info   ] [11299] * PostDelivery processing started
Wed Apr 26 16:24:37 2017: [info   ] [11299] * PostDelivery processing done
Wed Apr 26 16:24:37 2017: [info   ] [11299] * SendNewMailNotify processing started
Wed Apr 26 16:24:37 2017: [info   ] [11299] * SendNewMailNotify processing done
Wed Apr 26 16:24:37 2017: [debug  ] [11299] Send 'New Mail' notification
Wed Apr 26 16:24:37 2017: [info   ] [11299] Delivered message to 'USERNAME-RECEIVER', Subject: "test", Message-Id: <kcim.5900ada3.2c1f.0db0011d360a301f@mailserverFQDN>, size 3598
Wed Apr 26 16:24:37 2017: [info   ] [11299] Finished processing message
Wed Apr 26 16:24:37 2017: [debug  ] [11299] < 250 2.1.5 mailarchiv@DOMAIN Ok
Wed Apr 26 16:24:37 2017: [debug  ] [11299] < 250 2.1.5 ORIG-RECEIVER@DOMAIN Ok
Wed Apr 26 16:24:37 2017: [debug  ] [11299] > QUIT
Wed Apr 26 16:24:37 2017: [debug  ] [11299] < 221 2.0.0 Bye
Wed Apr 26 16:24:37 2017: [info   ] [11299] LMTP thread exiting
Wed Apr 26 16:24:41 2017: [info   ] [ 8885] Accepted connection from 127.0.0.1:32854
Wed Apr 26 16:24:41 2017: [info   ] [11316] Starting worker for LMTP request pid 11316
Wed Apr 26 16:24:41 2017: [debug  ] [11316] PYTHONPATH = /usr/share/kopano-dagent/python
Wed Apr 26 16:24:41 2017: [debug  ] [11316] < 220 2.1.5 LMTP server is ready
Wed Apr 26 16:24:41 2017: [debug  ] [11316] > LHLO mx01.DOMAIN
Wed Apr 26 16:24:41 2017: [debug  ] [11316] LHLO ID: mx01.DOMAIN
Wed Apr 26 16:24:41 2017: [debug  ] [11316] < 250-SERVER ready
Wed Apr 26 16:24:41 2017: [debug  ] [11316] < 250-PIPELINING
Wed Apr 26 16:24:41 2017: [debug  ] [11316] < 250-ENHANCEDSTATUSCODE
Wed Apr 26 16:24:41 2017: [debug  ] [11316] < 250 RSET
Wed Apr 26 16:24:41 2017: [debug  ] [11316] > MAIL FROM:<ORIG-RECEIVER@DOMAIN>
Wed Apr 26 16:24:41 2017: [debug  ] [11316] < 250 2.1.0 Ok
Wed Apr 26 16:24:41 2017: [debug  ] [11316] > RCPT TO:<ORIG-SENDER@DOMAIN>
Wed Apr 26 16:24:41 2017: [debug  ] [11316] Resolved command "RCPT TO:<ORIG-SENDER@DOMAIN>" to recipient address "ORIG-SENDER@DOMAIN"
Wed Apr 26 16:24:41 2017: [notice ] [11316] Resolved recipient ORIG-SENDER@DOMAIN as user USERNAME-SENDER
Wed Apr 26 16:24:41 2017: [debug  ] [11316] < 250 2.1.5 Ok
Wed Apr 26 16:24:41 2017: [debug  ] [11316] > RCPT TO:<mailarchiv@DOMAIN>
Wed Apr 26 16:24:41 2017: [debug  ] [11316] Resolved command "RCPT TO:<mailarchiv@DOMAIN>" to recipient address "mailarchiv@DOMAIN"
Wed Apr 26 16:24:41 2017: [notice ] [11316] Resolved recipient mailarchiv@DOMAIN as user mailarchiv
Wed Apr 26 16:24:41 2017: [debug  ] [11316] < 250 2.1.5 Ok
Wed Apr 26 16:24:41 2017: [debug  ] [11316] > DATA
Wed Apr 26 16:24:41 2017: [debug  ] [11316] < 354 2.1.5 Start mail input; end with <CRLF>.<CRLF>
Wed Apr 26 16:24:41 2017: [info   ] [11316] * Loading plugins started
Wed Apr 26 16:24:41 2017: [info   ] [11316] ** Checking plugins in /var/lib/kopano/dagent/plugins
Wed Apr 26 16:24:41 2017: [info   ] [11316] * Loading plugins done
Wed Apr 26 16:24:41 2017: [info   ] [11316] Mail will be delivered in Inbox
Wed Apr 26 16:24:41 2017: [debug  ] [11316] HTML4 meta tag found: charset="text/html; charset=us-ascii"
Wed Apr 26 16:24:41 2017: [debug  ] [11316] HTML charset adjusted to "us-ascii"
Wed Apr 26 16:24:41 2017: [debug  ] [11316] MIME headers declare charset "windows-1252", while HTML meta tag declares "us-ascii".
Wed Apr 26 16:24:41 2017: [debug  ] [11316] Admin forced charset upgrade "us-ascii" -> "iso-8859-15".
Wed Apr 26 16:24:41 2017: [debug  ] [11316] renovate_encoding: reading data using charset "windows-1252" succeeded.
Wed Apr 26 16:24:41 2017: [info   ] [11316] * PostConverting processing started
Wed Apr 26 16:24:41 2017: [info   ] [11316] * PostConverting processing done
Wed Apr 26 16:24:41 2017: [info   ] [11316] * PreDelivery processing started
Wed Apr 26 16:24:41 2017: [info   ] [11316] * PreDelivery processing done
Wed Apr 26 16:24:41 2017: [info   ] [11316] * PreRuleProcess processing started
Wed Apr 26 16:24:41 2017: [info   ] [11316] * PreRuleProcess processing done
Wed Apr 26 16:24:41 2017: [debug  ] [11316] Processing rule Let's Encrypt Expiry Bot for USERNAME-SENDER
Wed Apr 26 16:24:41 2017: [info   ] [11316] Rule Let's Encrypt Expiry Bot doesn't match: 0x8004010f
Wed Apr 26 16:24:41 2017: [debug  ] [11316] Processing rule Kategorien der E-Mails l?schen (empfohlen) for USERNAME-SENDER
Wed Apr 26 16:24:41 2017: [info   ] [11316] Rule Kategorien der E-Mails l?schen (empfohlen) doesn't match: 0x8004010f
Wed Apr 26 16:24:41 2017: [debug  ] [11316] Target user has OOF inactive

Wed Apr 26 16:24:41 2017: [info   ] [11316] * PostDelivery processing started
Wed Apr 26 16:24:41 2017: [info   ] [11316] * PostDelivery processing done
Wed Apr 26 16:24:41 2017: [info   ] [11316] * SendNewMailNotify processing started
Wed Apr 26 16:24:41 2017: [info   ] [11316] * SendNewMailNotify processing done
Wed Apr 26 16:24:41 2017: [debug  ] [11316] Send 'New Mail' notification
Wed Apr 26 16:24:41 2017: [info   ] [11316] Delivered message to 'USERNAME-SENDER', Subject: "RE: test", Message-Id: <kcim.5900ada8.2c30.0e182bab43d88a92@mailserverFQDN>, size 1360
Wed Apr 26 16:24:41 2017: [info   ] [11316] Mail will be delivered in Inbox
Wed Apr 26 16:24:41 2017: [info   ] [11316] * PreDelivery processing started
Wed Apr 26 16:24:41 2017: [info   ] [11316] * PreDelivery processing done
Wed Apr 26 16:24:41 2017: [info   ] [11316] * PreRuleProcess processing started
Wed Apr 26 16:24:41 2017: [info   ] [11316] * PreRuleProcess processing done
Wed Apr 26 16:24:41 2017: [debug  ] [11316] Target user has OOF inactive

Wed Apr 26 16:24:42 2017: [info   ] [11316] * PostDelivery processing started
Wed Apr 26 16:24:42 2017: [info   ] [11316] * PostDelivery processing done
Wed Apr 26 16:24:42 2017: [info   ] [11316] * SendNewMailNotify processing started
Wed Apr 26 16:24:42 2017: [info   ] [11316] * SendNewMailNotify processing done
Wed Apr 26 16:24:42 2017: [debug  ] [11316] Send 'New Mail' notification
Wed Apr 26 16:24:42 2017: [info   ] [11316] Delivered message to 'mailarchiv', Subject: "RE: test", Message-Id: <kcim.5900ada8.2c30.0e182bab43d88a92@mailserverFQDN>, size 1360
Wed Apr 26 16:24:42 2017: [info   ] [11316] Finished processing message
Wed Apr 26 16:24:42 2017: [debug  ] [11316] < 250 2.1.5 ORIG-SENDER@DOMAIN Ok
Wed Apr 26 16:24:42 2017: [debug  ] [11316] < 250 2.1.5 mailarchiv@DOMAIN Ok
Wed Apr 26 16:24:42 2017: [debug  ] [11316] > QUIT
Wed Apr 26 16:24:42 2017: [debug  ] [11316] < 221 2.0.0 Bye
Wed Apr 26 16:24:42 2017: [info   ] [11316] LMTP thread exiting

The blank line after " Target user has OOF inactive" is originally from log.

And the z-Push log from the receiving user:

2017/04/26 16:24:39.490 (1,VSTA_Main): Trace: ZPushFolder: New item Posteingang: 00000000A33F64A62E31A5429353AFBB687C4A960700C3B68E10F77511CEB4CD00AA00BBB6E600000000000C0000D9539C2261A6BB45B9DAB62C7081B3C10100EE3200000000
2017/04/26 16:24:39.490 (1,VSTA_Main): Debug: ZPushFolder: Folder changed in USERNAME-RECEIVER@DOMAIN: Posteingang
2017/04/26 16:24:39.490 (1,VSTA_Main): Trace: ZPushWatcher: Folder changed: Posteingang
2017/04/26 16:24:39.490 (1,VSTA_Main): Debug: ZPushWatcher: Folder event: Posteingang, ReplyFlags:MailItem, False
2017/04/26 16:24:39.505 (1,VSTA_Main): Debug: ZPushFolder: Folder changed in USERNAME-RECEIVER@DOMAIN: Postausgang
2017/04/26 16:24:39.505 (1,VSTA_Main): Debug: ZPushFolder: Folder change on unreported folder in USERNAME-RECEIVER@DOMAIN: Postausgang, 00000000A33F64A62E31A5429353AFBB687C4A960100C3B68E10F77511CEB4CD00AA00BBB6E600000000000D0000, USERNAME-RECEIVER@DOMAIN
2017/04/26 16:24:39.505 (1,VSTA_Main): Trace: ZPushFolder: Excluding child on USERNAME-RECEIVER@DOMAIN: \\USERNAME-RECEIVER@DOMAIN\Postausgang
2017/04/26 16:24:40.242 (1,VSTA_Main): Debug: ZPushFolder: Folder changed in USERNAME-RECEIVER@DOMAIN: Postausgang
2017/04/26 16:24:40.242 (1,VSTA_Main): Debug: ZPushFolder: Folder change on unreported folder in USERNAME-RECEIVER@DOMAIN: Postausgang, 00000000A33F64A62E31A5429353AFBB687C4A960100C3B68E10F77511CEB4CD00AA00BBB6E600000000000D0000, USERNAME-RECEIVER@DOMAIN
2017/04/26 16:24:40.242 (1,VSTA_Main): Trace: ZPushFolder: Excluding child on USERNAME-RECEIVER@DOMAIN: \\USERNAME-RECEIVER@DOMAIN\Postausgang
2017/04/26 16:24:40.773 (1,VSTA_Main): Trace: ZPushFolder: Changed item Posteingang
2017/04/26 16:24:44.832 (1,VSTA_Main): Debug: ZPushFolder: Folder changed in USERNAME-RECEIVER@DOMAIN: Gesendete Elemente
2017/04/26 16:24:44.832 (1,VSTA_Main): Trace: ZPushWatcher: Folder changed: Gesendete Elemente
2017/04/26 16:24:44.832 (1,VSTA_Main): Debug: ZPushWatcher: Folder event: Gesendete Elemente, ReplyFlags:MailItem, False
2017/04/26 16:24:44.832 (1,VSTA_Main): Debug: ZPushFolder: Folder changed in USERNAME-RECEIVER@DOMAIN: Gesendete Elemente
2017/04/26 16:24:44.832 (1,VSTA_Main): Trace: ZPushWatcher: Folder changed: Gesendete Elemente
2017/04/26 16:24:44.832 (1,VSTA_Main): Debug: ZPushWatcher: Folder event: Gesendete Elemente, ReplyFlags:MailItem, False
2017/04/26 16:24:44.843 (1,VSTA_Main): Trace: ZPushFolder: New item Gesendete Elemente: 00000000A33F64A62E31A5429353AFBB687C4A960700C3B68E10F77511CEB4CD00AA00BBB6E600000000000E0000D9539C2261A6BB45B9DAB62C7081B3C10100EF3200000000
2017/04/26 16:24:44.843 (1,VSTA_Main): Debug: ZPushFolder: Folder changed in USERNAME-RECEIVER@DOMAIN: Gesendete Elemente
2017/04/26 16:24:44.843 (1,VSTA_Main): Trace: ZPushWatcher: Folder changed: Gesendete Elemente
2017/04/26 16:24:44.843 (1,VSTA_Main): Debug: ZPushWatcher: Folder event: Gesendete Elemente, ReplyFlags:MailItem, False
2017/04/26 16:24:44.856 (1,VSTA_Main): Debug: ZPushFolder: Folder changed in USERNAME-RECEIVER@DOMAIN: Gesendete Elemente
2017/04/26 16:24:44.856 (1,VSTA_Main): Trace: ZPushWatcher: Folder changed: Gesendete Elemente
2017/04/26 16:24:44.856 (1,VSTA_Main): Debug: ZPushWatcher: Folder event: Gesendete Elemente, ReplyFlags:MailItem, False
2017/04/26 16:24:44.856 (1,VSTA_Main): Debug: ZPushFolder: Folder changed in USERNAME-RECEIVER@DOMAIN: Gesendete Elemente
2017/04/26 16:24:44.856 (1,VSTA_Main): Trace: ZPushWatcher: Folder changed: Gesendete Elemente
2017/04/26 16:24:44.856 (1,VSTA_Main): Debug: ZPushWatcher: Folder event: Gesendete Elemente, ReplyFlags:MailItem, False
2017/04/26 16:24:44.856 (1,VSTA_Main): Debug: ZPushFolder: Folder changed in USERNAME-RECEIVER@DOMAIN: Gesendete Elemente
2017/04/26 16:24:44.867 (1,VSTA_Main): Trace: ZPushWatcher: Folder changed: Gesendete Elemente
2017/04/26 16:24:44.867 (1,VSTA_Main): Debug: ZPushWatcher: Folder event: Gesendete Elemente, ReplyFlags:MailItem, False
2017/04/26 16:24:44.979 (1,VSTA_Main): Debug: ZPushFolder: Folder changed in USERNAME-RECEIVER@DOMAIN: Gesendete Elemente
2017/04/26 16:24:44.979 (1,VSTA_Main): Trace: ZPushWatcher: Folder changed: Gesendete Elemente
2017/04/26 16:24:44.979 (1,VSTA_Main): Debug: ZPushWatcher: Folder event: Gesendete Elemente, ReplyFlags:MailItem, False
2017/04/26 16:24:46.972 (1,VSTA_Main): Debug: ZPushFolder: Folder changed in USERNAME-RECEIVER@DOMAIN: Gesendete Elemente
2017/04/26 16:24:46.976 (1,VSTA_Main): Trace: ZPushWatcher: Folder changed: Gesendete Elemente
2017/04/26 16:24:46.976 (1,VSTA_Main): Debug: ZPushWatcher: Folder event: Gesendete Elemente, ReplyFlags:MailItem, False
2017/04/26 16:24:46.976 (1,VSTA_Main): Debug: ZPushFolder: Folder changed in USERNAME-RECEIVER@DOMAIN: Gesendete Elemente
2017/04/26 16:24:46.976 (1,VSTA_Main): Trace: ZPushWatcher: Folder changed: Gesendete Elemente
2017/04/26 16:24:46.976 (1,VSTA_Main): Debug: ZPushWatcher: Folder event: Gesendete Elemente, ReplyFlags:MailItem, False
2017/04/26 16:24:49.759 (1,VSTA_Main): Debug: ZPushFolder: Folder changed in USERNAME-RECEIVER@DOMAIN: Gesendete Elemente
2017/04/26 16:24:49.759 (1,VSTA_Main): Trace: ZPushWatcher: Folder changed: Gesendete Elemente
2017/04/26 16:24:49.759 (1,VSTA_Main): Debug: ZPushWatcher: Folder event: Gesendete Elemente, ReplyFlags:MailItem, False
2017/04/26 16:24:49.765 (1,VSTA_Main): Trace: ZPushFolder: New item Gesendete Elemente: 00000000A33F64A62E31A5429353AFBB687C4A960700C3B68E10F77511CEB4CD00AA00BBB6E600000000000E0000D9539C2261A6BB45B9DAB62C7081B3C10100F03200000000
2017/04/26 16:24:49.765 (1,VSTA_Main): Trace: ZPushFolder: New item Gesendete Elemente: 00000000A33F64A62E31A5429353AFBB687C4A960700C3B68E10F77511CEB4CD00AA00BBB6E600000000000E0000D9539C2261A6BB45B9DAB62C7081B3C10100F13200000000
2017/04/26 16:27:34.930 (1,VSTA_Main): Trace: ZPushFolder: New item Posteingang: 00000000A33F64A62E31A5429353AFBB687C4A960700C3B68E10F77511CEB4CD00AA00BBB6E600000000000C0000D9539C2261A6BB45B9DAB62C7081B3C10100F23200000000
2017/04/26 16:27:34.930 (1,VSTA_Main): Debug: ZPushFolder: Folder changed in USERNAME-RECEIVER@DOMAIN: Posteingang
2017/04/26 16:27:34.930 (1,VSTA_Main): Trace: ZPushWatcher: Folder changed: Posteingang
2017/04/26 16:27:34.930 (1,VSTA_Main): Debug: ZPushWatcher: Folder event: Posteingang, ReplyFlags:MailItem, False

hopefully you see something i cant :)

Coffee_is_life

Good morning everyone,

i think i’ve found this bug:

This specific user turned on absence assistant before we used kopano via zarafa mapi client, connected to ZCP 7.2.4.
He came back, got a new pc with office2016 and Kopano via z-push and disabled the feature. The message was deleted but the automatic reply was still present.
Even turning oof on and off via ‘kopano-set-oof’ didnt solve this.

Solution:
Delete all outlook-profiles
restart computer
delete the local profile (windows)
resync it from server.
create new kopano-profile
turn on oof via kopano KOE
turn off oof via kopano KOE

didnt get a message since than. - Maybe the resync from server isnt needed, but i did it to be sure and it worked.

closed for me

Coffee_is_life