Uploaded image for project: 'WiredTiger'
  1. WiredTiger
  2. WT-8312

keys on page at [write-check] are incorrectly sorted

    • Type: Icon: Bug Bug
    • Resolution: Duplicate
    • Priority: Icon: Major - P3 Major - P3
    • None
    • Affects Version/s: None
    • Component/s: None
    • None

      zSeries failure here:

      [2021/10/29 00:13:18.434] format.sh: job in /data/mci/d6ac5dbd6df83f80a130eee4729fd4e6/wiredtiger/test/format/RUNDIR.7 failed
      [2021/10/29 00:13:18.435]     t: process 33599 running
      [2021/10/29 00:13:18.435]     [1635466390:344171][33599:0x3ff8ecf6e40], t, file:F00009, WT_CURSOR.insert: __verify_row_key_order_check, 259: the 1 and 3 keys on page at [write-check] are incorrectly sorted: 0000000189.00/opqrstuvwxyzabcdefghijklmnopqrstuvwxyzabcdefghijklmnopqrstuvwxyzabcdefghijklmnopqrstuvwxyzabcdefghijklmnopqrstuvwxyzabcdefghijklmnopqrstuvwxyzabcdefghijklmnopqrstuvwxyzabcdefghijklmnopqrstuvwxyzabcdefghijklmnopqrstuvwxyzabcdefghijklmnopqrstuv, 0000000189.00/opqrstuvwxyzabcdefghijklmnopqrstuvwxyzabcdefghijklmnopqrstuvwxyzabcdefghijklmnopqrstuvwxyzabcdefghijklmnopqrstuvwxyzabcdefghijklmnopqrstuvwxyzabcdefghijklmnopqrstuvwxyzabcdefghijklmnopqrstuvwxyzabcdefghijklmnopqrstuvwxyzabcdefghijklmnopqrstuv
      

      Here's the CONFIG:

      [2021/10/29 00:13:18.437]     ############################################
      [2021/10/29 00:13:18.437]     #  RUN PARAMETERS: V3
      [2021/10/29 00:13:18.437]     ############################################
      [2021/10/29 00:13:18.437]     assert.read_timestamp=0
      [2021/10/29 00:13:18.437]     assert.write_timestamp=0
      [2021/10/29 00:13:18.437]     backup=0
      [2021/10/29 00:13:18.437]     backup.incremental=off
      [2021/10/29 00:13:18.437]     backup.incr_granularity=8659
      [2021/10/29 00:13:18.437]     block_cache=1
      [2021/10/29 00:13:18.437]     block_cache.cache_on_checkpoint=0
      [2021/10/29 00:13:18.437]     block_cache.cache_on_writes=1
      [2021/10/29 00:13:18.437]     block_cache.size=111
      [2021/10/29 00:13:18.437]     btree.huffman_value=0
      [2021/10/29 00:13:18.437]     btree.internal_page_max=9
      [2021/10/29 00:13:18.437]     btree.key_min=256
      [2021/10/29 00:13:18.437]     btree.leaf_page_max=9
      [2021/10/29 00:13:18.437]     btree.value_min=256
      [2021/10/29 00:13:18.437]     cache=552
      [2021/10/29 00:13:18.437]     cache.evict_max=4
      [2021/10/29 00:13:18.437]     cache.minimum=20
      [2021/10/29 00:13:18.437]     checkpoint=on
      [2021/10/29 00:13:18.437]     checkpoint.log_size=37
      [2021/10/29 00:13:18.437]     checkpoint.wait=86
      [2021/10/29 00:13:18.437]     disk.data_extend=0
      [2021/10/29 00:13:18.437]     disk.direct_io=0
      [2021/10/29 00:13:18.437]     disk.encryption=rotn-7
      [2021/10/29 00:13:18.437]     disk.mmap=1
      [2021/10/29 00:13:18.437]     disk.mmap_all=0
      [2021/10/29 00:13:18.437]     format.abort=0
      [2021/10/29 00:13:18.437]     format.independent_thread_rng=0
      [2021/10/29 00:13:18.437]     format.major_timeout=0
      [2021/10/29 00:13:18.437]     import=0
      [2021/10/29 00:13:18.437]     logging=0
      [2021/10/29 00:13:18.437]     logging.archive=0
      [2021/10/29 00:13:18.437]     logging.compression=none
      [2021/10/29 00:13:18.437]     logging.file_max=170574
      [2021/10/29 00:13:18.437]     logging.prealloc=0
      [2021/10/29 00:13:18.437]     ops.alter=0
      [2021/10/29 00:13:18.437]     ops.compaction=0
      [2021/10/29 00:13:18.437]     ops.hs_cursor=0
      [2021/10/29 00:13:18.437]     ops.prepare=0
      [2021/10/29 00:13:18.437]     ops.random_cursor=0
      [2021/10/29 00:13:18.437]     ops.salvage=0
      [2021/10/29 00:13:18.437]     ops.verify=1
      [2021/10/29 00:13:18.437]     quiet=1
      [2021/10/29 00:13:18.437]     runs.in_memory=0
      [2021/10/29 00:13:18.437]     runs.ops=0
      [2021/10/29 00:13:18.437]     runs.rows=100000
      [2021/10/29 00:13:18.437]     runs.source=table
      [2021/10/29 00:13:18.437]     runs.tables=10
      [2021/10/29 00:13:18.437]     runs.threads=6
      [2021/10/29 00:13:18.437]     runs.timer=4
      [2021/10/29 00:13:18.437]     runs.type=row-store
      [2021/10/29 00:13:18.437]     runs.verify_failure_dump=0
      [2021/10/29 00:13:18.437]     statistics=0
      [2021/10/29 00:13:18.437]     statistics.server=0
      [2021/10/29 00:13:18.437]     stress.aggressive_sweep=0
      [2021/10/29 00:13:18.437]     stress.checkpoint=0
      [2021/10/29 00:13:18.437]     stress.checkpoint_reserved_txnid_delay=0
      [2021/10/29 00:13:18.437]     stress.checkpoint_prepare=1
      [2021/10/29 00:13:18.437]     stress.failpoint_hs_delete_key_from_ts=1
      [2021/10/29 00:13:18.437]     stress.failpoint_hs_insert_1=1
      [2021/10/29 00:13:18.437]     stress.failpoint_hs_insert_2=0
      [2021/10/29 00:13:18.437]     stress.hs_checkpoint_delay=0
      [2021/10/29 00:13:18.437]     stress.hs_search=0
      [2021/10/29 00:13:18.437]     stress.hs_sweep=0
      [2021/10/29 00:13:18.437]     stress.split_1=0
      [2021/10/29 00:13:18.437]     stress.split_2=0
      [2021/10/29 00:13:18.437]     stress.split_3=0
      [2021/10/29 00:13:18.437]     stress.split_4=0
      [2021/10/29 00:13:18.437]     stress.split_5=0
      [2021/10/29 00:13:18.437]     stress.split_6=0
      [2021/10/29 00:13:18.437]     stress.split_7=0
      [2021/10/29 00:13:18.438]     transaction.implicit=0
      [2021/10/29 00:13:18.438]     transaction.timestamps=1
      [2021/10/29 00:13:18.438]     wiredtiger.config=
      [2021/10/29 00:13:18.438]     wiredtiger.rwlock=1
      [2021/10/29 00:13:18.438]     wiredtiger.leak_memory=0
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     #  TABLE PARAMETERS: table 1
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     table1.btree.compression=none
      [2021/10/29 00:13:18.438]     table1.btree.dictionary=0
      [2021/10/29 00:13:18.438]     table1.btree.internal_key_truncation=1
      [2021/10/29 00:13:18.438]     table1.btree.key_max=256
      [2021/10/29 00:13:18.438]     table1.btree.memory_page_max=1
      [2021/10/29 00:13:18.438]     table1.btree.prefix_len=0
      [2021/10/29 00:13:18.438]     table1.btree.prefix_compression=1
      [2021/10/29 00:13:18.438]     table1.btree.prefix_compression_min=3
      [2021/10/29 00:13:18.438]     table1.btree.reverse=0
      [2021/10/29 00:13:18.438]     table1.btree.split_pct=60
      [2021/10/29 00:13:18.438]     table1.btree.value_max=1831
      [2021/10/29 00:13:18.438]     table1.disk.checksum=unencrypted
      [2021/10/29 00:13:18.438]     table1.disk.firstfit=0
      [2021/10/29 00:13:18.438]     table1.ops.pct.delete=5
      [2021/10/29 00:13:18.438]     table1.ops.pct.insert=22
      [2021/10/29 00:13:18.438]     table1.ops.pct.modify=21
      [2021/10/29 00:13:18.438]     table1.ops.pct.read=46
      [2021/10/29 00:13:18.438]     table1.ops.pct.write=6
      [2021/10/29 00:13:18.438]     table1.ops.truncate=1
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     #  TABLE PARAMETERS: table 2
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     table2.btree.compression=snappy
      [2021/10/29 00:13:18.438]     table2.btree.dictionary=0
      [2021/10/29 00:13:18.438]     table2.btree.internal_key_truncation=1
      [2021/10/29 00:13:18.438]     table2.btree.key_max=256
      [2021/10/29 00:13:18.438]     table2.btree.memory_page_max=3
      [2021/10/29 00:13:18.438]     table2.btree.prefix_len=0
      [2021/10/29 00:13:18.438]     table2.btree.prefix_compression=1
      [2021/10/29 00:13:18.438]     table2.btree.prefix_compression_min=0
      [2021/10/29 00:13:18.438]     table2.btree.reverse=0
      [2021/10/29 00:13:18.438]     table2.btree.split_pct=64
      [2021/10/29 00:13:18.438]     table2.btree.value_max=490
      [2021/10/29 00:13:18.438]     table2.disk.checksum=uncompressed
      [2021/10/29 00:13:18.438]     table2.disk.firstfit=0
      [2021/10/29 00:13:18.438]     table2.ops.pct.delete=94
      [2021/10/29 00:13:18.438]     table2.ops.pct.insert=0
      [2021/10/29 00:13:18.438]     table2.ops.pct.modify=2
      [2021/10/29 00:13:18.438]     table2.ops.pct.read=2
      [2021/10/29 00:13:18.438]     table2.ops.pct.write=2
      [2021/10/29 00:13:18.438]     table2.ops.truncate=1
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     #  TABLE PARAMETERS: table 3
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     table3.btree.compression=none
      [2021/10/29 00:13:18.438]     table3.btree.dictionary=0
      [2021/10/29 00:13:18.438]     table3.btree.internal_key_truncation=1
      [2021/10/29 00:13:18.438]     table3.btree.key_max=256
      [2021/10/29 00:13:18.438]     table3.btree.memory_page_max=9
      [2021/10/29 00:13:18.438]     table3.btree.prefix_len=54
      [2021/10/29 00:13:18.438]     table3.btree.prefix_compression=1
      [2021/10/29 00:13:18.438]     table3.btree.prefix_compression_min=3
      [2021/10/29 00:13:18.438]     table3.btree.reverse=0
      [2021/10/29 00:13:18.438]     table3.btree.split_pct=89
      [2021/10/29 00:13:18.438]     table3.btree.value_max=1308
      [2021/10/29 00:13:18.438]     table3.disk.checksum=unencrypted
      [2021/10/29 00:13:18.438]     table3.disk.firstfit=0
      [2021/10/29 00:13:18.438]     table3.ops.pct.delete=1
      [2021/10/29 00:13:18.438]     table3.ops.pct.insert=1
      [2021/10/29 00:13:18.438]     table3.ops.pct.modify=52
      [2021/10/29 00:13:18.438]     table3.ops.pct.read=43
      [2021/10/29 00:13:18.438]     table3.ops.pct.write=3
      [2021/10/29 00:13:18.438]     table3.ops.truncate=1
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     #  TABLE PARAMETERS: table 4
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     table4.btree.compression=none
      [2021/10/29 00:13:18.438]     table4.btree.dictionary=0
      [2021/10/29 00:13:18.438]     table4.btree.internal_key_truncation=0
      [2021/10/29 00:13:18.438]     table4.btree.key_max=256
      [2021/10/29 00:13:18.438]     table4.btree.memory_page_max=9
      [2021/10/29 00:13:18.438]     table4.btree.prefix_len=0
      [2021/10/29 00:13:18.438]     table4.btree.prefix_compression=1
      [2021/10/29 00:13:18.438]     table4.btree.prefix_compression_min=6
      [2021/10/29 00:13:18.438]     table4.btree.reverse=0
      [2021/10/29 00:13:18.438]     table4.btree.split_pct=90
      [2021/10/29 00:13:18.438]     table4.btree.value_max=1893
      [2021/10/29 00:13:18.438]     table4.disk.checksum=uncompressed
      [2021/10/29 00:13:18.438]     table4.disk.firstfit=0
      [2021/10/29 00:13:18.438]     table4.ops.pct.delete=3
      [2021/10/29 00:13:18.438]     table4.ops.pct.insert=19
      [2021/10/29 00:13:18.438]     table4.ops.pct.modify=6
      [2021/10/29 00:13:18.438]     table4.ops.pct.read=62
      [2021/10/29 00:13:18.438]     table4.ops.pct.write=10
      [2021/10/29 00:13:18.438]     table4.ops.truncate=1
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     #  TABLE PARAMETERS: table 5
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     table5.btree.compression=snappy
      [2021/10/29 00:13:18.438]     table5.btree.dictionary=0
      [2021/10/29 00:13:18.438]     table5.btree.internal_key_truncation=1
      [2021/10/29 00:13:18.438]     table5.btree.key_max=256
      [2021/10/29 00:13:18.438]     table5.btree.memory_page_max=7
      [2021/10/29 00:13:18.438]     table5.btree.prefix_len=0
      [2021/10/29 00:13:18.438]     table5.btree.prefix_compression=1
      [2021/10/29 00:13:18.438]     table5.btree.prefix_compression_min=7
      [2021/10/29 00:13:18.438]     table5.btree.reverse=1
      [2021/10/29 00:13:18.438]     table5.btree.split_pct=96
      [2021/10/29 00:13:18.438]     table5.btree.value_max=1728
      [2021/10/29 00:13:18.438]     table5.disk.checksum=uncompressed
      [2021/10/29 00:13:18.438]     table5.disk.firstfit=0
      [2021/10/29 00:13:18.438]     table5.ops.pct.delete=20
      [2021/10/29 00:13:18.438]     table5.ops.pct.insert=36
      [2021/10/29 00:13:18.438]     table5.ops.pct.modify=36
      [2021/10/29 00:13:18.438]     table5.ops.pct.read=1
      [2021/10/29 00:13:18.438]     table5.ops.pct.write=7
      [2021/10/29 00:13:18.438]     table5.ops.truncate=1
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     #  TABLE PARAMETERS: table 6
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     table6.btree.compression=none
      [2021/10/29 00:13:18.438]     table6.btree.dictionary=0
      [2021/10/29 00:13:18.438]     table6.btree.internal_key_truncation=1
      [2021/10/29 00:13:18.438]     table6.btree.key_max=256
      [2021/10/29 00:13:18.438]     table6.btree.memory_page_max=4
      [2021/10/29 00:13:18.438]     table6.btree.prefix_len=35
      [2021/10/29 00:13:18.438]     table6.btree.prefix_compression=1
      [2021/10/29 00:13:18.438]     table6.btree.prefix_compression_min=2
      [2021/10/29 00:13:18.438]     table6.btree.reverse=0
      [2021/10/29 00:13:18.438]     table6.btree.split_pct=82
      [2021/10/29 00:13:18.438]     table6.btree.value_max=1542
      [2021/10/29 00:13:18.438]     table6.disk.checksum=on
      [2021/10/29 00:13:18.438]     table6.disk.firstfit=0
      [2021/10/29 00:13:18.438]     table6.ops.pct.delete=87
      [2021/10/29 00:13:18.438]     table6.ops.pct.insert=0
      [2021/10/29 00:13:18.438]     table6.ops.pct.modify=13
      [2021/10/29 00:13:18.438]     table6.ops.pct.read=0
      [2021/10/29 00:13:18.438]     table6.ops.pct.write=0
      [2021/10/29 00:13:18.438]     table6.ops.truncate=1
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     #  TABLE PARAMETERS: table 7
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     table7.btree.compression=none
      [2021/10/29 00:13:18.438]     table7.btree.dictionary=1
      [2021/10/29 00:13:18.438]     table7.btree.internal_key_truncation=1
      [2021/10/29 00:13:18.438]     table7.btree.key_max=256
      [2021/10/29 00:13:18.438]     table7.btree.memory_page_max=1
      [2021/10/29 00:13:18.438]     table7.btree.prefix_len=0
      [2021/10/29 00:13:18.438]     table7.btree.prefix_compression=0
      [2021/10/29 00:13:18.438]     table7.btree.prefix_compression_min=3
      [2021/10/29 00:13:18.438]     table7.btree.reverse=0
      [2021/10/29 00:13:18.438]     table7.btree.split_pct=88
      [2021/10/29 00:13:18.438]     table7.btree.value_max=508
      [2021/10/29 00:13:18.438]     table7.disk.checksum=on
      [2021/10/29 00:13:18.438]     table7.disk.firstfit=0
      [2021/10/29 00:13:18.438]     table7.ops.pct.delete=18
      [2021/10/29 00:13:18.438]     table7.ops.pct.insert=3
      [2021/10/29 00:13:18.438]     table7.ops.pct.modify=0
      [2021/10/29 00:13:18.438]     table7.ops.pct.read=18
      [2021/10/29 00:13:18.438]     table7.ops.pct.write=61
      [2021/10/29 00:13:18.438]     table7.ops.truncate=1
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     #  TABLE PARAMETERS: table 8
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     table8.btree.compression=snappy
      [2021/10/29 00:13:18.438]     table8.btree.dictionary=0
      [2021/10/29 00:13:18.438]     table8.btree.internal_key_truncation=1
      [2021/10/29 00:13:18.438]     table8.btree.key_max=256
      [2021/10/29 00:13:18.438]     table8.btree.memory_page_max=10
      [2021/10/29 00:13:18.438]     table8.btree.prefix_len=0
      [2021/10/29 00:13:18.438]     table8.btree.prefix_compression=1
      [2021/10/29 00:13:18.438]     table8.btree.prefix_compression_min=1
      [2021/10/29 00:13:18.438]     table8.btree.reverse=0
      [2021/10/29 00:13:18.438]     table8.btree.split_pct=73
      [2021/10/29 00:13:18.438]     table8.btree.value_max=712
      [2021/10/29 00:13:18.438]     table8.disk.checksum=unencrypted
      [2021/10/29 00:13:18.438]     table8.disk.firstfit=0
      [2021/10/29 00:13:18.438]     table8.ops.pct.delete=89
      [2021/10/29 00:13:18.438]     table8.ops.pct.insert=11
      [2021/10/29 00:13:18.438]     table8.ops.pct.modify=0
      [2021/10/29 00:13:18.438]     table8.ops.pct.read=0
      [2021/10/29 00:13:18.438]     table8.ops.pct.write=0
      [2021/10/29 00:13:18.438]     table8.ops.truncate=1
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     #  TABLE PARAMETERS: table 9
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     table9.btree.compression=zlib
      [2021/10/29 00:13:18.438]     table9.btree.dictionary=0
      [2021/10/29 00:13:18.438]     table9.btree.internal_key_truncation=1
      [2021/10/29 00:13:18.438]     table9.btree.key_max=256
      [2021/10/29 00:13:18.438]     table9.btree.memory_page_max=1
      [2021/10/29 00:13:18.438]     table9.btree.prefix_len=0
      [2021/10/29 00:13:18.438]     table9.btree.prefix_compression=1
      [2021/10/29 00:13:18.438]     table9.btree.prefix_compression_min=6
      [2021/10/29 00:13:18.438]     table9.btree.reverse=0
      [2021/10/29 00:13:18.438]     table9.btree.split_pct=50
      [2021/10/29 00:13:18.438]     table9.btree.value_max=2110
      [2021/10/29 00:13:18.438]     table9.disk.checksum=unencrypted
      [2021/10/29 00:13:18.438]     table9.disk.firstfit=0
      [2021/10/29 00:13:18.438]     table9.ops.pct.delete=5
      [2021/10/29 00:13:18.438]     table9.ops.pct.insert=7
      [2021/10/29 00:13:18.438]     table9.ops.pct.modify=71
      [2021/10/29 00:13:18.438]     table9.ops.pct.read=17
      [2021/10/29 00:13:18.438]     table9.ops.pct.write=0
      [2021/10/29 00:13:18.438]     table9.ops.truncate=1
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     #  TABLE PARAMETERS: table 10
      [2021/10/29 00:13:18.438]     ############################################
      [2021/10/29 00:13:18.438]     table10.btree.compression=zlib
      [2021/10/29 00:13:18.438]     table10.btree.dictionary=0
      [2021/10/29 00:13:18.438]     table10.btree.internal_key_truncation=1
      [2021/10/29 00:13:18.438]     table10.btree.key_max=256
      [2021/10/29 00:13:18.438]     table10.btree.memory_page_max=1
      [2021/10/29 00:13:18.438]     table10.btree.prefix_len=0
      [2021/10/29 00:13:18.438]     table10.btree.prefix_compression=1
      [2021/10/29 00:13:18.438]     table10.btree.prefix_compression_min=0
      [2021/10/29 00:13:18.438]     table10.btree.reverse=0
      [2021/10/29 00:13:18.438]     table10.btree.split_pct=77
      [2021/10/29 00:13:18.438]     table10.btree.value_max=2562
      [2021/10/29 00:13:18.438]     table10.disk.checksum=unencrypted
      [2021/10/29 00:13:18.438]     table10.disk.firstfit=0
      [2021/10/29 00:13:18.438]     table10.ops.pct.delete=15
      [2021/10/29 00:13:18.438]     table10.ops.pct.insert=0
      [2021/10/29 00:13:18.438]     table10.ops.pct.modify=4
      [2021/10/29 00:13:18.438]     table10.ops.pct.read=73
      [2021/10/29 00:13:18.438]     table10.ops.pct.write=8
      [2021/10/29 00:13:18.438]     table10.ops.truncate=1
      

            Assignee:
            keith.bostic@mongodb.com Keith Bostic (Inactive)
            Reporter:
            keith.bostic@mongodb.com Keith Bostic (Inactive)
            Votes:
            0 Vote for this issue
            Watchers:
            2 Start watching this issue

              Created:
              Updated:
              Resolved: