Lots of error messages in /var/log/kopano/dagent.log
-
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 -
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.
-
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.
ThanksReiner
-
@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.