Purge-softdelete doesnt work

Hello Forum,

after upgrade to Kopano 8.4.2.0-10 the softdelete-Trigger should work again.
The trigger works, but the action doesnt:

Mon Nov 20 03:06:04 2017: [warning] Log connection was reset
Mon Nov 20 03:36:41 2017: [info   ] Start to purge 1783560 messages
Mon Nov 20 03:44:07 2017: [warning] GetChanges:549 The sync ID 132349 does not exist. (unexpected null pointer) session user name: <some-user>.
Mon Nov 20 03:44:10 2017: [warning] GetChanges:549 The sync ID 132360 does not exist. (unexpected null pointer) session user name: <some-user>.
Mon Nov 20 04:01:58 2017: [error  ] SQL [00290454] result failed: Deadlock found when trying to get lock; try restarting transaction, Query: "SELECT properties.val_ulong FROM properties WHERE hierarchyid = 62810 FOR UPDATE"
Mon Nov 20 04:02:00 2017: [info   ] Error while expanding delete item list, error code 2147483655
Mon Nov 20 04:02:00 2017: [error  ] Error while removing softdelete message objects, error code: 0x80000007.
Mon Nov 20 04:02:00 2017: [info   ] Softdelete failed: removed 0 stores, 0 folders, and 0 messages
Mon Nov 20 04:13:01 2017: [info   ] Start syncs table clean up
Mon Nov 20 04:13:01 2017: [info   ] syncs table clean up done: removed syncs: 0
Mon Nov 20 04:14:01 2017: [info   ] Start syncedmessages table clean up
Mon Nov 20 04:14:30 2017: [info   ] syncedmessages table clean up done, 0 entries removed
Mon Nov 20 05:00:00 2017: [info   ] Start scheduled softdelete clean up
Mon Nov 20 05:37:34 2017: [info   ] Start to purge 1783671 messages
Mon Nov 20 05:59:26 2017: [warning] GetChanges:549 The sync ID 132503 does not exist. (unexpected null pointer) session user name: <some-user>.
Mon Nov 20 05:59:27 2017: [warning] GetChanges:549 The sync ID 132777 does not exist. (unexpected null pointer) session user name: <some-user>.
Mon Nov 20 06:02:21 2017: [warning] K-1515: Object not found unknown user "Verteiler Dispo Nahverkehr": Verteiler Dispo Nahverkehr not found in LDAP
Mon Nov 20 06:06:34 2017: [info   ] Resolved multiple users for search "nahverkehr@<domain>".
Mon Nov 20 06:11:13 2017: [error  ] SQL [00291226] Failed: Deadlock found when trying to get lock; try restarting transaction, Query Size: 127, Query: "UPDATE properties SET val_ulong = IF (val_ulong >= 5, val_ulong + -5, 0) WHERE hierarchyid = 67480 AND tag = 26176 AND type = 3"
Mon Nov 20 06:11:13 2017: [error  ] KDatabase::I_Update() query failed: UPDATE properties SET val_ulong = IF (val_ulong >= 5, val_ulong + -5, 0) WHERE hierarchyid = 67480 AND tag = 26176 AND type = 3: Deadlock found when trying to get lock; try restarting transaction
Mon Nov 20 06:11:13 2017: [info   ] Error while deleting expanded item list, error code 2147483655
Mon Nov 20 06:11:14 2017: [error  ] Error while removing softdelete message objects, error code: 0x80000007.
Mon Nov 20 06:11:14 2017: [info   ] Softdelete failed: removed 0 stores, 0 folders, and 0 messages
Mon Nov 20 06:13:04 2017: [info   ] Start syncs table clean up
Mon Nov 20 06:13:04 2017: [info   ] syncs table clean up done: removed syncs: 0
Mon Nov 20 06:14:04 2017: [info   ] Start syncedmessages table clean up
Mon Nov 20 06:14:33 2017: [info   ] syncedmessages table clean up done, 0 entries removed
Mon Nov 20 06:25:40 2017: [error  ] SQL [00275480] result failed: Deadlock found when trying to get lock; try restarting transaction, Query: "SELECT val_ulong FROM properties WHERE hierarchyid = 62810 FOR UPDATE"
Mon Nov 20 07:00:03 2017: [info   ] Start scheduled softdelete clean up
Mon Nov 20 07:07:13 2017: [error  ] SQL [00275480] result failed: Deadlock found when trying to get lock; try restarting transaction, Query: "SELECT val_ulong FROM properties WHERE hierarchyid = 62810 FOR UPDATE"
Mon Nov 20 07:33:55 2017: [info   ] Start to purge 1781248 messages

we did no reindexing, should we?

//EDIT: every saturday this job starts and no communication is possible whiöle the log is growing with following messages:

Sun Nov 19 00:39:56 2017: [error  ] SQL [00277197] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62336) LOCK IN SHARE MODE"
Sun Nov 19 00:39:57 2017: [error  ] SQL [00277198] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62810) LOCK IN SHARE MODE"
Sun Nov 19 00:39:58 2017: [error  ] SQL [00277199] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62810) LOCK IN SHARE MODE"
Sun Nov 19 00:39:59 2017: [error  ] SQL [00277200] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(88734) LOCK IN SHARE MODE"
Sun Nov 19 00:40:00 2017: [error  ] SQL [00277201] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(88734) LOCK IN SHARE MODE"
Sun Nov 19 00:40:04 2017: [error  ] SQL [00277204] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(88734) LOCK IN SHARE MODE"
Sun Nov 19 00:40:06 2017: [error  ] Session failed to shut down: skipping clean
Sun Nov 19 00:40:16 2017: [error  ] SQL [00277208] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(67480) LOCK IN SHARE MODE"
Sun Nov 19 00:40:28 2017: [error  ] SQL [00277213] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(63219) LOCK IN SHARE MODE"
Sun Nov 19 00:40:30 2017: [error  ] SQL [00277186] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62810) LOCK IN SHARE MODE"
Sun Nov 19 00:40:35 2017: [error  ] SQL [00277218] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(88734) LOCK IN SHARE MODE"
Sun Nov 19 00:40:41 2017: [error  ] SQL [00277191] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62706) LOCK IN SHARE MODE"
Sun Nov 19 00:40:45 2017: [error  ] SQL [00277222] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62706) LOCK IN SHARE MODE"
Sun Nov 19 00:40:46 2017: [error  ] SQL [00277196] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(63220) LOCK IN SHARE MODE"
Sun Nov 19 00:40:47 2017: [error  ] SQL [00277197] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62810) LOCK IN SHARE MODE"
Sun Nov 19 00:40:49 2017: [error  ] SQL [00277199] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(63896) LOCK IN SHARE MODE"
Sun Nov 19 00:40:50 2017: [error  ] SQL [00277227] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(63928) LOCK IN SHARE MODE"
Sun Nov 19 00:40:51 2017: [error  ] SQL [00277201] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62336) LOCK IN SHARE MODE"
Sun Nov 19 00:40:53 2017: [error  ] SQL [00277230] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62699) LOCK IN SHARE MODE"
Sun Nov 19 00:40:55 2017: [error  ] SQL [00277204] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(88734) LOCK IN SHARE MODE"
Sun Nov 19 00:40:56 2017: [error  ] SQL [00277236] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(88734) LOCK IN SHARE MODE"
Sun Nov 19 00:40:57 2017: [error  ] SQL [00277238] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62810) LOCK IN SHARE MODE"
Sun Nov 19 00:40:58 2017: [error  ] SQL [00277239] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(88734) LOCK IN SHARE MODE"
Sun Nov 19 00:41:14 2017: [error  ] SQL [00277250] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(63220) LOCK IN SHARE MODE"
Sun Nov 19 00:41:16 2017: [error  ] SQL [00277252] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62810) LOCK IN SHARE MODE"
Sun Nov 19 00:41:17 2017: [error  ] SQL [00277253] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(61900) LOCK IN SHARE MODE"
Sun Nov 19 00:41:21 2017: [error  ] SQL [00277255] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(63219) LOCK IN SHARE MODE"
Sun Nov 19 00:41:23 2017: [error  ] SQL [00277257] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62810) LOCK IN SHARE MODE"
Sun Nov 19 00:41:37 2017: [error  ] SQL [00277259] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62706) LOCK IN SHARE MODE"
Sun Nov 19 00:41:37 2017: [error  ] SQL [00277196] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(88734) LOCK IN SHARE MODE"
Sun Nov 19 00:41:45 2017: [error  ] SQL [00277260] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62706) LOCK IN SHARE MODE"
Sun Nov 19 00:41:47 2017: [error  ] SQL [00277236] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(63896) LOCK IN SHARE MODE"
Sun Nov 19 00:41:48 2017: [error  ] SQL [00277263] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(63220) LOCK IN SHARE MODE"
Sun Nov 19 00:41:52 2017: [error  ] SQL [00277266] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62336) LOCK IN SHARE MODE"
Sun Nov 19 00:41:55 2017: [error  ] SQL [00277269] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62810) LOCK IN SHARE MODE"
Sun Nov 19 00:41:56 2017: [error  ] SQL [00277270] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62699) LOCK IN SHARE MODE"
Sun Nov 19 00:42:00 2017: [error  ] SQL [00277273] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(88734) LOCK IN SHARE MODE"
Sun Nov 19 00:42:01 2017: [error  ] SQL [00277274] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(88734) LOCK IN SHARE MODE"
Sun Nov 19 00:42:03 2017: [error  ] SQL [00277275] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(88734) LOCK IN SHARE MODE"
Sun Nov 19 00:42:06 2017: [error  ] SQL [00277278] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(63220) LOCK IN SHARE MODE"
Sun Nov 19 00:42:10 2017: [error  ] SQL [00277280] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(67480) LOCK IN SHARE MODE"
Sun Nov 19 00:42:14 2017: [error  ] SQL [00277282] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(63219) LOCK IN SHARE MODE"
Sun Nov 19 00:42:34 2017: [error  ] SQL [00277285] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(88734) LOCK IN SHARE MODE"
Sun Nov 19 00:42:38 2017: [error  ] SQL [00277287] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62706) LOCK IN SHARE MODE"
Sun Nov 19 00:42:48 2017: [error  ] SQL [00277291] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62706) LOCK IN SHARE MODE"
Sun Nov 19 00:42:51 2017: [error  ] SQL [00277294] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(63896) LOCK IN SHARE MODE"
Sun Nov 19 00:42:53 2017: [error  ] SQL [00277295] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62810) LOCK IN SHARE MODE"
Sun Nov 19 00:42:54 2017: [error  ] SQL [00277297] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(63220) LOCK IN SHARE MODE"
Sun Nov 19 00:42:54 2017: [error  ] SQL [00277275] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62699) LOCK IN SHARE MODE"
Sun Nov 19 00:42:55 2017: [error  ] SQL [00277298] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(62336) LOCK IN SHARE MODE"
Sun Nov 19 00:42:58 2017: [error  ] SQL [00277301] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(88734) LOCK IN SHARE MODE"
Sun Nov 19 00:42:59 2017: [error  ] SQL [00277302] result failed: Lock wait timeout exceeded; try restarting transaction, Query: "SELECT * FROM properties WHERE hierarchyid IN(88734) LOCK IN SHARE MODE"

coffee_is_life

CentOS 7.4.1708
Mariadb-5.5.56-2
KC 8.5.4.0-9.1
WebApp 3.4.5.1202-47.1 external Server - TCP-Socket
Z-Push 2.3.9+0-90.1
PHP-MAPI 8.5.4.0-9.1
PHP 5.6.25 with Zend OPcache v7.0.6-dev
DeskApp 1.5.0
Outlook 2016(64bit) KOE 1.6.282
Outlook 2010 -Zarafa 7.2.6

I couldn’t reproduce this, can you be more specific what your steps were??

Just did Upgrade 2 weeks ago:

Upgrade process:
stopping postfix
stopping all kopano-services
create vmware-snapshot
yum --nogpgcheck update kopano*
installed the packages and started services - everything works normally except:
https://forum.kopano.io/topic/789/dagent-log-error-cant-send-mails-via-dagent
https://forum.kopano.io/topic/805/circular-mail-will-be-send-dublicated
and this one.

coffee_is_life

CentOS 7.4.1708
Mariadb-5.5.56-2
KC 8.5.4.0-9.1
WebApp 3.4.5.1202-47.1 external Server - TCP-Socket
Z-Push 2.3.9+0-90.1
PHP-MAPI 8.5.4.0-9.1
PHP 5.6.25 with Zend OPcache v7.0.6-dev
DeskApp 1.5.0
Outlook 2016(64bit) KOE 1.6.282
Outlook 2010 -Zarafa 7.2.6

SHOW ENGINE INNODB STATUS shows:

=====================================
171120 14:05:40 INNODB MONITOR OUTPUT
=====================================
Per second averages calculated from the last 50 seconds
-----------------
BACKGROUND THREAD
-----------------
srv_master_thread loops: 1171668 1_second, 1171302 sleeps, 116048 10_second, 36001 background, 35904 flush
srv_master_thread log flush and writes: 1021197
----------
SEMAPHORES
----------
OS WAIT ARRAY INFO: reservation count 13485074, signal count 148027547
Mutex spin waits 2480214495, rounds 2038809283, OS waits 4303339
RW-shared spins 42676660, rounds 327370335, OS waits 6980231
RW-excl spins 5306387, rounds 236672968, OS waits 1848812
Spin rounds per wait: 0.82 mutex, 7.67 RW-shared, 44.60 RW-excl
--------
FILE I/O
--------
I/O thread 0 state: waiting for completed aio requests (insert buffer thread)
I/O thread 1 state: waiting for completed aio requests (log thread)
I/O thread 2 state: waiting for completed aio requests (read thread)
I/O thread 3 state: waiting for completed aio requests (read thread)
I/O thread 4 state: waiting for completed aio requests (read thread)
I/O thread 5 state: waiting for completed aio requests (read thread)
I/O thread 6 state: waiting for completed aio requests (write thread)
I/O thread 7 state: waiting for completed aio requests (write thread)
I/O thread 8 state: waiting for completed aio requests (write thread)
I/O thread 9 state: waiting for completed aio requests (write thread)
Pending normal aio reads: 0 [0, 0, 0, 0] , aio writes: 0 [0, 0, 0, 0] ,
 ibuf aio reads: 0, log i/o's: 0, sync i/o's: 0
Pending flushes (fsync) log: 0; buffer pool: 0
645488801 OS file reads, 40125495 OS file writes, 7934606 OS fsyncs
1 pending preads, 0 pending pwrites
1418.87 reads/s, 16384 avg bytes/read, 21.96 writes/s, 19.76 fsyncs/s
-------------------------------------
INSERT BUFFER AND ADAPTIVE HASH INDEX
-------------------------------------
Ibuf: size 1, free list len 7988, seg size 7990, 1308240 merges
merged operations:
 insert 52027458, delete mark 7173651, delete 1394
discarded operations:
 insert 0, delete mark 0, delete 0
Hash table size 8850419, node heap has 17620 buffer(s)
557164.52 hash searches/s, 23424.57 non-hash searches/s
---
LOG
---
Log sequence number 2866773755410
Log flushed up to   2866773753845
Last checkpoint at  2866718431946
Max checkpoint age    869019772
Checkpoint age target 841862905
Modified age          55323464
Checkpoint age        55323464
0 pending log writes, 0 pending chkp writes
5954623 log i/o's done, 19.26 log i/o's/second
----------------------
BUFFER POOL AND MEMORY
----------------------
Total memory allocated 4408213504; in additional pool allocated 0
Total memory allocated by read views 6336
Internal hash tables (constant factor + variable factor)
    Adaptive hash index 359493648       (70803352 + 288690296)
    Page hash           2213656 (buffer pool 0 only)
    Dictionary cache    17893456        (17702416 + 191040)
    File system         95200   (82672 + 12528)
    Lock system         10633328        (10625704 + 7624)
    Recovery system     0       (0 + 0)
Dictionary memory allocated 191040
Buffer pool size        262142
Buffer pool size, bytes 4294934528
Free buffers            0
Database pages          244522
Old database pages      90223
Modified db pages       4699
Pending reads 2
Pending writes: LRU 0, flush list 0, single page 0
Pages made young 687496206, not young 0
1618.13 youngs/s, 0.00 non-youngs/s
Pages read 645489289, created 14607071, written 33145327
1418.99 reads/s, 5.92 creates/s, 2.46 writes/s
Buffer pool hit rate 1000 / 1000, young-making rate 0 / 1000 not 0 / 1000
Pages read ahead 19.10/s, evicted without access 3.82/s, Random read ahead 0.00/s
LRU len: 244522, unzip_LRU len: 0
I/O sum[141194]:cur[2364], unzip sum[0]:cur[0]
----------------------
INDIVIDUAL BUFFER POOL INFO
----------------------
---BUFFER POOL 0
Buffer pool size        131071
Buffer pool size, bytes 2147467264
Free buffers            0
Database pages          122304
Old database pages      45128
Modified db pages       2629
Pending reads 2
Pending writes: LRU 0, flush list 0, single page 0
Pages made young 344348502, not young 0
807.56 youngs/s, 0.00 non-youngs/s
Pages read 323984429, created 7443761, written 17031465
708.99 reads/s, 5.40 creates/s, 1.22 writes/s
Buffer pool hit rate 1000 / 1000, young-making rate 0 / 1000 not 0 / 1000
Pages read ahead 10.14/s, evicted without access 3.08/s, Random read ahead 0.00/s
LRU len: 122304, unzip_LRU len: 0
I/O sum[70597]:cur[1182], unzip sum[0]:cur[0]
---BUFFER POOL 1
Buffer pool size        131071
Buffer pool size, bytes 2147467264
Free buffers            0
Database pages          122218
Old database pages      45095
Modified db pages       2070
Pending reads 0
Pending writes: LRU 0, flush list 0, single page 0
Pages made young 343147704, not young 0
810.56 youngs/s, 0.00 non-youngs/s
Pages read 321504860, created 7163310, written 16113862
710.01 reads/s, 0.52 creates/s, 1.24 writes/s
Buffer pool hit rate 1000 / 1000, young-making rate 0 / 1000 not 0 / 1000
Pages read ahead 8.96/s, evicted without access 0.74/s, Random read ahead 0.00/s
LRU len: 122218, unzip_LRU len: 0
I/O sum[70597]:cur[1182], unzip sum[0]:cur[0]
--------------
ROW OPERATIONS
--------------
0 queries inside InnoDB, 0 queries in queue
3 read views open inside InnoDB
2 transactions active inside InnoDB
2 out of 1000 descriptors used
---OLDEST VIEW---
Normal read view
Read view low limit trx n:o 10C61D565
Read view up limit trx id 10C61D564
Read view low limit trx id 10C61D565
Read view individually stored trx ids:
Read view trx id 10C61D564
-----------------
Main thread process no. 1726, id 140082520446720, state: sleeping
Number of rows inserted 1259197771, updated 43627000, deleted 288476964, read 203066152224
315.39 inserts/s, 128.98 updates/s, 250.27 deletes/s, 795867.42 reads/s
------------------------
LATEST DETECTED DEADLOCK
------------------------
171120 13:40:02
*** (1) TRANSACTION:
TRANSACTION 10C5E491B, ACTIVE 0 sec fetching rows
mysql tables in use 1, locked 1
LOCK WAIT 3 lock struct(s), heap size 1248, 25 row lock(s)
MySQL thread id 309488, OS thread handle 0x7f66fff24700, query id 2319898111 localhost kopano Sending data
SELECT * FROM properties WHERE hierarchyid IN(62810) LOCK IN SHARE MODE
*** (1) WAITING FOR THIS LOCK TO BE GRANTED:
RECORD LOCKS space id 385 page no 130 n bits 456 index `PRIMARY` of table `zarafa`.`properties` trx id 10C5E491B lock mode S waiting
*** (2) TRANSACTION:
TRANSACTION 10C5E48A7, ACTIVE 1 sec inserting
mysql tables in use 1, locked 1
7 lock struct(s), heap size 1248, 19 row lock(s), undo log entries 1
MySQL thread id 301354, OS thread handle 0x7f66ff895700, query id 2319907427 localhost kopano update
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(62810,12296,64,null,null,null,null,null,30630396,2936470784)
*** (2) HOLDS THE LOCK(S):
RECORD LOCKS space id 385 page no 130 n bits 456 index `PRIMARY` of table `zarafa`.`properties` trx id 10C5E48A7 lock_mode X locks rec but not gap
*** (2) WAITING FOR THIS LOCK TO BE GRANTED:
RECORD LOCKS space id 385 page no 130 n bits 456 index `PRIMARY` of table `zarafa`.`properties` trx id 10C5E48A7 lock_mode X locks rec but not gap waiting
*** WE ROLL BACK TRANSACTION (1)
------------
TRANSACTIONS
------------
Trx id counter 10C64C9AA
Purge done for trx's n:o < 10C61D567 undo n:o < 0
History list length 6180
LIST OF TRANSACTIONS FOR EACH SESSION:
---TRANSACTION 0, not started
MySQL thread id 311557, OS thread handle 0x7f6775fb7700, query id 2322211920 localhost root
SHOW ENGINE INNODB STATUS
---TRANSACTION 10C64C995, not started
MySQL thread id 309488, OS thread handle 0x7f66fff24700, query id 2322211914 localhost kopano
---TRANSACTION 10C64C994, not started
MySQL thread id 301354, OS thread handle 0x7f66ff895700, query id 2322211852 localhost kopano
---TRANSACTION 10C64C9A6, not started
MySQL thread id 301345, OS thread handle 0x7f66ff4e0700, query id 2322211919 localhost kopano
---TRANSACTION 10C64C9A8, not started
MySQL thread id 278288, OS thread handle 0x7f66fdaed700, query id 2322211939 localhost kopano
---TRANSACTION 10C64C99B, not started
MySQL thread id 278075, OS thread handle 0x7f67747c3700, query id 2322211895 localhost kopano
---TRANSACTION 10C64C9A7, not started
MySQL thread id 276123, OS thread handle 0x7f6775a95700, query id 2322211925 localhost kopano
---TRANSACTION 10C64C99A, not started
MySQL thread id 275480, OS thread handle 0x7f66fe49f700, query id 2322211887 localhost kopano
---TRANSACTION 10C64C98C, not started
MySQL thread id 6, OS thread handle 0x7f677f802700, query id 2322211826 localhost kopano
---TRANSACTION 10C6475CA, not started
MySQL thread id 19, OS thread handle 0x7f677f528700, query id 2322107661 localhost kopano
---TRANSACTION 10C64C97D, not started
MySQL thread id 18, OS thread handle 0x7f677f571700, query id 2322211780 localhost kopano
---TRANSACTION 10C64C9A9, ACTIVE 0 sec inserting
mysql tables in use 1, locked 1
10 lock struct(s), heap size 3112, 34 row lock(s), undo log entries 11
MySQL thread id 301350, OS thread handle 0x7f6775a4c700, query id 2322211963 localhost kopano update
REPLACE INTO changes(change_type, sourcekey, parentsourcekey, sourcesync, flags) VALUES (4098, '▒*▒A\n▒v[▒%▒o▒b▒\0\0\0', '▒*▒A\n▒v[▒%▒o▒*o\0\0\0\0', 0, 0)
Trx read view will not see trx with id >= 10C64C9AA, sees < 10C61D564
---TRANSACTION 10C61D564, ACTIVE 335 sec starting index read
mysql tables in use 2, locked 0
, holds adaptive hash latch
MySQL thread id 311260, OS thread handle 0x7f66fe80b700, query id 2321115794 localhost kopano Sending data
SELECT h.id FROM hierarchy AS h JOIN properties AS p ON p.hierarchyid=h.id AND p.tag=26255 AND p.type=64 WHERE (h.flags&1024)=1024 AND h.type=5 AND p.val_hi<=30624364
Trx read view will not see trx with id >= 10C61D565, sees < 10C61D565
----------------------------
END OF INNODB MONITOR OUTPUT
============================

anything of help?

coffee_is_life

CentOS 7.4.1708
Mariadb-5.5.56-2
KC 8.5.4.0-9.1
WebApp 3.4.5.1202-47.1 external Server - TCP-Socket
Z-Push 2.3.9+0-90.1
PHP-MAPI 8.5.4.0-9.1
PHP 5.6.25 with Zend OPcache v7.0.6-dev
DeskApp 1.5.0
Outlook 2016(64bit) KOE 1.6.282
Outlook 2010 -Zarafa 7.2.6

Hi @coffee_is_life ,

seeing that you are using a supported version of Kopano i’d recommend to open up a support case instead.

Log in to reply

Looks like your connection to Kopano Community Forum was lost, please wait while we try to reconnect.