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

funcs_2.memory_charset failed with timeout in buildbot

    Details

      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

            Activity

              People

              • Assignee:
                bar Alexander Barkov
                Reporter:
                elenst Elena Stepanova
              • Votes:
                0 Vote for this issue
                Watchers:
                1 Start watching this issue

                Dates

                • Created:
                  Updated: