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

    Lots of error messages in /var/log/kopano/dagent.log

    General Discussion
    2
    4
    684
    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.
    • reiner
      reiner last edited by

      Hello,

      I noticed that I have a lot of error messages in /var/log/kopano/dagent.log:

      Mon Jun 18 16:53:49 2018: [info   ] [ 7875] * Loading plugins done
      Mon Jun 18 16:53:49 2018: [info   ] [ 7876] * Loading plugins started
      Mon Jun 18 16:53:49 2018: [info   ] [ 7876] ** Checking plugins in /var/lib/kopano/dagent/plugins
      Mon Jun 18 16:53:49 2018: [info   ] [ 7876] * Loading plugins done
      Mon Jun 18 16:53:49 2018: [info   ] [ 7875] Mail will be delivered in Inbox
      Mon Jun 18 16:53:49 2018: [info   ] [ 7876] Mail will be delivered in Inbox
      Mon Jun 18 16:53:49 2018: [info   ] [ 7876] * PostConverting processing started
      Mon Jun 18 16:53:49 2018: [info   ] [ 7876] * PostConverting processing done
      Mon Jun 18 16:53:49 2018: [info   ] [ 7876] * PreDelivery processing started
      Mon Jun 18 16:53:49 2018: [info   ] [ 7876] * PreDelivery processing done
      Mon Jun 18 16:53:49 2018: [info   ] [ 7876] * PreRuleProcess processing started
      Mon Jun 18 16:53:49 2018: [info   ] [ 7876] * PreRuleProcess processing done
      Mon Jun 18 16:53:49 2018: [info   ] [ 7875] * PostConverting processing started
      Mon Jun 18 16:53:49 2018: [info   ] [ 7875] * PostConverting processing done
      Mon Jun 18 16:53:49 2018: [info   ] [ 7875] * PreDelivery processing started
      Mon Jun 18 16:53:49 2018: [info   ] [ 7875] * PreDelivery processing done
      Mon Jun 18 16:53:49 2018: [info   ] [ 7875] * PreRuleProcess processing started
      Mon Jun 18 16:53:49 2018: [info   ] [ 7875] * PreRuleProcess processing done
      Mon Jun 18 16:53:49 2018: [error  ] [ 7876] Unable to commit message: 0x80040116
      Mon Jun 18 16:53:49 2018: [error  ] [ 7876] Unable to deliver message to "user1", error code: 0x80040116
      Mon Jun 18 16:53:49 2018: [error  ] [ 7876] Unable to deliver all messages for server "default:"
      Mon Jun 18 16:53:49 2018: [info   ] [ 7876] Finished processing message
      Mon Jun 18 16:53:49 2018: [info   ] [ 7876] LMTP thread exiting
      Mon Jun 18 16:53:49 2018: [error  ] [ 7875] Unable to commit message: 0x80040116
      Mon Jun 18 16:53:49 2018: [error  ] [ 7875] Unable to deliver message to "user1", error code: 0x80040116
      Mon Jun 18 16:53:49 2018: [error  ] [ 7875] Unable to deliver all messages for server "default:"
      Mon Jun 18 16:53:49 2018: [info   ] [ 7875] Finished processing message
      Mon Jun 18 16:53:49 2018: [info   ] [ 7875] LMTP thread exiting
      Mon Jun 18 17:13:49 2018: [info   ] [  529] Accepted connection from [::ffff:127.0.0.1]:32770
      Mon Jun 18 17:13:49 2018: [info   ] [11916] Starting worker for LMTP request pid 11916
      Mon Jun 18 17:13:49 2018: [notice ] [11916] Resolved recipient user1@example.de as user user1
      Mon Jun 18 17:13:49 2018: [info   ] [11916] * Loading plugins started
      Mon Jun 18 17:13:49 2018: [info   ] [11916] ** Checking plugins in /var/lib/kopano/dagent/plugins
      Mon Jun 18 17:13:49 2018: [info   ] [11916] * Loading plugins done
      Mon Jun 18 17:13:49 2018: [info   ] [11916] Mail will be delivered in Inbox
      Mon Jun 18 17:13:49 2018: [info   ] [11916] * PostConverting processing started
      Mon Jun 18 17:13:49 2018: [info   ] [11916] * PostConverting processing done
      Mon Jun 18 17:13:49 2018: [info   ] [11916] * PreDelivery processing started
      Mon Jun 18 17:13:49 2018: [info   ] [11916] * PreDelivery processing done
      Mon Jun 18 17:13:49 2018: [info   ] [11916] * PreRuleProcess processing started
      Mon Jun 18 17:13:49 2018: [info   ] [11916] * PreRuleProcess processing done
      Mon Jun 18 17:13:49 2018: [error  ] [11916] Unable to commit message: 0x80040116
      Mon Jun 18 17:13:49 2018: [error  ] [11916] Unable to deliver message to "user1", error code: 0x80040116
      Mon Jun 18 17:13:49 2018: [error  ] [11916] Unable to deliver all messages for server "default:"
      Mon Jun 18 17:13:49 2018: [info   ] [11916] Finished processing message
      Mon Jun 18 17:13:49 2018: [info   ] [11916] LMTP thread exiting
      Mon Jun 18 17:35:56 2018: [info   ] [  529] Accepted connection from [::ffff:127.0.0.1]:34534
      Mon Jun 18 17:35:56 2018: [info   ] [16664] Starting worker for LMTP request pid 16664
      Mon Jun 18 17:35:56 2018: [notice ] [16664] Resolved recipient user2@example.de as user user2
      Mon Jun 18 17:35:56 2018: [info   ] [16664] * Loading plugins started
      Mon Jun 18 17:35:56 2018: [info   ] [16664] ** Checking plugins in /var/lib/kopano/dagent/plugins
      Mon Jun 18 17:35:56 2018: [info   ] [16664] * Loading plugins done
      Mon Jun 18 17:35:56 2018: [info   ] [16664] Mail will be delivered in Inbox
      Mon Jun 18 17:35:56 2018: [info   ] [16664] * PostConverting processing started
      Mon Jun 18 17:35:56 2018: [info   ] [16664] * PostConverting processing done
      Mon Jun 18 17:35:56 2018: [info   ] [16664] * PreDelivery processing started
      Mon Jun 18 17:35:56 2018: [info   ] [16664] * PreDelivery processing done
      Mon Jun 18 17:35:56 2018: [info   ] [16664] * PreRuleProcess processing started
      Mon Jun 18 17:35:56 2018: [info   ] [16664] * PreRuleProcess processing done
      Mon Jun 18 17:35:56 2018: [info   ] [16664] * PostDelivery processing started
      Mon Jun 18 17:35:56 2018: [info   ] [16664] * PostDelivery processing done
      Mon Jun 18 17:35:56 2018: [info   ] [16664] * SendNewMailNotify processing started
      Mon Jun 18 17:35:56 2018: [info   ] [16664] * SendNewMailNotify processing done
      Mon Jun 18 17:35:56 2018: [info   ] [16664] Delivered message to "user2", Subject: "[Kopano Community Forum] Welcome to Kopano Community Forum", Message-Id: <209c9ba1-3578-7404-fc39-de3ea0537a48@kopano.io>, size 14569
      Mon Jun 18 17:35:56 2018: [info   ] [16664] Finished processing message
      Mon Jun 18 17:35:56 2018: [info   ] [16664] LMTP thread exiting
      

      And in /var/log/kopano/server.log:

      Mon Jun 18 16:21:57 2018: [warning] SQL [00000350] info: Try to reconnect
      Mon Jun 18 16:21:57 2018: [error  ] SQL [00000397] Failed: MySQL server has gone away, Query Size: 287101, Query: "REPLACE INTO properties (hierarchyid,tag,type,properties.val_ulong,properties.val_string,properties.val_binary,properties.val_double,properties.val_longint,properties.val_hi,properties.val_lo) VALUES(1$
      Mon Jun 18 16:21:57 2018: [error  ] KDatabase::I_Update() query failed: REPLACE INTO properties (hierarchyid,tag,type,properties.val_ulong,properties.val_string,properties.val_binary,properties.val_double,properties.val_longint,properties.val_hi,properties.val_lo) VALUES(121859,34056,30,null,'Clear (ClamAV 0.99.4/2$
      Mon Jun 18 16:21:57 2018: [warning] SQL [00000397] info: Try to reconnect
      Mon Jun 18 16:22:10 2018: [warning] SQL [00000369] info: Try to reconnect
      Mon Jun 18 16:22:10 2018: [error  ] SQL [00000403] Failed: MySQL server has gone away, Query Size: 447621, Query: "REPLACE INTO properties (hierarchyid,tag,type,properties.val_ulong,properties.val_string,properties.val_binary,properties.val_double,properties.val_longint,properties.val_hi,properties.val_lo) VALUES(1$
      Mon Jun 18 16:22:10 2018: [error  ] KDatabase::I_Update() query failed: REPLACE INTO properties (hierarchyid,tag,type,properties.val_ulong,properties.val_string,properties.val_binary,properties.val_double,properties.val_longint,properties.val_hi,properties.val_lo) VALUES(121864,34056,30,null,'Clear (ClamAV 0.99.4/2$
      Mon Jun 18 16:22:10 2018: [warning] SQL [00000403] info: Try to reconnect
      Mon Jun 18 16:33:12 2018: [error  ] LDAP search error: Can't contact LDAP server. Will unbind, reconnect and retry.
      Mon Jun 18 16:53:49 2018: [error  ] Previous message logged 16 times
      Mon Jun 18 16:53:49 2018: [warning] SQL [00000344] info: Try to reconnect
      Mon Jun 18 16:53:49 2018: [error  ] SQL [00000428] Failed: MySQL server has gone away, Query Size: 352613, Query: "REPLACE INTO properties (hierarchyid,tag,type,properties.val_ulong,properties.val_string,properties.val_binary,properties.val_double,properties.val_longint,properties.val_hi,properties.val_lo) VALUES(1$
      Mon Jun 18 16:53:49 2018: [error  ] KDatabase::I_Update() query failed: REPLACE INTO properties (hierarchyid,tag,type,properties.val_ulong,properties.val_string,properties.val_binary,properties.val_double,properties.val_longint,properties.val_hi,properties.val_lo) VALUES(121892,34056,30,null,'Clear (ClamAV 0.99.4/2$
      Mon Jun 18 16:53:49 2018: [warning] SQL [00000428] info: Try to reconnect
      Mon Jun 18 16:53:49 2018: [warning] SQL [00000331] info: Try to reconnect
      Mon Jun 18 16:53:49 2018: [error  ] SQL [00000430] Failed: MySQL server has gone away, Query Size: 419587, Query: "REPLACE INTO properties (hierarchyid,tag,type,properties.val_ulong,properties.val_string,properties.val_binary,properties.val_double,properties.val_longint,properties.val_hi,properties.val_lo) VALUES(1$
      Mon Jun 18 16:53:49 2018: [error  ] KDatabase::I_Update() query failed: REPLACE INTO properties (hierarchyid,tag,type,properties.val_ulong,properties.val_string,properties.val_binary,properties.val_double,properties.val_longint,properties.val_hi,properties.val_lo) VALUES(121893,34056,30,null,'Clear (ClamAV 0.99.4/2$
      Mon Jun 18 16:53:49 2018: [warning] SQL [00000430] info: Try to reconnect
      Mon Jun 18 17:00:03 2018: [info   ] Start scheduled softdelete clean up
      Mon Jun 18 17:00:03 2018: [info   ] Softdelete done: removed 0 stores, 0 folders, and 0 messages
      Mon Jun 18 17:03:36 2018: [error  ] LDAP search error: Can't contact LDAP server. Will unbind, reconnect and retry.
      Mon Jun 18 17:13:03 2018: [error  ] Previous message logged 2 times
      Mon Jun 18 17:13:03 2018: [info   ] Start syncs table clean up
      Mon Jun 18 17:13:03 2018: [info   ] syncs table clean up done: removed syncs: 0
      Mon Jun 18 17:13:49 2018: [warning] SQL [00000291] info: Try to reconnect
      Mon Jun 18 17:13:49 2018: [error  ] SQL [00000434] Failed: MySQL server has gone away, Query Size: 367376, Query: "REPLACE INTO properties (hierarchyid,tag,type,properties.val_ulong,properties.val_string,properties.val_binary,properties.val_double,properties.val_longint,properties.val_hi,properties.val_lo) VALUES(1$
      Mon Jun 18 17:13:49 2018: [error  ] KDatabase::I_Update() query failed: REPLACE INTO properties (hierarchyid,tag,type,properties.val_ulong,properties.val_string,properties.val_binary,properties.val_double,properties.val_longint,properties.val_hi,properties.val_lo) VALUES(121894,34056,30,null,'Clear (ClamAV 0.99.4/2$
      Mon Jun 18 17:13:49 2018: [warning] SQL [00000434] info: Try to reconnect
      Mon Jun 18 17:14:03 2018: [info   ] Start syncedmessages table clean up
      Mon Jun 18 17:14:03 2018: [info   ] syncedmessages table clean up done, 0 entries removed
      

      Mails are delivered successfully. Can I ignore the error messages?

      Kopano4UCS
      UCS4.3-0 errata3.

      bye
      reiner

      1 Reply Last reply Reply Quote 0
      • fbartels
        fbartels Kopano last edited by

        hi @reiner ,

        you don’t mention the version of Kopano you’re running, but I guess its the default 8.4.5 from the app? This is a known issue with the first Debian 9 builds of Kopano and has since then been fixed. If you have a subscription you can already update to a more recent version when following the steps explained in https://wiki.z-hub.io/display/K4U/Updating+Kopano+packages+directly+from+the+Kopano+download+server

        The cause of these messages are some messages that are stuck in your mailqueue, since they could not be delivered to Kopano.

        If you don’t have a subscription then there is currently an app update in review at Univention that will also resolve this. I cannot give any eta on the update going public, though.

        Regards Felix

        Resources:
        https://kopano.com/blog/how-to-get-kopano/
        https://documentation.kopano.io/
        https://kb.kopano.io/

        Support overview:
        https://kopano.com/support/

        1 Reply Last reply Reply Quote 0
        • reiner
          reiner last edited by

          Hi @fbartels,

          yes it is the 8.4.5 installed.
          I do not have a subscription, It´s for private use.
          Are emails lost due to this error? I use fetchmail to pull out mail from pop mailboxes.
          Thanks

          Reiner

          fbartels 1 Reply Last reply Reply Quote 0
          • fbartels
            fbartels Kopano @reiner last edited by

            @reiner said in Lots of error messages in /var/log/kopano/dagent.log:

            Are emails lost due to this error?

            no, i don’t think so.

            Regards Felix

            Resources:
            https://kopano.com/blog/how-to-get-kopano/
            https://documentation.kopano.io/
            https://kb.kopano.io/

            Support overview:
            https://kopano.com/support/

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