failed: unit-test-hook-disagg-leader-table on ubuntu2004-nonstandalone [wiredtiger @ 34d32553]

XMLWordPrintableJSON

    • Type: Build Failure
    • Resolution: Unresolved
    • Priority: Major - P3
    • None
    • Affects Version/s: None
    • Component/s: None

      unit-test-hook-disagg-leader-table on ubuntu2004-nonstandalone

      Host: i-00847db6f67cf7ff8
      Project: wiredtiger
      Commit: 34d32553
      Please refer to BF(G) Playbook for instructions on handling BF and BFG tickets as well as Auto-Resolution Rules

      Task Logs:

      unit-test-hook-disagg-leader-table task_log

      Logs:

      test_import12.py: [pid:56387]:     Creating "file:new_db_file" with config = "import=(enabled,repair=false,panic_corrupt=false,file_metadata=(access_pattern_hint=none,allocation_size=512,app_metadata=,assert=(commit_timestamp=none,durable_timestamp=none,read_timestamp=none,write_timestamp=off),block_allocation=best,block_compressor=,block_manager=default,cache_resident=false,checksum=on,collator=,columns=,dictionary=0,disaggregated=(delta_pct=20,max_consecutive_delta=32,page_log=),encryption=(keyid=,name=),format=btree,huffman_key=,huffman_value=,id=32,ignore_in_memory_cache_size=false,in_memory=false,internal_item_max=0,internal_key_max=0,internal_key_truncate=true,internal_page_max=4KB,key_format=u,key_gap=10,leaf_item_max=0,leaf_key_max=0,leaf_page_max=32KB,leaf_value_max=0,log=(enabled=true),memory_page_image_max=0,memory_page_max=5MB,os_cache_dirty_max=0,os_cache_max=0,prefix_compression=false,prefix_compression_min=4,readonly=false,split_deepen_min_child=0,split_deepen_per_child=0,split_pct=90,tiered_object=false,tiered_storage=(auth_token=,bucket=,bucket_prefix=,cache_directory=,local_retention=300,name=,object_target_size=0),value_format=u,verbose=[],version=(major=1,minor=1),write_timestamp_usage=none,checkpoint=(WiredTigerCheckpoint.2=(addr="018881e4d31f08608981e4e5a567078a84e41aef88f2808080ddc0c1c0",order=2,time=1753082097,size=1024,newest_start_durable_ts=40,oldest_start_ts=10,newest_txn=9,newest_stop_durable_ts=0,newest_stop_ts=-1,newest_stop_txn=-11,prepare=0,write_gen=6,run_write_gen=1,next_page_id=100)),checkpoint_backup_info=,checkpoint_lsn=(4294967295,2147483647)))"
test_import12.py: [pid:56387]:     Creating "file:new_db_file" with config = "import=(enabled,repair=false,panic_corrupt=false,file_metadata=(access_pattern_hint=none,allocation_size=512,app_metadata=,assert=(commit_timestamp=none,durable_timestamp=none,read_timestamp=none,write_timestamp=off),block_allocation=best,block_compressor=,block_manager=default,cache_resident=false,checksum=on,collator=,columns=,dictionary=0,disaggregated=(delta_pct=20,max_consecutive_delta=32,page_log=),encryption=(keyid=,name=),format=btree,huffman_key=,huffman_value=,id=32,ignore_in_memory_cache_size=false,in_memory=false,internal_item_max=0,internal_key_max=0,internal_key_truncate=true,internal_page_max=4KB,key_format=u,key_gap=10,leaf_item_max=0,leaf_key_max=0,leaf_page_max=32KB,leaf_value_max=0,log=(enabled=true),memory_page_image_max=0,memory_page_max=5MB,os_cache_dirty_max=0,os_cache_max=0,prefix_compression=false,prefix_compression_min=4,readonly=false,split_deepen_min_child=0,split_deepen_per_child=0,split_pct=90,tiered_object=false,tiered_storage=(auth_token=,bucket=,bucket_prefix=,cache_directory=,local_retention=300,name=,object_target_size=0),value_format=u,verbose=[],version=(major=1,minor=1),write_timestamp_usage=none,checkpoint=(WiredTigerCheckpoint.2=(addr="018881e4d31f08608981e4e5a567078a84e41aef88f2808080ddc0c1c0",order=2,time=1753082097,size=1024,newest_start_durable_ts=40,oldest_start_ts=10,newest_txn=9,newest_stop_durable_ts=0,newest_stop_ts=-1,newest_stop_txn=-11,prepare=0,write_gen=6,run_write_gen=1,next_page_id=100)),checkpoint_backup_info=,checkpoint_lsn=(4294967295,2147483647)))"
test_import12.py: [pid:56387]:     Creating "file:new_db_file" with config = "import=(enabled,repair=false,panic_corrupt=false,file_metadata=(access_pattern_hint=none,allocation_size=512,app_metadata=,assert=(commit_timestamp=none,durable_timestamp=none,read_timestamp=none,write_timestamp=off),block_allocation=best,block_compressor=,block_manager=default,cache_resident=false,checksum=on,collator=,columns=,dictionary=0,disaggregated=(delta_pct=20,max_consecutive_delta=32,page_log=),encryption=(keyid=,name=),format=btree,huffman_key=,huffman_value=,id=32,ignore_in_memory_cache_size=false,in_memory=false,internal_item_max=0,internal_key_max=0,internal_key_truncate=true,internal_page_max=4KB,key_format=u,key_gap=10,leaf_item_max=0,leaf_key_max=0,leaf_page_max=32KB,leaf_value_max=0,log=(enabled=true),memory_page_image_max=0,memory_page_max=5MB,os_cache_dirty_max=0,os_cache_max=0,prefix_compression=false,prefix_compression_min=4,readonly=false,split_deepen_min_child=0,split_deepen_per_child=0,split_pct=90,tiered_object=false,tiered_storage=(auth_token=,bucket=,bucket_prefix=,cache_directory=,local_retention=300,name=,object_target_size=0),value_format=u,verbose=[],version=(major=1,minor=1),write_timestamp_usage=none,checkpoint=(WiredTigerCheckpoint.2=(addr="018881e4d31f08608981e4e5a567078a84e41aef88f2808080ddc0c1c0",order=2,time=1753082097,size=1024,newest_start_durable_ts=40,oldest_start_ts=10,newest_txn=9,newest_stop_durable_ts=0,newest_stop_ts=-1,newest_stop_txn=-11,prepare=0,write_gen=6,run_write_gen=1,next_page_id=100)),checkpoint_backup_info=,checkpoint_lsn=(4294967295,2147483647)))"

      logs

      unit-test-hook-disagg-leader-table task_log

      Logs:

      test_truncate09.py: [pid:73108]: FAIL: None
test_truncate09.py: ----------------------------------------------------------------------
test_truncate09.py: [pid:73108]: Traceback (most recent call last):
test_truncate09.py:   File "/data/mci/f43a62d9db4f278b34e6c1f166cddef3/wiredtiger/test/suite/wttest.py", line 570, in tearDown
test_truncate09.py:     self.captureout.check(self)
test_truncate09.py:   File "/data/mci/f43a62d9db4f278b34e6c1f166cddef3/wiredtiger/test/suite/../py_utility/abstract_test_case.py", line 111, in check
test_truncate09.py:     testcase.fail('unexpected ' + self.desc + ', contains: "' +
test_truncate09.py: AssertionError: unexpected standard output, contains: "[1753082225:989405][73108:0x7fc5ed634cc0], test_truncate09.test_truncate09.test_truncate09(row_integer), txn-recover: [WT_VERB_RTS][WARNING]: skipped recovery RTS due to disagg
test_truncate09.py: [1753082352:379666][73108:0x7fc5cc3db700], test_truncate09.test_truncate09.test_truncate09(row_integer), file:test_truncate09.wt_stable, eviction-server: [WT_VERB_EVICTION][WARNING]: Eviction took more than 1 minute (92701308us). Building disk image took 92676192us. History store wrapup took 6594us.
test_truncate09.py: [1753082353:324650][73108:0x7fc5ed634cc0], test_truncate09.test_truncate09.test_truncate09(row_integer), file:test_truncate09.wt_stable, connection-open-session: [WT_VERB_EVICTION][WARNING]: Eviction took more than 1 minute (93492747us). Building disk image took 93463165us. History store wrapup took 7273us.
test_truncate09.py: [1753082354:080755][73108:0x7fc5ed634cc0], test_truncate09.test_truncate09.test_truncate09(row_integer), WT_CONNECTION.close: [WT_VERB_RTS][WARNING]: skipped shutdown RTS due to disagg
test_truncate09.py: [1753082535:686229][73108:0x7fc5ed634cc0], test_truncate09.test_truncate09.test_truncate09(row_integer), txn-recover: [WT_VERB_RTS][WARNING]: skipped recovery RTS due to disagg
test_truncate09.py: [1753082536:687443][73108:0x7fc5ed634cc0], test_truncate09.test_truncate09.test_truncate09(row_integer), WT_CONNECTION.close: [WT_VERB_RTS][WARNING]: skipped shutdown RTS due to disagg
test_truncate09.py: "
test_truncate09.py:
test_truncate09.py: ----------------------------------------------------------------------
test_truncate09.py: Ran 2 tests in 314.211s
test_truncate09.py:

      logs

      unit-test-hook-disagg-leader-table task_log

      Logs:

      ERROR: test_truncate09.py process returned 1
Waiting on processes:  test_compat03.py [40891] test_config01.py [41294] test_cursor12.py [44447] test_prepare09.py [61960] test_truncate08.py [71986] test_truncate15.py [74829] test_txn24.py [82973]
starting
test_config01.py: [pid:41297]:     Replacing, old config = "\key_format=S,value_format=S,internal_page_max=536870912,leaf_page_max=536870912"
test_config01.py: [pid:41297]:     Replacing, new config = "\key_format=S,value_format=S,internal_page_max=536870912,leaf_page_max=536870912,block_manager=disagg,type=layered"
test_config01.py: [pid:41297]:     Creating "table:test_base03a" with config = "key_format=S,value_format=S,internal_page_max=536870912,leaf_page_max=536870912,block_manager=disagg,type=layered"
test_config01.py: [pid:41297]: test_config01.test_config01.test_table_ss -s 105 (scen_ntdtt): 1.32 seconds
test_config01.py: ok
test_config01.py: [pid:41297]: Create entries, and read back in a cursor: key=string, value=string (scen_ntntk) ... [pid:41297]: test_config01.test_config01.test_table_ss -s 106 (scen_ntntk): starting
test_config01.py: [pid:41297]:     Replacing, old config = "\key_format=S,value_format=S,internal_page_max=536870912,leaf_page_max=536870912"
test_config01.py: [pid:41297]:     Replacing, new config = "\key_format=S,value_format=S,internal_page_max=536870912,leaf_page_max=536870912,block_manager=disagg,type=layered"
test_config01.py: [pid:41297]:     Creating "table:test_base03a" with config = "key_format=S,value_format=S,internal_page_max=536870912,leaf_page_max=536870912,block_manager=disagg,type=layered"
test_config01.py: [pid:41297]: test_config01.test_config01.test_table_ss -s 106 (scen_ntntk): 1.32 seconds
test_config01.py: ok
test_config01.py: [pid:41297]: Create entries, and read back in a cursor: key=string, value=string (scen_ntntp) ... [pid:41297]: test_config01.test_config01.test_table_ss -s 107 (scen_ntntp): starting
test_config01.py: [pid:41297]:     Replacing, old config = "\key_format=S,value_format=S,internal_page_max=536870912,leaf_page_max=536870912"
test_config01.py: [pid:41297]:     Replacing, new config = "\key_format=S,value_format=S,internal_page_max=536870912,leaf_page_max=536870912,block_manager=disagg,type=layered"
test_config01.py: [pid:41297]:     Creating "table:test_base03a" with config = "key_format=S,value_format=S,internal_page_max=536870912,leaf_page_max=536870912,block_manager=disagg,type=layered"
test_config01.py: [pid:41297]: test_config01.test_config01.test_table_ss -s 107 (scen_ntntp): 1.28 seconds
test_config01.py: ok
test_config01.py: [pid:41297]: Create entries, and read back in a cursor: key=string, value=string (scen_ntntt) ... [pid:41297]: test_config01.test_config01.test_table_ss -s 108 (scen_ntntt): starting
test_config01.py: [pid:41297]:     Replacing, old config = "\key_format=S,value_format=S,internal_page_max=536870912,leaf_page_max=536870912"
test_config01.py: [pid:41297]:     Replacing, new config = "\key_format=S,value_format=S,internal_page_max=536870912,leaf_page_max=536870912,block_manager=disagg,type=layered"
test_config01.py: [pid:41297]:     Creating "table:test_base03a" with config = "key_format=S,value_format=S,internal_page_max=536870912,leaf_page_max=536870912,block_manager=disagg,type=layered"
test_config01.py: [pid:41297]: test_config01.test_config01.test_table_ss -s 108 (scen_ntntt): 1.25 seconds
test_config01.py: ok
test_config01.py:
test_config01.py: ----------------------------------------------------------------------
test_config01.py: Ran 436 tests in 555.076s
test_config01.py:
test_config01.py: OK
Waiting on processes:  test_compat03.py [40891] test_cursor12.py [44447] test_prepare09.py [61960] test_truncate08.py [71986] test_truncate15.py [74829] test_txn24.py [82973]
min): 1.19 seconds
test_compat03.py: skipped 'cannot run disagg hook on a test that requires compatibility in the config string'
test_compat03.py: [pid:40893]: None ... [pid:40893]: test_compat03.test_compat03.test_compat03 -s 465 (100_rel.120_max.def_min): starting
test_compat03.py: [pid:40893]: test_compat03.test_compat03.test_compat03 -s 465 (100_rel.120_max.def_min): 1.20 seconds
test_compat03.py: skipped 'cannot run disagg hook on a test that requires compatibility in the config string'
test_compat03.py: [pid:40893]: None ... [pid:40893]: test_compat03.test_compat03.test_compat03 -s 466 (100_rel.120_max.100_min): starting
test_compat03.py: [pid:40893]: test_compat03.test_compat03.test_compat03 -s 466 (100_rel.120_max.100_min): 1.21 seconds
test_compat03.py: skipped 'cannot run disagg hook on a test that requires compatibility in the config string'
test_compat03.py: [pid:40893]: None ... [pid:40893]: test_compat03.test_compat03.test_compat03 -s 467 (100_rel.120_max.33_min): starting
test_compat03.py: [pid:40893]: test_compat03.test_compat03.test_compat03 -s 467 (100_rel.120_max.33_min): 1.20 seconds
test_compat03.py: skipped 'cannot run disagg hook on a test that requires compatibility in the config string'
test_compat03.py: [pid:40893]: None ... [pid:40893]: test_compat03.test_compat03.test_compat03 -s 468 (100_rel.120_max.31_min): starting
test_compat03.py: [pid:40893]: test_compat03.test_compat03.test_compat03 -s 468 (100_rel.120_max.31_min): 1.19 seconds
test_compat03.py: skipped 'cannot run disagg hook on a test that requires compatibility in the config string'
test_compat03.py: [pid:40893]: None ... [pid:40893]: test_compat03.test_compat03.test_compat03 -s 469 (100_rel.120_max.30_min): starting
test_compat03.py: [pid:40893]: test_compat03.test_compat03.test_compat03 -s 469 (100_rel.120_max.30_min): 1.20 seconds
test_compat03.py: skipped 'cannot run disagg hook on a test that requires compatibility in the config string'
test_compat03.py: [pid:40893]: None ... [pid:40893]: test_compat03.test_compat03.test_compat03 -s 470 (100_rel.120_max.26_min): starting
test_compat03.py: [pid:40893]: test_compat03.test_compat03.test_compat03 -s 470 (100_rel.120_max.26_min): 1.19 seconds
test_compat03.py: skipped 'cannot run disagg hook on a test that requires compatibility in the config string'
test_compat03.py: [pid:40893]: None ... [pid:40893]: test_compat03.test_compat03.test_compat03 -s 471 (100_rel.120_max.26_patch_min): starting
test_compat03.py: [pid:40893]: test_compat03.test_compat03.test_compat03 -s 471 (100_rel.120_max.26_patch_min): 1.19 seconds
test_compat03.py: skipped 'cannot run disagg hook on a test that requires compatibility in the config string'
test_compat03.py: [pid:40893]: None ... [pid:40893]: test_compat03.test_compat03.test_compat03 -s 472 (100_rel.33_max.future_min): starting
test_compat03.py: [pid:40893]: test_compat03.test_compat03.test_compat03 -s 472 (100_rel.33_max.future_min): 1.19 seconds
test_compat03.py: skipped 'cannot run disagg hook on a test that requires compatibility in the config string'
test_compat03.py: [pid:40893]: None ... [pid:40893]: test_compat03.test_compat03.test_compat03 -s 473 (100_rel.33_max.def_min): starting
test_compat03.py: [pid:40893]: test_compat03.test_compat03.test_compat03 -s 473 (100_rel.33_max.def_min): 1.18 seconds
test_compat03.py: skipped 'cannot run disagg hook on a test that requires compatibility in the config string'
test_compat03.py: [pid:40893]: None ... [pid:40893]: test_compat03.test_compat03.test_compat03 -s 474 (100_rel.33_max.100_min): starting
test_compat03.py: [pid:40893]: test_compat03.test_compat03.test_compat03 -s 474 (100_rel.33_max.100_min): 1.17 seconds
test_compat03.py: skipped 'cannot run disagg hook on a test that requires compatibility in the config string'
test_compat03.py: [pid:40893]: None ... [pid:40893]: test_compat03.test_compat03.test_compat03 -s 475 (100_rel.33_max.33_min): starting
test_compat03.py: [pid:40893]: test_compat03.test_compat03.test_compat03 -s 475 (100_rel.33_max.33_min): 1.16 seconds
test_compat03.py: skipped 'canntest_truncate08.py: [pid:71988]: None ... [pid:71988]: test_truncate08.test_truncate08.test_truncate08 -s 0 (column): starting
test_truncate08.py: [pid:71988]:     Creating "table:test_truncate08" with config = "allocation_size=512,leaf_page_max=512,key_format=r,value_format=S"
test_truncate08.py: [pid:71988]: test_truncate08.test_truncate08.test_truncate08 -s 0 (column): 3.31 seconds
test_truncate08.py: skipped 'truncate on disagg tables not yet implemented'
test_truncate08.py: [pid:71988]: None ... [pid:71988]: test_truncate08.test_truncate08.test_truncate08 -s 1 (fix): starting
test_truncate08.py: [pid:71988]:     Creating "table:test_truncate08" with config = "allocation_size=512,leaf_page_max=512,key_format=r,value_format=8t"
test_truncate08.py: [pid:71988]: test_truncate08.test_truncate08.test_truncate08 -s 1 (fix): 2.29 seconds
test_truncate08.py: skipped 'truncate on disagg tables not yet implemented'
test_truncate08.py: [pid:71988]: None ... [pid:71988]: test_truncate08.test_truncate08.test_truncate08 -s 2 (row_integer): starting
test_truncate08.py: [pid:71988]:     Replacing, old config = "\allocation_size=512,leaf_page_max=512,key_format=i,value_format=S"
test_truncate08.py: [pid:71988]:     Replacing, new config = "\allocation_size=512,leaf_page_max=512,key_format=i,value_format=S,block_manager=disagg,type=layered"
test_truncate08.py: [pid:71988]:     Creating "table:test_truncate08" with config = "allocation_size=512,leaf_page_max=512,key_format=i,value_format=S,block_manager=disagg,type=layered"
test_truncate08.py: [pid:71988]: ERROR: stdout.txt unexpected standard output, contains:
test_truncate08.py: "[1753082217:912990][71988:0x7fd38af3ecc0], test_truncate08.test_truncate08.test_truncate08(row_integer), txn-recover: [WT_VERB_RTS][WARNING]: skipped recovery RTS due to disagg
test_truncate08.py: [1753082286:170366][71988:0x7fd367cef700], test_truncate08.test_truncate08.test_truncate08(row_integer), file:test_truncate08.wt_stable, eviction-server: [WT_VERB_EVICTION][WARNING]: Eviction took more than 1 minute (67495723us). Building disk image took 67473669us. History s

      logs

              Assignee:
              [DO NOT USE] Backlog - Storage Engines Team
              Reporter:
              xgen-buildbaron-user
              Votes:
              0 Vote for this issue
              Watchers:
              1 Start watching this issue

                Created:
                Updated: