[MDEV-10290] funcs_2.memory_charset failed with timeout in buildbot - Jira

Details

Type: Bug
Status: Closed (View Workflow)
Priority: Minor
Resolution: Won't Fix
Affects Version/s: 10.1
Fix Version/s: N/A
Component/s: Character Sets, Tests
Labels:
None

Description

http://buildbot.askmonty.org/buildbot/builders/kvm-bintar-centos5-amd64/builds/3139/steps/test/logs/stdio

funcs_2.memory_charset                   w4 [ fail ]  timeout after 900 seconds

        Test ended at 2016-06-24 17:30:32

Test case timeout after 900 seconds

== /usr/local/mariadb-10.1.15-linux-x86_64/mysql-test/var/4/log/memory_charset.log ==

F1	1

F2	1

F3	1

F4	1

F5	1

F6	1

F7	1

F8	1

F9	1

FA	1

FB	1

FC	1

FD	1

DROP TABLE IF EXISTS test.t1;

DROP TABLE IF EXISTS test.t1;

SET NAMES greek;

CREATE TABLE test.t1 (a VARCHAR(3) CHARACTER SET greek COLLATE greek_bin) ENGINE=Memory CHARACTER SET greek COLLATE greek_bin;

SHOW TABLE STATUS LIKE 't1';

Name	Engine	Version	Row_format	Rows	Avg_row_length	Data_length	Max_data_length	Index_length	Data_free	Auto_increment	Create_time	Update_time	Check_time	Collation	Checksum	Create_options	Comment

t1	MEMORY	#	#	#	#	#	#	#	#	#	#	#	#	greek_bin	#	#	#

 == /usr/local/mariadb-10.1.15-linux-x86_64/mysql-test/var/4/tmp/analyze-timeout-mysqld.1.err ==

mysqltest: Could not open connection 'default' after 500 attempts: 2002 Can't connect to local MySQL server through socket '/usr/local/mariadb-10.1.15-linux-x86_64/mysql-test/var/tmp/4/mysqld.1.sock' (111 "Connection refused")

 - saving '/usr/local/mariadb-10.1.15-linux-x86_64/mysql-test/var/4/log/funcs_2.memory_charset/' to '/usr/local/mariadb-10.1.15-linux-x86_64/mysql-test/var/log/funcs_2.memory_charset/'

Retrying test funcs_2.memory_charset, attempt(2/3)...

worker[4] > Restart  - not started

***Warnings generated in error logs during shutdown after running tests: funcs_2.memory_charset

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

funcs_2.memory_charset                   w4 [ retry-pass ]   3558

Nothing interesting in the error log (the signal is from the timeout handling):

CURRENT_TEST: funcs_2.memory_charset

2016-06-24 17:14:40 46941992236864 [Note] /usr/local/mariadb-10.1.15-linux-x86_64/bin/mysqld (mysqld 10.1.15-MariaDB) starting as process 10203 ...

2016-06-24 17:14:40 46941992236864 [Warning] Could not increase number of max_open_files to more than 1024 (request: 4162)

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'partition' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'InnoDB' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'SEQUENCE' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_SYS_INDEXES' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'XTRADB_RSEG' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_CMP_PER_INDEX' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_TRX' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'CHANGED_PAGE_BITMAPS' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_LOCKS' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'XTRADB_INTERNAL_HASH_TABLES' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_SYS_FIELDS' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'FEEDBACK' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_CMP' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_MUTEXES' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_BUFFER_PAGE_LRU' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_SYS_FOREIGN_COLS' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_CMP_RESET' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_BUFFER_POOL_STATS' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_SYS_FOREIGN' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_METRICS' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_CMPMEM' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_SYS_TABLES' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_SYS_COLUMNS' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_BUFFER_PAGE' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'XTRADB_READ_VIEW' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_CHANGED_PAGES' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_FT_DELETED' is disabled.

2016-06-24 17:14:40 46941992236864 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.

2016-06-24 17:14:40 46941992236864 [Warning] /usr/local/mariadb-10.1.15-linux-x86_64/bin/mysqld: unknown variable 'loose-feedback-debug-startup-interval=20'

2016-06-24 17:14:40 46941992236864 [Warning] /usr/local/mariadb-10.1.15-linux-x86_64/bin/mysqld: unknown variable 'loose-feedback-debug-first-interval=60'

2016-06-24 17:14:40 46941992236864 [Warning] /usr/local/mariadb-10.1.15-linux-x86_64/bin/mysqld: unknown variable 'loose-feedback-debug-interval=60'

2016-06-24 17:14:40 46941992236864 [Warning] /usr/local/mariadb-10.1.15-linux-x86_64/bin/mysqld: unknown variable 'loose-debug-sync-timeout=300'

2016-06-24 17:14:40 46941992236864 [Note] Server socket created on IP: '127.0.0.1'.

2016-06-24 17:14:40 46941992236864 [Note] /usr/local/mariadb-10.1.15-linux-x86_64/bin/mysqld: ready for connections.

Version: '10.1.15-MariaDB'  socket: '/usr/local/mariadb-10.1.15-linux-x86_64/mysql-test/var/tmp/4/mysqld.1.sock'  port: 16060  MariaDB Server

160624 17:29:41 [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.15-MariaDB

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 = 62889 K  bytes of memory

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

Thread pointer: 0x0x0

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 = 0x0 thread_stack 0x48400

/usr/local/mariadb-10.1.15-linux-x86_64/bin/mysqld(my_print_stacktrace+0x2e)[0xc037de]

/usr/local/mariadb-10.1.15-linux-x86_64/bin/mysqld(handle_fatal_signal+0x464)[0x7658d4]

/lib64/libpthread.so.0[0x2ab18771e4c0]

/lib64/libc.so.6(__poll+0x66)[0x2ab1887c0436]

/usr/local/mariadb-10.1.15-linux-x86_64/bin/mysqld(_Z26handle_connections_socketsv+0x1a0)[0x51ada0]

/usr/local/mariadb-10.1.15-linux-x86_64/bin/mysqld(_Z11mysqld_mainiPPc+0xf8d)[0x52184d]

/lib64/libc.so.6(__libc_start_main+0xf4)[0x2ab188713974]

/usr/local/mariadb-10.1.15-linux-x86_64/bin/mysqld[0x516289]

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

The server was restarted before the test, so there should be no dependency on previous tests.

The most curious thing about this failure is that it happened before only once, almost 2 years ago, on a different tree (one of 10.0 work trees) and on a different builder, but at the exactly the same place of the test. There is no log anymore, only the failure output:

10.0-serg	4280	work-amd64-valgrind	2014-07-08 16:01:42	5830	nm	Valgrind run, no --ps-protocol	funcs_2.memory_charset		timeout after 9000 seconds

funcs_2.memory_charset                   w6 [ fail ]  timeout after 9000 seconds

        Test ended at 2014-07-08 21:41:21

Test case timeout after 9000 seconds

== /dev/shm/var_auto_Oc0O/6/log/memory_charset.log ==

F1	1

F2	1

F3	1

F4	1

F5	1

F6	1

F7	1

F8	1

F9	1

FA	1

FB	1

FC	1

FD	1

DROP TABLE IF EXISTS test.t1;

DROP TABLE IF EXISTS test.t1;

SET NAMES greek;

CREATE TABLE test.t1 (a VARCHAR(3) CHARACTER SET greek COLLATE greek_bin) ENGINE=Memory CHARACTER SET greek COLLATE greek_bin;

SHOW TABLE STATUS LIKE 't1';

Name	Engine	Version	Row_format	Rows	Avg_row_length	Data_length	Max_data_length	Index_length	Data_free	Auto_increment	Create_time	Update_time	Check_time	Collation	Checksum	Create_options	Comment

t1	MEMORY	#	#	#	#	#	#	#	#	#	#	#	#	greek_bin	#	#	#

 == /dev/shm/var_auto_Oc0O/6/tmp/analyze-timeout-mysqld.1.err ==

mysqltest: Could not open connection 'default' after 500 attempts: 2002 Can't connect to local MySQL server through socket '/var/lib/buildbot/maria-slave/work-opensuse-amd64/build/mysql-test/var/tmp/6/mysqld.1.sock' (111 "Connection refused")

 - skipping '/dev/shm/var_auto_Oc0O/6/log/funcs_2.memory_charset/'

Retrying test funcs_2.memory_charset, attempt(2/3)...

The test normally lasts only a few seconds, during which it performs the same set of simple actions with dozens of character sets, and greek is somewhere in the middle. I'd say the probability that the failure happened both times on the very same charset by a pure chance is close to zero, there must be something special about greek.

Attachments

Issue Links

relates to

MDEV-7069 Fix buildbot failures in main server trees

Stalled

funcs_2.memory_charset failed with timeout in buildbot

Details

Description

Attachments

Issue Links

Activity

People

Dates

Git Integration