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

Assertion failure in file fil0fil.c line 5268

    Details

    • Type: Bug
    • Status: Closed
    • Priority: Major
    • Resolution: Cannot Reproduce
    • Affects Version/s: None
    • Fix Version/s: N/A
    • Labels:
      None

      Description

      Got the assertion once while running an RQG test on mdev-232 tree, but could not reproduce it so far. Saving as a bug so the information didn't get lost.

      InnoDB: DEBUG: update_statistics for test/z#P#p5.
      InnoDB: Error: trying to access page number 4294965631 in space 0,
      InnoDB: space name ./ibdata1,
      InnoDB: which is outside the tablespace bounds.
      InnoDB: Byte offset 0, len 16384, i/o type 10.
      InnoDB: If you get this error at mysqld startup, please check that
      InnoDB: your my.cnf matches the ibdata files that you have in the
      InnoDB: MySQL server.
      120615 22:55:57  InnoDB: Assertion failure in thread 139720830846720 in file fil0fil.c line 5268
      InnoDB: We intentionally generate a memory trap.
      InnoDB: Submit a detailed bug report to http://bugs.mysql.com.
      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.5/en/forcing-innodb-recovery.html
      InnoDB: about forcing recovery.
      120615 22:55:57 [ERROR] mysqld got signal 6 ;
      
      #5  0x00007f1364835b0b in __GI_abort () at abort.c:92
      #6  0x0000000000b349ea in _fil_io (type=10, sync=1, space_id=0, zip_size=0, block_offset=4294965631, byte_offset=0, len=16384, buf=0x7f135b268000, message=0x7f1353a7d630, trx=0x0) at storage/xtradb/fil/fil0fil.c:5268
      #7  0x0000000000af6f0f in buf_read_page_low (err=0x7f134a7d31f0, sync=1, mode=132, space=0, zip_size=0, unzip=0, tablespace_version=1, offset=4294967295, trx=0x0) at storage/xtradb/buf/buf0rea.c:196
      #8  0x0000000000af744e in buf_read_page (space=0, zip_size=0, offset=4294967295, trx=0x0) at storage/xtradb/buf/buf0rea.c:410
      #9  0x0000000000adf01d in buf_page_get_gen (space=0, zip_size=0, offset=4294967295, rw_latch=2, guess=0x0, mode=10, file=0xe1c6e0 "storage/xtradb/btr/btr0btr.c", line=694, mtr=0x7f134a7d3430) at storage/xtradb/buf/buf0buf.c:2582
      #10 0x0000000000aaca07 in btr_block_get_func (space=0, zip_size=0, page_no=4294967295, mode=2, file=0xe1c6e0 "storage/xtradb/btr/btr0btr.c", line=694, mtr=0x7f134a7d3430) at storage/xtradb/include/btr0btr.ic:59
      #11 0x0000000000aad6f4 in btr_root_block_get (index=0x4dda818, mtr=0x7f134a7d3430) at storage/xtradb/btr/btr0btr.c:693
      #12 0x0000000000aad874 in btr_root_get (index=0x4dda818, mtr=0x7f134a7d3430) at storage/xtradb/btr/btr0btr.c:727
      #13 0x0000000000aae0c0 in btr_get_size (index=0x4dda818, flag=2) at storage/xtradb/btr/btr0btr.c:985
      #14 0x0000000000b13aca in dict_update_statistics (table=0x7f13402c5408, only_calc_if_missing_stats=0, sync=0) at storage/xtradb/dict/dict0dict.c:4742
      #15 0x0000000000a1bc3e in ha_innobase::info_low (this=0x7f133c149ee8, flag=212, called_from_analyze=false) at storage/xtradb/handler/ha_innodb.cc:8883
      #16 0x0000000000a1c72b in ha_innobase::info (this=0x7f133c149ee8, flag=212) at storage/xtradb/handler/ha_innodb.cc:9183
      #17 0x00000000006879b3 in get_schema_tables_record (thd=0x7f1344180520, tables=0x5000738, table=0x4f22988, res=false, db_name=0x7f134a7d6380, table_name=0x4de60e8) at sql/sql_show.cc:4502
      #18 0x0000000000685165 in fill_schema_table_by_open (thd=0x7f1344180520, is_show_fields_or_keys=false, table=0x4f22988, schema_table=0x137aa80, orig_db_name=0x7f134a7d6380, orig_table_name=0x4de60e8, open_tables_state_backup=0x7f134a7d6330, can_deadlock=false) at sql/sql_show.cc:3587
      #19 0x0000000000686755 in get_all_tables (thd=0x7f1344180520, tables=0x4d1a6a8, cond=0x0) at sql/sql_show.cc:4239
      #20 0x000000000069463a in do_fill_table (thd=0x7f1344180520, table_list=0x4d1a6a8, join_table=0x4e5bf58) at sql/sql_show.cc:7394
      #21 0x0000000000694a4c in get_schema_tables_result (join=0x4de5b30, executed_place=PROCESSED_BY_JOIN_EXEC) at sql/sql_show.cc:7501
      #22 0x0000000000640b78 in JOIN::exec (this=0x4de5b30) at sql/sql_select.cc:2275
      #23 0x0000000000643565 in mysql_select (thd=0x7f1344180520, rref_pointer_array=0x7f13441831c8, tables=0x4d1a6a8, wild_num=0, fields=..., conds=0x0, og_num=0, order=0x0, group=0x0, having=0x0, proc_param=0x0, select_options=2684619520, result=0x4de5b10, unit=0x7f1344182898, select_lex=0x7f1344182f70) at sql/sql_select.cc:3003
      #24 0x000000000063a321 in handle_select (thd=0x7f1344180520, lex=0x7f13441827e8, result=0x4de5b10, setup_tables_done_option=0) at sql/sql_select.cc:310
      #25 0x0000000000613584 in execute_sqlcom_select (thd=0x7f1344180520, all_tables=0x4d1a6a8) at sql/sql_parse.cc:4616
      #26 0x000000000060c0c9 in mysql_execute_command (thd=0x7f1344180520) at sql/sql_parse.cc:2184
      #27 0x0000000000615deb in mysql_parse (thd=0x7f1344180520, rawbuf=0x4d18e68 "SHOW TABLE STATUS", length=17, parser_state=0x7f134a7d7550) at sql/sql_parse.cc:5731
      #28 0x000000000060968f in dispatch_command (command=COM_QUERY, thd=0x7f1344180520, packet=0x7f134404b9a1 "SHOW TABLE STATUS", packet_length=17) at sql/sql_parse.cc:1055
      #29 0x0000000000608946 in do_command (thd=0x7f1344180520) at sql/sql_parse.cc:794
      #30 0x0000000000709007 in do_handle_one_connection (thd_arg=0x7f1344180520) at sql/sql_connect.cc:1253
      #31 0x00000000007089f2 in handle_one_connection (arg=0x7f1344180520) at sql/sql_connect.cc:1168
      #32 0x00007f136556cefc in start_thread (arg=0x7f134a7d8700) at pthread_create.c:304
      #33 0x00007f13648df59d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112
      
      Server version: 5.5.23-MariaDB-debug-log
      key_buffer_size=1048576
      read_buffer_size=131072
      max_used_connections=12
      max_threads=153
      thread_count=10
      
      Trying to get some variables.
      Some pointers may be invalid and cause the dump to abort.
      Query (0x4d18e68): SHOW TABLE STATUS
      Connection ID (thread ID): 18
      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=off
      

      ~maria-captains/maria/5.5-mdev232
      bzr version-info

      revision-id: knielsen@knielsen-hq.org-20120613132210-vwxe0ejooug9a0bl
      date: 2012-06-13 15:22:10 +0200
      build-date: 2012-06-16 19:51:14 +0400
      revno: 3382
      

      RQG command line (the grammar is standard from rqg-mariadb revno 969, randgen revno 744):

      perl runall.pl \
      --queries=100000000 \
      --no-mask \
      --seed=1339736060 \
      --threads=8 \
      --duration=600 \
      --queries=100M \
      --reporters=QueryTimeout,Backtrace,ErrorLog,Deadlock,ReplicationConsistency \
      --grammar=conf/runtime/information_schema.yy \
      --engine=InnoDB \
      --rpl_mode=row \
      --mysqld=--log-output=FILE \
      --mtr-build-thread=300 \
      --mask=2829 \
      --basedir1=<my basedir> --vardir1=<my vardir>
      

      all threads stack trace, master.log and master.err are attached.

        Gliffy Diagrams

          Attachments

          1. master.err.gz
            85 kB
          2. master.log.gz
            2.66 MB
          3. threads1
            60 kB

            Activity

            There are no comments yet on this issue.

              People

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

                Dates

                • Created:
                  Updated:
                  Resolved:

                  Time Tracking

                  Estimated:
                  Original Estimate - Not Specified
                  Not Specified
                  Remaining:
                  Remaining Estimate - 0 minutes
                  0m
                  Logged:
                  Time Spent - 2 hours
                  2h