Navigation

    Kopano
    • Register
    • Login
    • Search
    • Categories
    • Get Official Kopano Support
    • Recent
    Statement regarding the closure of the Kopano community forum and the end of the community edition

    LOG-Entry "Autoresponder failed" after update to Kopano 8.7.1

    Kopano Groupware Core
    2
    2
    189
    Loading More Posts
    • Oldest to Newest
    • Newest to Oldest
    • Most Votes
    Reply
    • Reply as topic
    Log in to reply
    This topic has been deleted. Only users with topic management privileges can see it.
    • ekpack
      ekpack last edited by

      WebApp: 3.5.6.2298+94.1
      Kopano Core: 8.7.1
      Z-Push: 2.5.0+0-0
      Ubuntu 16.04.6 LTS

      Hello 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.

      1 Reply Last reply Reply Quote 0
      • jengelh
        jengelh Banned last edited by

        https://jira.kopano.io/browse/KC-929

        1 Reply Last reply Reply Quote 0
        • First post
          Last post