Uploaded image for project: 'MariaDB Server'
  1. MariaDB Server
  2. MDEV-14441

InnoDB hangs when setting innodb_adaptive_hash_index=OFF during UPDATE

    XMLWordPrintable

Details

    Description

      Run with --mem --repeat=N. On my machine, N=10 is pretty much always enough. On perro, it took a few more.

      --source include/have_innodb.inc
       
      --connect (con1,localhost,root,,test)
      CREATE TABLE t1 (f INT, KEY(f)) ENGINE=InnoDB;
      INSERT INTO t1 VALUES (),(),(),(),(),(),(),();
      UPDATE t1 SET f = 8;
      UPDATE t1 SET f = 4;
      UPDATE t1 SET f = 6;
      UPDATE t1 SET f = 8;
      UPDATE t1 SET f = 2;
      UPDATE t1 SET f = 9;
      UPDATE t1 SET f = 3;
      UPDATE t1 SET f = 4;
      UPDATE t1 SET f = 6;
      CREATE TABLE t2 (n DECIMAL) ENGINE=InnoDB;
      UPDATE t1 SET f = 0;
      UPDATE t1 SET f = 1;
      UPDATE t1 SET f = 5;
      ALTER TABLE t2 ADD COLUMN i INT;
      UPDATE t1 SET f = 2;
      --send
      	ALTER TABLE t2 ADD COLUMN v INT AS (i) VIRTUAL;
       
      --connection default
      UPDATE t1 SET f = 6;
       
      --connection con1
      --reap
       
      # Cleanup
      --disconnect con1
      --connection default
      DROP TABLE t2, t1;
      

      The explicit "DEADLOCK of threads detected" failure I was mostly getting in initial concurrent tests; it's still achievable with the test case above, although rarely. More often I get a hang which ends up in the long semaphore wait abort.

      DEADLOCK of threads detected variation

      All threads' stack trace is attached as threads

      10.3 c029eae02d5d94a

      Version: '10.3.3-MariaDB-debug-log'  socket: '/data/bld/10.3/mysql-test/var/tmp/mysqld.1.sock'  port: 16000  Source distribution
      CURRENT_TEST: bug.t9i
      ########################################
      DEADLOCK of threads detected!
      rw-lock 0x55bd3e204f00 --Thread 139629613262592 has waited at btr0sea.ic line 96 for 0.00 seconds the semaphore:
      X-lock on RW-latch at 0x55bd3e204f00 created in file btr0sea.cc line 260
      a writer (thread id 139629925762816) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file btr0sea.ic line 134
      Last time write locked in file btr0sea.ic line 96
      Locked: thread 139629925762816 file btr0sea.ic line 96  X-LOCK
      Locked: thread 139629925762816 file btr0sea.ic line 96  X-LOCK
      rw-lock 0x7efe21cddcc8 --Thread 139629630048000 has waited at row0row.cc line 1030 for 0.00 seconds the semaphore:
      X-lock on RW-latch at 0x7efe21cddcc8 created in file buf0buf.cc line 1461
      a writer (thread id 139629613262592) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0row.cc line 1030
      Last time write locked in file row0row.cc line 1030
      Locked: thread 139629613262592 file row0row.cc line 1030  X-LOCK
      Locked: thread 139629613262592 file row0row.cc line 1030  X-LOCK
      rw-lock 0x55bd3e6cb6d0 --Thread 139629925762816 has waited at row0mysql.cc line 3597 for 0.00 seconds the semaphore:
      X-lock (wait_ex) on RW-latch at 0x55bd3e6cb6d0 created in file dict0dict.cc line 1109
      a writer (thread id 139629925762816) has reserved it in mode  wait exclusive
      number of readers 3, waiters flag 0, lock_word: fffffffffffffffd
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      Locked: thread 139629630048000 file row0purge.cc line 928  S-LOCK
      Locked: thread 139629630048000 file row0purge.cc line 928  S-LOCK
      2017-11-19 23:56:02 14 [ERROR] [FATAL] InnoDB: ######################################## Deadlock Detected!
      171119 23:56:02 [ERROR] mysqld got signal 6 ;
      

      #5  0x00007efe2860a3fa in abort () from /lib/x86_64-linux-gnu/libc.so.6
      #6  0x000055bd3b9857d3 in ib::fatal::~fatal (this=0x7efe201fb6a0, __in_chrg=<optimized out>) at /data/src/10.3/storage/innobase/ut/ut0ut.cc:850
      #7  0x000055bd3b926941 in sync_array_wait_event (arr=0x55bd3e013a30, cell=@0x7efe201fb858: 0x55bd3e013b80) at /data/src/10.3/storage/innobase/sync/sync0arr.cc:468
      #8  0x000055bd3b929a6c in rw_lock_x_lock_wait_func (lock=0x55bd3e6cb6d0, pass=0, threshold=0, file_name=0x55bd3bee7980 "/data/src/10.3/storage/innobase/row/row0mysql.cc", line=3597) at /data/src/10.3/storage/innobase/sync/sync0rw.cc:479
      #9  0x000055bd3b929bd3 in rw_lock_x_lock_low (lock=0x55bd3e6cb6d0, pass=0, file_name=0x55bd3bee7980 "/data/src/10.3/storage/innobase/row/row0mysql.cc", line=3597) at /data/src/10.3/storage/innobase/sync/sync0rw.cc:543
      #10 0x000055bd3b92a035 in rw_lock_x_lock_func (lock=0x55bd3e6cb6d0, pass=0, file_name=0x55bd3bee7980 "/data/src/10.3/storage/innobase/row/row0mysql.cc", line=3597) at /data/src/10.3/storage/innobase/sync/sync0rw.cc:694
      #11 0x000055bd3b89acd9 in pfs_rw_lock_x_lock_func (lock=0x55bd3e6cb6d0, pass=0, file_name=0x55bd3bee7980 "/data/src/10.3/storage/innobase/row/row0mysql.cc", line=3597) at /data/src/10.3/storage/innobase/include/sync0rw.ic:549
      #12 0x000055bd3b8a35d8 in row_mysql_lock_data_dictionary_func (trx=0x7efe22505878, file=0x55bd3bee7980 "/data/src/10.3/storage/innobase/row/row0mysql.cc", line=3597) at /data/src/10.3/storage/innobase/row/row0mysql.cc:2361
      #13 0x000055bd3b8a6393 in row_drop_table_for_mysql (name=0x7efe201fc690 "test/t2", trx=0x7efe22505878, drop_db=false, create_failed=0, nonatomic=true) at /data/src/10.3/storage/innobase/row/row0mysql.cc:3597
      #14 0x000055bd3b750edb in ha_innobase::delete_table (this=0x7efdd0015c20, name=0x7efe201fe210 "./test/t2") at /data/src/10.3/storage/innobase/handler/ha_innodb.cc:13379
      #15 0x000055bd3b42239c in handler::ha_delete_table (this=0x7efdd0015c20, name=0x7efe201fe210 "./test/t2") at /data/src/10.3/sql/handler.cc:4358
      #16 0x000055bd3b41c725 in ha_delete_table (thd=0x7efdd0000b00, table_type=0x55bd3df308d0, path=0x7efe201fe210 "./test/t2", db=0x7efdd0015178 "test", alias=0x7efdd0014b30 "t2", generate_warning=true) at /data/src/10.3/sql/handler.cc:2359
      #17 0x000055bd3b216ea8 in mysql_rm_table_no_locks (thd=0x7efdd0000b00, tables=0x7efdd0014b68, if_exists=false, drop_temporary=false, drop_view=false, drop_sequence=false, dont_log_query=false, dont_free_locks=false) at /data/src/10.3/sql/sql_table.cc:2507
      #18 0x000055bd3b215ec4 in mysql_rm_table (thd=0x7efdd0000b00, tables=0x7efdd0014b68, if_exists=false, drop_temporary=false, drop_sequence=false) at /data/src/10.3/sql/sql_table.cc:2119
      #19 0x000055bd3b155bf8 in mysql_execute_command (thd=0x7efdd0000b00) at /data/src/10.3/sql/sql_parse.cc:5020
      #20 0x000055bd3b15ecee in mysql_parse (thd=0x7efdd0000b00, rawbuf=0x7efdd0014a98 "DROP TABLE t2, t1", length=17, parser_state=0x7efe201ff610, is_com_multi=false, is_next_command=false) at /data/src/10.3/sql/sql_parse.cc:7933
      #21 0x000055bd3b14c6ce in dispatch_command (command=COM_QUERY, thd=0x7efdd0000b00, packet=0x7efdd0093e71 "DROP TABLE t2, t1", packet_length=17, is_com_multi=false, is_next_command=false) at /data/src/10.3/sql/sql_parse.cc:1828
      #22 0x000055bd3b14b0ef in do_command (thd=0x7efdd0000b00) at /data/src/10.3/sql/sql_parse.cc:1370
      #23 0x000055bd3b2a2ed6 in do_handle_one_connection (connect=0x55bd3e53b340) at /data/src/10.3/sql/sql_connect.cc:1420
      #24 0x000055bd3b2a2c63 in handle_one_connection (arg=0x55bd3e53b340) at /data/src/10.3/sql/sql_connect.cc:1326
      #25 0x000055bd3b724392 in pfs_spawn_thread (arg=0x55bd3e543a00) at /data/src/10.3/storage/perfschema/pfs.cc:1863
      #26 0x00007efe2a2d8494 in start_thread (arg=0x7efe20200700) at pthread_create.c:333
      #27 0x00007efe286be93f in clone () from /lib/x86_64-linux-gnu/libc.so.6
      

      Long semaphore variation

      All threads from the running server are attached as threads1.

      10.3 c029eae02d5d9

      2017-11-20  0:04:21 0 [Warning] InnoDB: A long semaphore wait:
      --Thread 140696535160576 has waited at row0purge.cc line 928 for 241.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:04:21 0 [Warning] InnoDB: A long semaphore wait:
      --Thread 140697023878912 has waited at btr0sea.ic line 114 for 241.00 seconds the semaphore:
      X-lock on RW-latch at 0x55cf57038d30 created in file btr0sea.cc line 260
      a writer (thread id 140697024182016) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file btr0sea.ic line 134
      Last time write locked in file btr0sea.ic line 96
      2017-11-20  0:04:21 0 [Warning] InnoDB: A long semaphore wait:
      --Thread 140696543553280 has waited at row0purge.cc line 928 for 241.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:04:21 0 [Warning] InnoDB: A long semaphore wait:
      --Thread 140696526767872 has waited at row0purge.cc line 928 for 241.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:04:21 0 [Note] InnoDB: A semaphore wait:
      --Thread 140696535160576 has waited at row0purge.cc line 928 for 241.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:04:21 0 [Note] InnoDB: A semaphore wait:
      --Thread 140697023878912 has waited at btr0sea.ic line 114 for 241.00 seconds the semaphore:
      X-lock on RW-latch at 0x55cf57038d30 created in file btr0sea.cc line 260
      a writer (thread id 140697024182016) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file btr0sea.ic line 134
      Last time write locked in file btr0sea.ic line 96
      2017-11-20  0:04:21 0 [Note] InnoDB: A semaphore wait:
      --Thread 140696543553280 has waited at row0purge.cc line 928 for 241.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:04:21 0 [Note] InnoDB: A semaphore wait:
      --Thread 140696526767872 has waited at row0purge.cc line 928 for 241.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:04:21 0 [Note] InnoDB: A semaphore wait:
      --Thread 140696770025216 has waited at srv0srv.cc line 2120 for 240.00 seconds the semaphore:
      X-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      InnoDB: ###### Starts InnoDB Monitor for 30 secs to print diagnostic info:
      InnoDB: Pending reads 0, writes 0
       
      =====================================
      2017-11-20 00:04:39 0x7ff6867fc700 INNODB MONITOR OUTPUT
      =====================================
      Per second averages calculated from the last 77 seconds
      -----------------
      BACKGROUND THREAD
      -----------------
      srv_master_thread loops: 1 srv_active, 0 srv_shutdown, 1 srv_idle
      srv_master_thread log flush and writes: 1
      ----------
      SEMAPHORES
      ----------
      -------------
      RW-LATCH INFO
      -------------
      RW-LOCK: 0x55cf574ff6d0  Waiters for the lock exist
      Locked: thread 140697023878912 file handler0alter.cc line 9152  X-LOCK
      RW-LOCK: 0x55cf57038d30  Waiters for the lock exist
      Locked: thread 140697024182016 file btr0sea.ic line 96  X-LOCK
      RW-LOCK: 0x55cf57038b60 
      Locked: thread 140697023878912 file btr0sea.ic line 114  X-LOCK
      RW-LOCK: 0x55cf57038990 
      Locked: thread 140697023878912 file btr0sea.ic line 114  X-LOCK
      RW-LOCK: 0x55cf570387c0 
      Locked: thread 140697023878912 file btr0sea.ic line 114  X-LOCK
      RW-LOCK: 0x55cf570385f0 
      Locked: thread 140697023878912 file btr0sea.ic line 114  X-LOCK
      Total number of rw-locks 1079
      OS WAIT ARRAY INFO: reservation count 146
      --Thread 140696535160576 has waited at row0purge.cc line 928 for 259.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      --Thread 140697023878912 has waited at btr0sea.ic line 114 for 259.00 seconds the semaphore:
      X-lock on RW-latch at 0x55cf57038d30 created in file btr0sea.cc line 260
      a writer (thread id 140697024182016) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file btr0sea.ic line 134
      Last time write locked in file btr0sea.ic line 96
      --Thread 140696543553280 has waited at row0purge.cc line 928 for 259.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      --Thread 140696526767872 has waited at row0purge.cc line 928 for 259.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      --Thread 140696770025216 has waited at srv0srv.cc line 2120 for 258.00 seconds the semaphore:
      X-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      OS WAIT ARRAY INFO: signal count 239
      RW-shared spins 0, rounds 347, OS waits 39
      RW-excl spins 0, rounds 3217, OS waits 40
      RW-sx spins 0, rounds 0, OS waits 0
      Spin rounds per wait: 347.00 RW-shared, 3217.00 RW-excl, 0.00 RW-sx
      ------------
      TRANSACTIONS
      ------------
      Trx id counter 1425
      Purge done for trx's n:o < 1424 undo n:o < 0 state: running
      History list length 19
      Total number of lock structs in row lock hash table 0
      LIST OF TRANSACTIONS FOR EACH SESSION:
      ---TRANSACTION 422172003623128, not started
      0 lock struct(s), heap size 1160, 0 row lock(s)
      ---TRANSACTION 422172003622056, not started
      0 lock struct(s), heap size 1160, 0 row lock(s)
      ---TRANSACTION 422172003620984, not started
      mysql tables in use 1, locked 1
      0 lock struct(s), heap size 1160, 0 row lock(s)
      --------
      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 (write thread)
      I/O thread 5 state: waiting for completed aio requests (write thread)
      Pending normal aio reads: [0, 0] , aio writes: [0, 0] ,
       ibuf aio reads:, log i/o's:, sync i/o's:
      Pending flushes (fsync) log: 0; buffer pool: 0
      186 OS file reads, 356 OS file writes, 80 OS fsyncs
      0.00 reads/s, 0 avg bytes/read, 0.00 writes/s, 0.00 fsyncs/s
      -------------------------------------
      INSERT BUFFER AND ADAPTIVE HASH INDEX
      -------------------------------------
      Ibuf: size 1, free list len 0, seg size 2, 0 merges
      merged operations:
       insert 0, delete mark 0, delete 0
      discarded operations:
       insert 0, delete mark 0, delete 0
      InnoDB: ###### Diagnostic info printed to the standard error stream
      2017-11-20  0:04:52 0 [Warning] InnoDB: A long semaphore wait:
      --Thread 140696535160576 has waited at row0purge.cc line 928 for 272.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:04:52 0 [Warning] InnoDB: A long semaphore wait:
      --Thread 140697023878912 has waited at btr0sea.ic line 114 for 272.00 seconds the semaphore:
      X-lock on RW-latch at 0x55cf57038d30 created in file btr0sea.cc line 260
      a writer (thread id 140697024182016) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file btr0sea.ic line 134
      Last time write locked in file btr0sea.ic line 96
      2017-11-20  0:04:52 0 [Warning] InnoDB: A long semaphore wait:
      --Thread 140696543553280 has waited at row0purge.cc line 928 for 272.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:04:52 0 [Warning] InnoDB: A long semaphore wait:
      --Thread 140696526767872 has waited at row0purge.cc line 928 for 272.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:04:52 0 [Warning] InnoDB: A long semaphore wait:
      --Thread 140696770025216 has waited at srv0srv.cc line 2120 for 271.00 seconds the semaphore:
      X-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:04:52 0 [Note] InnoDB: A semaphore wait:
      --Thread 140696535160576 has waited at row0purge.cc line 928 for 272.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:04:52 0 [Note] InnoDB: A semaphore wait:
      --Thread 140697023878912 has waited at btr0sea.ic line 114 for 272.00 seconds the semaphore:
      X-lock on RW-latch at 0x55cf57038d30 created in file btr0sea.cc line 260
      a writer (thread id 140697024182016) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file btr0sea.ic line 134
      Last time write locked in file btr0sea.ic line 96
      2017-11-20  0:04:52 0 [Note] InnoDB: A semaphore wait:
      --Thread 140696543553280 has waited at row0purge.cc line 928 for 272.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:04:52 0 [Note] InnoDB: A semaphore wait:
      --Thread 140696526767872 has waited at row0purge.cc line 928 for 272.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:04:52 0 [Note] InnoDB: A semaphore wait:
      --Thread 140696770025216 has waited at srv0srv.cc line 2120 for 271.00 seconds the semaphore:
      X-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:04:52 0 [Note] InnoDB: A semaphore wait:
      --Thread 140696795203328 has waited at srv0srv.cc line 1306 for 13.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf570385f0 created in file btr0sea.cc line 260
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file not yet reserved line 0
      Last time write locked in file btr0sea.ic line 114
      InnoDB: ###### Starts InnoDB Monitor for 30 secs to print diagnostic info:
      InnoDB: Pending reads 0, writes 0
      InnoDB: ###### Diagnostic info printed to the standard error stream
      2017-11-20  0:05:23 0 [Warning] InnoDB: A long semaphore wait:
      --Thread 140696535160576 has waited at row0purge.cc line 928 for 303.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:05:23 0 [Warning] InnoDB: A long semaphore wait:
      --Thread 140697023878912 has waited at btr0sea.ic line 114 for 303.00 seconds the semaphore:
      X-lock on RW-latch at 0x55cf57038d30 created in file btr0sea.cc line 260
      a writer (thread id 140697024182016) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file btr0sea.ic line 134
      Last time write locked in file btr0sea.ic line 96
      2017-11-20  0:05:23 0 [Warning] InnoDB: A long semaphore wait:
      --Thread 140696543553280 has waited at row0purge.cc line 928 for 303.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:05:23 0 [Warning] InnoDB: A long semaphore wait:
      --Thread 140696526767872 has waited at row0purge.cc line 928 for 303.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:05:23 0 [Warning] InnoDB: A long semaphore wait:
      --Thread 140696770025216 has waited at srv0srv.cc line 2120 for 302.00 seconds the semaphore:
      X-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:05:23 0 [Note] InnoDB: A semaphore wait:
      --Thread 140696535160576 has waited at row0purge.cc line 928 for 303.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:05:23 0 [Note] InnoDB: A semaphore wait:
      --Thread 140697023878912 has waited at btr0sea.ic line 114 for 303.00 seconds the semaphore:
      X-lock on RW-latch at 0x55cf57038d30 created in file btr0sea.cc line 260
      a writer (thread id 140697024182016) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file btr0sea.ic line 134
      Last time write locked in file btr0sea.ic line 96
      2017-11-20  0:05:23 0 [Note] InnoDB: A semaphore wait:
      --Thread 140696543553280 has waited at row0purge.cc line 928 for 303.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:05:23 0 [Note] InnoDB: A semaphore wait:
      --Thread 140696526767872 has waited at row0purge.cc line 928 for 303.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:05:23 0 [Note] InnoDB: A semaphore wait:
      --Thread 140696770025216 has waited at srv0srv.cc line 2120 for 302.00 seconds the semaphore:
      X-lock on RW-latch at 0x55cf574ff6d0 created in file dict0dict.cc line 1109
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file row0purge.cc line 928
      Last time write locked in file handler0alter.cc line 9152
      2017-11-20  0:05:23 0 [Note] InnoDB: A semaphore wait:
      --Thread 140696795203328 has waited at srv0srv.cc line 1306 for 44.00 seconds the semaphore:
      S-lock on RW-latch at 0x55cf570385f0 created in file btr0sea.cc line 260
      a writer (thread id 140697023878912) has reserved it in mode  exclusive
      number of readers 0, waiters flag 1, lock_word: 0
      Last time read locked in file not yet reserved line 0
      Last time write locked in file btr0sea.ic line 114
      InnoDB: ###### Starts InnoDB Monitor for 30 secs to print diagnostic info:
      InnoDB: Pending reads 0, writes 0
      

      Neither seems to be reproducible on 10.2.

      Attachments

        1. threads
          43 kB
          Elena Stepanova
        2. threads1
          36 kB
          Elena Stepanova

        Issue Links

          Activity

            People

              marko Marko Mäkelä
              elenst Elena Stepanova
              Votes:
              0 Vote for this issue
              Watchers:
              2 Start watching this issue

              Dates

                Created:
                Updated:
                Resolved:

                Git Integration

                  Error rendering 'com.xiplink.jira.git.jira_git_plugin:git-issue-webpanel'. Please contact your Jira administrators.