[MDEV-10290] funcs_2.memory_charset failed with timeout in buildbot Created: 2016-06-26  Updated: 2023-11-29  Resolved: 2023-11-29

Status: Closed
Project: MariaDB Server
Component/s: Character Sets, Tests
Affects Version/s: 10.1
Fix Version/s: N/A

Type: Bug Priority: Minor
Reporter: Elena Stepanova Assignee: Alexander Barkov
Resolution: Won't Fix Votes: 0
Labels: None

Issue Links:
Relates
relates to MDEV-7069 Fix buildbot failures in main server ... Stalled

 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.


Generated at Thu Feb 08 07:41:05 UTC 2024 using Jira 8.20.16#820016-sha1:9d11dbea5f4be3d4cc21f03a88dd11d8c8687422.