LOG-Entry "Autoresponder failed" after update to Kopano 8.7.1
-
WebApp: 3.5.6.2298+94.1
Kopano Core: 8.7.1
Z-Push: 2.5.0+0-0
Ubuntu 16.04.6 LTSHello together,
after the update to Kopano 8.7.1 i get a log entry “Autoresponder failed” in the dagent.log. But the Autoresponder works. I tested it twice.Here the debug:
Sat Jun 1 09:40:48 2019: [info ] Accepted connection from [::ffff:127.0.0.1]:59056 Sat Jun 1 09:40:48 2019: [info ] Starting worker for LMTP request pid 5464 Sat Jun 1 09:40:48 2019: [debug ] Initializing provider "Kopano Directory Service" Sat Jun 1 09:40:48 2019: [debug ] Initializing provider "Private Folders" Sat Jun 1 09:40:48 2019: [debug ] Initializing provider "Public Folders" Sat Jun 1 09:40:48 2019: [debug ] < 220 2.1.5 LMTP server is ready Sat Jun 1 09:40:48 2019: [debug ] > LHLO svgrw.XXXXX.lan Sat Jun 1 09:40:48 2019: [debug ] LHLO ID: svgrw.XXXXX.lan Sat Jun 1 09:40:48 2019: [debug ] < 250-SERVER ready Sat Jun 1 09:40:48 2019: [debug ] < 250-PIPELINING Sat Jun 1 09:40:48 2019: [debug ] < 250-8BITMIME Sat Jun 1 09:40:48 2019: [debug ] < 250-ENHANCEDSTATUSCODE Sat Jun 1 09:40:48 2019: [debug ] < 250-RSET Sat Jun 1 09:40:48 2019: [debug ] < 250 SMTPUTF8 Sat Jun 1 09:40:48 2019: [debug ] > MAIL FROM:<MAX.MUSTERMANN@XXXXX.com> Sat Jun 1 09:40:48 2019: [debug ] < 250 2.1.0 Ok Sat Jun 1 09:40:48 2019: [debug ] > RCPT TO:<MICHAEL.KRAFTMANN@XXXXX.com> Sat Jun 1 09:40:48 2019: [debug ] Resolved command "RCPT TO:<MICHAEL.KRAFTMANN@XXXXX.com>" to recipient address "MICHAEL.KRAFTMANN@XXXXX.com" Sat Jun 1 09:40:48 2019: [notice ] Resolved recipient MICHAEL.KRAFTMANN@XXXXX.com as user KRAFTMANN Sat Jun 1 09:40:48 2019: [debug ] < 250 2.1.5 Ok Sat Jun 1 09:40:48 2019: [debug ] > DATA Sat Jun 1 09:40:48 2019: [debug ] < 354 2.1.5 Start mail input; end with <CRLF>.<CRLF> Sat Jun 1 09:40:49 2019: [debug ] PYTHONPATH = /usr/share/kopano-dagent/python Sat Jun 1 09:40:49 2019: [info ] * Loading plugins started Sat Jun 1 09:40:49 2019: [info ] ** Checking plugins in /var/lib/kopano/dagent/plugins Sat Jun 1 09:40:49 2019: [info ] * Loading plugins done Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Kopano Directory Service" Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Private Folders" Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Public Folders" Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Kopano Directory Service" Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Private Folders" Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Public Folders" Sat Jun 1 09:40:49 2019: [info ] Mail will be delivered in Inbox Sat Jun 1 09:40:49 2019: [debug ] HTML4 meta tag found: charset="text/html; charset=utf-8" Sat Jun 1 09:40:49 2019: [debug ] HTML charset adjusted to "utf-8" Sat Jun 1 09:40:49 2019: [debug ] renovate_encoding: reading data using charset "utf-8" succeeded. Sat Jun 1 09:40:49 2019: [info ] * PostConverting processing started Sat Jun 1 09:40:49 2019: [info ] * PostConverting processing done Sat Jun 1 09:40:49 2019: [info ] * PreDelivery processing started Sat Jun 1 09:40:49 2019: [info ] * PreDelivery processing done Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Kopano Directory Service" Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Private Folders" Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Public Folders" Sat Jun 1 09:40:49 2019: [info ] * PreRuleProcess processing started Sat Jun 1 09:40:49 2019: [info ] * PreRuleProcess processing done Sat Jun 1 09:40:49 2019: [debug ] Target user has OOF active Sat Jun 1 09:40:49 2019: [info ] Starting autoresponder for out-of-office message Sat Jun 1 09:40:49 2019: [debug ] Running command: "/usr/sbin/kopano-autorespond" "MICHAEL.KRAFTMANN@XXXXX.com" "MAX.MUSTERMANN@XXXXX.com" "Abwesend/Out of office" "KRAFTMANN" "/tm p/autorespond.aIQPas" Sat Jun 1 09:40:49 2019: [error ] Autoresponder failed Sat Jun 1 09:40:49 2019: [info ] Accepted connection from [::ffff:127.0.0.1]:59058 Sat Jun 1 09:40:49 2019: [info ] Starting worker for LMTP request pid 5484 Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Kopano Directory Service" Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Private Folders" Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Public Folders" Sat Jun 1 09:40:49 2019: [info ] * PostDelivery processing started Sat Jun 1 09:40:49 2019: [info ] * PostDelivery processing done Sat Jun 1 09:40:49 2019: [info ] * SendNewMailNotify processing started Sat Jun 1 09:40:49 2019: [info ] * SendNewMailNotify processing done Sat Jun 1 09:40:49 2019: [debug ] Send 'New Mail' notification Sat Jun 1 09:40:49 2019: [info ] Delivered message to "KRAFTMANN", Subject: "Test IT ignorieren", Message-Id: <kcis.73E3E1E3609146B0A133E5DE3A90CA67@svgrw>, size 1321 Sat Jun 1 09:40:49 2019: [info ] Finished processing message Sat Jun 1 09:40:49 2019: [debug ] < 250 2.1.5 MICHAEL.KRAFTMANN@XXXXX.com Ok Sat Jun 1 09:40:49 2019: [debug ] > QUIT Sat Jun 1 09:40:49 2019: [debug ] < 221 2.0.0 Bye Sat Jun 1 09:40:49 2019: [info ] LMTP thread exiting Sat Jun 1 09:40:49 2019: [debug ] < 220 2.1.5 LMTP server is ready Sat Jun 1 09:40:49 2019: [debug ] > LHLO svgrw.XXXXX.lan Sat Jun 1 09:40:49 2019: [debug ] LHLO ID: svgrw.XXXXX.lan Sat Jun 1 09:40:49 2019: [debug ] < 250-SERVER ready Sat Jun 1 09:40:49 2019: [debug ] < 250-PIPELINING Sat Jun 1 09:40:49 2019: [debug ] < 250-8BITMIME Sat Jun 1 09:40:49 2019: [debug ] < 250-ENHANCEDSTATUSCODE Sat Jun 1 09:40:49 2019: [debug ] < 250-RSET Sat Jun 1 09:40:49 2019: [debug ] < 250 SMTPUTF8 Sat Jun 1 09:40:49 2019: [debug ] > MAIL FROM:<MICHAEL.KRAFTMANN@XXXXX.com> Sat Jun 1 09:40:49 2019: [debug ] < 250 2.1.0 Ok Sat Jun 1 09:40:49 2019: [debug ] > RCPT TO:<MAX.MUSTERMANN@XXXXX.com> Sat Jun 1 09:40:49 2019: [debug ] Resolved command "RCPT TO:<MAX.MUSTERMANN@XXXXX.com>" to recipient address "MAX.MUSTERMANN@XXXXX.com" Sat Jun 1 09:40:49 2019: [notice ] Resolved recipient MAX.MUSTERMANN@XXXXX.com as user MUSTERMANN Sat Jun 1 09:40:49 2019: [debug ] < 250 2.1.5 Ok Sat Jun 1 09:40:49 2019: [debug ] > DATA Sat Jun 1 09:40:49 2019: [debug ] < 354 2.1.5 Start mail input; end with <CRLF>.<CRLF> Sat Jun 1 09:40:49 2019: [debug ] PYTHONPATH = /usr/share/kopano-dagent/python Sat Jun 1 09:40:49 2019: [info ] * Loading plugins started Sat Jun 1 09:40:49 2019: [info ] ** Checking plugins in /var/lib/kopano/dagent/plugins Sat Jun 1 09:40:49 2019: [info ] * Loading plugins done Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Kopano Directory Service" Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Private Folders" Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Public Folders" Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Kopano Directory Service" Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Private Folders" Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Public Folders" Sat Jun 1 09:40:49 2019: [info ] Mail will be delivered in Inbox Sat Jun 1 09:40:49 2019: [info ] * PostConverting processing started Sat Jun 1 09:40:49 2019: [info ] * PostConverting processing done Sat Jun 1 09:40:49 2019: [info ] * PreDelivery processing started Sat Jun 1 09:40:49 2019: [info ] * PreDelivery processing done Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Kopano Directory Service" Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Private Folders" Sat Jun 1 09:40:49 2019: [debug ] Initializing provider "Public Folders" Sat Jun 1 09:40:49 2019: [info ] * PreRuleProcess processing started Sat Jun 1 09:40:49 2019: [info ] * PreRuleProcess processing done Sat Jun 1 09:40:49 2019: [debug ] Target user has OOF inactive Sat Jun 1 09:40:49 2019: [info ] * PostDelivery processing started Sat Jun 1 09:40:49 2019: [info ] * PostDelivery processing done Sat Jun 1 09:40:49 2019: [info ] * SendNewMailNotify processing started Sat Jun 1 09:40:49 2019: [info ] * SendNewMailNotify processing done Sat Jun 1 09:40:49 2019: [debug ] Send 'New Mail' notification Sat Jun 1 09:40:49 2019: [info ] Delivered message to "MUSTERMANN", Subject: "Abwesend/Out of office [Test IT ignorieren]", Message-Id: <20190601074049.3174F1140306@svgrw.XXXXX. lan>, size 1513 Sat Jun 1 09:40:49 2019: [info ] Finished processing message Sat Jun 1 09:40:49 2019: [debug ] < 250 2.1.5 MAX.MUSTERMANN@XXXXX.com Ok Sat Jun 1 09:40:49 2019: [debug ] > QUIT Sat Jun 1 09:40:49 2019: [debug ] < 221 2.0.0 Bye Sat Jun 1 09:40:49 2019: [info ] LMTP thread exiting
Is this something I have to worry about? I can’t find the cause of the error entry.
-