innodb_fts.fulltext2 failed in buildbot with long semaphore wait

innodb_fts.fulltext2 'xtradb'            w2 [ fail ]

        Test ended at 2017-12-15 10:22:34

CURRENT_TEST: innodb_fts.fulltext2

mysqltest: At line 228: query 'drop table t1' failed: 2013: Lost connection to MySQL server during query

The result from queries just before the failure was:

< snip >

('test'),('test'),('test'),('test'),('test'),('test'),('test'),('test'),

('test'),('test'),('test'),('test'),('test'),('test'),('test'),('test'),

('test'),('test'),('test'),('test'),('test'),('test'),('test'),('test'),

('test'),('test'),('test'),('test'),('test'),('test'),('test'),('test'),

('test'),('test'),('test'),('test'),('test'),('test'),('test'),('test'),

('test'),('test'),('test'),('test'),('test'),('test'),('test'),('test'),

('test'),('test'),('test'),('test'),('test'),('test'),('test'),('test'),

('test'),('test'),('test'),('test'),('test'),('test'),('test'),('test'),

('test'),('test'),('test'),('test'),('test'),('test'),('test'),('test'),

('test'),('test'),('test'),('test'),('test'),('test'),('test'),('test'),

('test'),('test'),('test'),('test'),('test'),('test'),('test'),('test');

delete from t1 limit 1;

truncate table t1;

insert into t1 values('ab c d');

update t1 set a='ab c d';

select * from t1 where match a against('ab c' in boolean mode);

a

select * from t1 where match a against('ab	c' in boolean mode);

a

drop table t1;

More results from queries before failure can be found in /opt/buildbot-slave/mariadb/starfsmenn1/build/mysql-test/var/2/log/fulltext2.log

Server [mysqld.1 - pid: 26597, winpid: 26597, exit: 256] failed during test run

Server log from this test:

----------SERVER LOG START-----------

2017-12-15 10:11:51 7f50d0dfa700 InnoDB: FTS Optimize Removing table test/t1

2017-12-15 10:12:24 7f50d0dfa700 InnoDB: FTS Optimize Removing table test/t1

2017-12-15 10:12:28 7f50d0dfa700 InnoDB: FTS Optimize Removing table test/t1

InnoDB: Error: Waited for 5 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 10 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 15 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 20 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 25 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 30 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 35 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 40 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 45 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 50 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 55 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 60 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 65 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 70 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 75 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 80 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 85 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 90 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 95 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 100 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 105 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 110 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 115 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 120 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 125 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 130 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 135 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 140 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 145 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 150 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 155 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 160 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 165 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 170 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 175 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 180 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 185 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 190 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 195 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 200 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 205 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 210 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 215 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 220 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 225 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 230 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 235 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 240 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Warning: a long semaphore wait:

--Thread 139985099409152 has waited at srv0srv.cc line 2841 for 241.00 seconds the semaphore:

X-lock on RW-latch at 0x7f50ead13a40 '&dict_operation_lock'

a writer (thread id 139985335802624) 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 772

Last time write locked in file row0mysql.cc line 4055

Holder thread 0 file not yet reserved line 0

InnoDB: Warning: semaphore wait:

--Thread 139985099409152 has waited at srv0srv.cc line 2841 for 241.00 seconds the semaphore:

X-lock on RW-latch at 0x7f50ead13a40 '&dict_operation_lock'

a writer (thread id 139985335802624) 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 772

Last time write locked in file row0mysql.cc line 4055

Holder thread 0 file not yet reserved line 0

InnoDB: ###### Starts InnoDB Monitor for 30 secs to print diagnostic info:

InnoDB: Pending reads 0, writes 0

InnoDB: Error: Waited for 245 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 250 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

=====================================

2017-12-15 10:16:46 7f50d3fff700 INNODB MONITOR OUTPUT

=====================================

Per second averages calculated from the last 33 seconds

-----------------

BACKGROUND THREAD

-----------------

srv_master_thread loops: 112 srv_active, 0 srv_shutdown, 17 srv_idle

srv_master_thread log flush and writes: 128

----------

SEMAPHORES

----------

----------

MUTEX INFO

----------

Locked mutex: addr 0x7f50ece119f8 thread 139985335802624 file /opt/buildbot-slave/mariadb/starfsmenn1/build/storage/xtradb/row/row0mysql.cc line 2269

Locked mutex: addr 0x7f50eacfe760 thread 139985130878720 file /opt/buildbot-slave/mariadb/starfsmenn1/build/storage/xtradb/srv/srv0srv.cc line 1441

Total number of mutexes 691

-------------

RW-LATCH INFO

-------------

RW-LOCK: 0x7f50ead13a40  Waiters for the lock exist

Locked: thread 139985335802624 file /opt/buildbot-slave/mariadb/starfsmenn1/build/storage/xtradb/row/row0mysql.cc line 4055  X-LOCK

Total number of rw-locks 1066

OS WAIT ARRAY INFO: reservation count 1410

--Thread 139985099409152 has waited at srv0srv.cc line 2841 for 256.00 seconds the semaphore:

X-lock on RW-latch at 0x7f50ead13a40 '&dict_operation_lock'

a writer (thread id 139985335802624) 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 772

Last time write locked in file row0mysql.cc line 4055

Holder thread 0 file not yet reserved line 0

OS WAIT ARRAY INFO: signal count 1760

Mutex spin waits 25589, rounds 91596, OS waits 811

RW-shared spins 693, rounds 16816, OS waits 364

RW-excl spins 25, rounds 10181, OS waits 179

Spin rounds per wait: 3.58 mutex, 24.27 RW-shared, 407.24 RW-excl

------------

TRANSACTIONS

------------

Trx id counter 14470

Purge done for trx's n:o < 14438 undo n:o < 0 state: running but idle

History list length 44

Total number of lock structs in row lock hash table 9

LIST OF TRANSACTIONS FOR EACH SESSION:

---TRANSACTION 14435, not started

MySQL thread id 10, OS thread handle 0x7f50e036db00, query id 5615 localhost root Unlocking tables

drop table t1

---TRANSACTION 14445, ACTIVE 258 sec

18 lock struct(s), heap size 3112, 112 row lock(s), undo log entries 97

MySQL thread id 10, OS thread handle 0x7f50e036db00, query id 5615 localhost root Unlocking tables

drop table t1

Trx read view will not see trx with id >= 14448, sees < 14448

Trx #rec lock waits 0 #table lock waits 0

Trx total rec lock wait time 0 SEC

Trx total table lock wait time 0 SEC

--------

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, 0] , aio writes: 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

1081 OS file reads, 7103 OS file writes, 4124 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

0.00 hash searches/s, 0.00 non-hash searches/s

---

LOG

---

Log sequence number 9458385

Log flushed up to   9458385

Pages flushed up to 9458385

Last checkpoint at  9430130

Max checkpoint age    7782360

Checkpoint age target 7539162

Modified age          0

Checkpoint age        28255

0 pending log writes, 0 pending chkp writes

1965 log i/o's done, 0.00 log i/o's/second

----------------------

BUFFER POOL AND MEMORY

----------------------

Total memory allocated 9060352; in additional pool allocated 0

Total memory allocated by read views 384

InnoDB: Error: Waited for 255 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 260 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 265 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: ###### Diagnostic info printed to the standard error stream

InnoDB: Error: Waited for 270 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Warning: a long semaphore wait:

--Thread 139985099409152 has waited at srv0srv.cc line 2841 for 272.00 seconds the semaphore:

X-lock on RW-latch at 0x7f50ead13a40 '&dict_operation_lock'

a writer (thread id 139985335802624) 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 772

Last time write locked in file row0mysql.cc line 4055

Holder thread 0 file not yet reserved line 0

InnoDB: Warning: semaphore wait:

--Thread 139985099409152 has waited at srv0srv.cc line 2841 for 272.00 seconds the semaphore:

X-lock on RW-latch at 0x7f50ead13a40 '&dict_operation_lock'

a writer (thread id 139985335802624) 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 772

Last time write locked in file row0mysql.cc line 4055

Holder thread 0 file not yet reserved line 0

InnoDB: Warning: semaphore wait:

--Thread 139985130878720 has waited at dict0dict.cc line 7278 for 16.000 seconds the semaphore:

Mutex at 0x7f50ece119f8 '&dict_sys->mutex', lock var 1

Last time reserved by thread 139985335802624 in file /opt/buildbot-slave/mariadb/starfsmenn1/build/storage/xtradb/row/row0mysql.cc line 2269, waiters flag 1

InnoDB: ###### Starts InnoDB Monitor for 30 secs to print diagnostic info:

InnoDB: Pending reads 0, writes 0

InnoDB: Error: Waited for 275 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 280 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 285 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 290 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 295 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 300 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: ###### Diagnostic info printed to the standard error stream

InnoDB: Warning: a long semaphore wait:

--Thread 139985099409152 has waited at srv0srv.cc line 2841 for 303.00 seconds the semaphore:

X-lock on RW-latch at 0x7f50ead13a40 '&dict_operation_lock'

a writer (thread id 139985335802624) 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 772

Last time write locked in file row0mysql.cc line 4055

Holder thread 0 file not yet reserved line 0

InnoDB: Warning: semaphore wait:

--Thread 139985099409152 has waited at srv0srv.cc line 2841 for 303.00 seconds the semaphore:

X-lock on RW-latch at 0x7f50ead13a40 '&dict_operation_lock'

a writer (thread id 139985335802624) 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 772

Last time write locked in file row0mysql.cc line 4055

Holder thread 0 file not yet reserved line 0

InnoDB: Warning: semaphore wait:

--Thread 139985130878720 has waited at dict0dict.cc line 7278 for 47.000 seconds the semaphore:

Mutex at 0x7f50ece119f8 '&dict_sys->mutex', lock var 1

Last time reserved by thread 139985335802624 in file /opt/buildbot-slave/mariadb/starfsmenn1/build/storage/xtradb/row/row0mysql.cc line 2269, waiters flag 1

InnoDB: ###### Starts InnoDB Monitor for 30 secs to print diagnostic info:

InnoDB: Pending reads 0, writes 0

InnoDB: Error: Waited for 305 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 310 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 315 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 320 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 325 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 330 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: ###### Diagnostic info printed to the standard error stream

InnoDB: Error: Waited for 335 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 340 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 345 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 350 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 355 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 360 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 365 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 370 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 375 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 380 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 385 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 390 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 395 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 400 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 405 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 410 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 415 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 420 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 425 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 430 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 435 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 440 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 445 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 450 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 455 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 460 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 465 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 470 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 475 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 480 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 485 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 490 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 495 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 500 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 505 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 510 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 515 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 520 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 525 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 530 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 535 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 540 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 545 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 550 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 555 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 560 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 565 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 570 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 575 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 580 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 585 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 590 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 595 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

InnoDB: Error: Waited for 600 secs for hash index ref_count (1) to drop to 0.

index: "GEN_CLUST_INDEX" table: "test/t1"

2017-12-15 10:22:34 7f50e036db00  InnoDB: Assertion failure in thread 139985335802624 in file dict0dict.cc line 2756

InnoDB: We intentionally generate a memory trap.

InnoDB: Submit a detailed bug report to https://jira.mariadb.org/

InnoDB: If you get repeated assertion failures or crashes, even

InnoDB: immediately after the mysqld startup, there may be

InnoDB: corruption in the InnoDB tablespace. Please refer to

InnoDB: http://dev.mysql.com/doc/refman/5.6/en/forcing-innodb-recovery.html

InnoDB: about forcing recovery.

"171215 10:22:34 [ERROR] mysqld got signal 6 ;

This could be because you hit a bug. It is also possible that this binary

or one of the libraries it was linked against is corrupt, improperly built,

or misconfigured. This error can also be caused by malfunctioning hardware.

To report this bug, see https://mariadb.com/kb/en/reporting-bugs

We will try our best to scrape up some info that will hopefully help

diagnose the problem, but since we have already crashed, 

something is definitely wrong and this may fail.

Server version: 10.1.30-MariaDB-debug

key_buffer_size=1048576

read_buffer_size=131072

max_used_connections=1

max_threads=153

thread_count=1

It is possible that mysqld could use up to 

key_buffer_size + (read_buffer_size + sort_buffer_size)*max_threads = 63042 K  bytes of memory

Hope that's ok; if not, decrease some variables in the equation.

Thread pointer: 0x7f50ecccfec0

Attempting backtrace. You can use the following information to find out

where mysqld died. If you see no messages after this, something went

terribly wrong...

stack_bottom = 0x7f50e036d230 thread_stack 0x48400

/opt/buildbot-slave/mariadb/starfsmenn1/build/sql/mysqld(my_print_stacktrace+0x38)[0x7f50e9a5e14d]

/opt/buildbot-slave/mariadb/starfsmenn1/build/sql/mysqld(handle_fatal_signal+0x38f)[0x7f50e93fedac]

/lib/x86_64-linux-gnu/libpthread.so.0(+0x10340)[0x7f50e7a23340]

/lib/x86_64-linux-gnu/libc.so.6(gsignal+0x39)[0x7f50e707acc9]

mysys/stacktrace.c:267(my_print_stacktrace)[0x7f50e707e0d8]

dict/dict0dict.cc:2758(dict_index_remove_from_cache_low)[0x7f50e997a97b]

dict/dict0dict.cc:2085(dict_table_remove_from_cache_low(dict_table_t*, unsigned long))[0x7f50e99794b2]

dict/dict0dict.cc:2148(dict_table_remove_from_cache(dict_table_t*))[0x7f50e997995b]

row/row0mysql.cc:4468(row_drop_table_for_mysql(char const*, trx_t*, bool, unsigned long, bool))[0x7f50e985bdc1]

handler/ha_innodb.cc:13175(ha_innobase::delete_table(char const*))[0x7f50e974f10d]

sql/handler.cc:4327(handler::ha_delete_table(char const*))[0x7f50e9409824]

sql/handler.cc:2382(ha_delete_table(THD*, handlerton*, char const*, char const*, char const*, bool))[0x7f50e940497d]

sql/sql_table.cc:2469(mysql_rm_table_no_locks(THD*, TABLE_LIST*, bool, bool, bool, bool, bool))[0x7f50e9273c9b]

sql/sql_table.cc:2084(mysql_rm_table(THD*, TABLE_LIST*, char, char))[0x7f50e9272ed2]

sql/sql_parse.cc:4238(mysql_execute_command(THD*))[0x7f50e91c17e8]

sql/sql_parse.cc:7353(mysql_parse(THD*, char*, unsigned int, Parser_state*))[0x7f50e91caf7f]

sql/sql_parse.cc:1479(dispatch_command(enum_server_command, THD*, char*, unsigned int))[0x7f50e91b9b49]

sql/sql_parse.cc:1106(do_command(THD*))[0x7f50e91b88c9]

sql/sql_connect.cc:1349(do_handle_one_connection(THD*))[0x7f50e92f1ff1]

sql/sql_connect.cc:1262(handle_one_connection)[0x7f50e92f1d55]

perfschema/pfs.cc:1863(pfs_spawn_thread)[0x7f50e95eed58]

/lib/x86_64-linux-gnu/libpthread.so.0(+0x8182)[0x7f50e7a1b182]

/lib/x86_64-linux-gnu/libc.so.6(clone+0x6d)[0x7f50e713e47d]

Trying to get some variables.

Some pointers may be invalid and cause the dump to abort.

Query (0x7f50980173d8): drop table t1

Connection ID (thread ID): 10

Status: NOT_KILLED

Optimizer switch: index_merge=on,index_merge_union=on,index_merge_sort_union=on,index_merge_intersection=on,index_merge_sort_intersection=off,engine_condition_pushdown=off,index_condition_pushdown=on,derived_merge=on,derived_with_keys=on,firstmatch=on,loosescan=on,materialization=on,in_to_exists=on,semijoin=on,partial_match_rowid_merge=on,partial_match_table_scan=on,subquery_cache=on,mrr=off,mrr_cost_based=off,mrr_sort_keys=off,outer_join_with_cache=on,semijoin_with_cache=on,join_cache_incremental=on,join_cache_hashed=on,join_cache_bka=on,optimize_join_buffer_size=off,table_elimination=on,extended_keys=on,exists_to_in=on,orderby_uses_equalities=off

The manual page at http://dev.mysql.com/doc/mysql/en/crashing.html contains

information that should help you find out what is causing the crash.

Writing a core file

----------SERVER LOG END-------------