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

test format hung with 9mb cache

    • Type: Icon: Bug Bug
    • Resolution: Done
    • Priority: Icon: Major - P3 Major - P3
    • WT2.9.2, 3.2.13, 3.4.4, 3.5.6
    • Affects Version/s: None
    • Component/s: None
    • None

      Found test format hung on kodkod. Traces and config below.

      It looks like the cache is able to make progress by evicting a page every so often, but is simply very very slow.

      Thread 14 (Thread 0x7f7783fff700 (LWP 32459)):
      #0  0x00007f77ebd13a82 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
      #1  0x0000000000450127 in __wt_cond_wait_signal (session=0x212f720, cond=0x214a7e0, usecs=100000, run_func=0x0, signalled=0x7f7783ffee9f) at ../src/os_posix/os_mtx_cond.c:87
      #2  0x0000000000419d96 in __wt_cond_wait (session=0x212f720, cond=0x214a7e0, usecs=100000, run_func=0x0) at ../src/include/misc.i:19
      #3  0x000000000041b288 in __log_file_server (arg=0x212f720) at ../src/conn/conn_log.c:521
      #4  0x00007f77ebd0fdc5 in start_thread () from /lib64/libpthread.so.0
      #5  0x00007f77eb40b73d in clone () from /lib64/libc.so.6
      
      Thread 13 (Thread 0x7f77e2ffd700 (LWP 32460)):
      #0  0x00007f77ebd13a82 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
      #1  0x0000000000450127 in __wt_cond_wait_signal (session=0x212fa40, cond=0x2149d30, usecs=1000000, run_func=0x0, signalled=0x7f77e2ffceaf) at ../src/os_posix/os_mtx_cond.c:87
      #2  0x0000000000482e6b in __wt_cond_auto_wait_signal (session=0x212fa40, cond=0x2149d30, progress=false, run_func=0x0, signalled=0x7f77e2ffceaf) at ../src/support/cond_auto.c:62
      #3  0x0000000000482f32 in __wt_cond_auto_wait (session=0x212fa40, cond=0x2149d30, progress=false, run_func=0x0) at ../src/support/cond_auto.c:82
      #4  0x000000000041bab3 in __log_wrlsn_server (arg=0x212fa40) at ../src/conn/conn_log.c:733
      #5  0x00007f77ebd0fdc5 in start_thread () from /lib64/libpthread.so.0
      #6  0x00007f77eb40b73d in clone () from /lib64/libc.so.6
      
      Thread 12 (Thread 0x7f77d6ffd700 (LWP 32461)):
      #0  0x00007f77ebd13a82 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
      #1  0x0000000000450127 in __wt_cond_wait_signal (session=0x212fd60, cond=0x214a880, usecs=1000000, run_func=0x0, signalled=0x7f77d6ffcebe) at ../src/os_posix/os_mtx_cond.c:87
      #2  0x0000000000482e6b in __wt_cond_auto_wait_signal (session=0x212fd60, cond=0x214a880, progress=false, run_func=0x0, signalled=0x7f77d6ffcebe) at ../src/support/cond_auto.c:62
      #3  0x000000000041bcdd in __log_server (arg=0x212fd60) at ../src/conn/conn_log.c:840
      #4  0x00007f77ebd0fdc5 in start_thread () from /lib64/libpthread.so.0
      #5  0x00007f77eb40b73d in clone () from /lib64/libc.so.6
      
      Thread 11 (Thread 0x7f77d77fe700 (LWP 32462)):
      #0  0x00007f77ebd13a82 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
      #1  0x0000000000450127 in __wt_cond_wait_signal (session=0x21303a0, cond=0x23c42d0, usecs=10000, run_func=0x0, signalled=0x7f77d77fde4f) at ../src/os_posix/os_mtx_cond.c:87
      #2  0x000000000042ac16 in __wt_cond_wait (session=0x21303a0, cond=0x23c42d0, usecs=10000, run_func=0x0) at ../src/include/misc.i:19
      #3  0x000000000042d0fa in __evict_lru_pages (session=0x21303a0, is_server=false) at ../src/evict/evict_lru.c:1103
      #4  0x000000000042b5aa in __wt_evict_thread_run (session=0x21303a0, thread=0x23c4380) at ../src/evict/evict_lru.c:335
      #5  0x000000000048f7f7 in __wt_thread_run (arg=0x23c4380) at ../src/support/thread_group.c:25
      #6  0x00007f77ebd0fdc5 in start_thread () from /lib64/libpthread.so.0
      #7  0x00007f77eb40b73d in clone () from /lib64/libc.so.6
      
      Thread 10 (Thread 0x7f77ea8ef700 (LWP 32463)):
      #0  0x00007f77ebd13a82 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
      #1  0x0000000000450127 in __wt_cond_wait_signal (session=0x2130d00, cond=0x23dc020, usecs=10000000, run_func=0x4200b7 <__sweep_server_run_chk>, signalled=0x7f77ea8eeeaf) at ../src/os_posix/os_mtx_cond.c:87
      #2  0x000000000041f83e in __wt_cond_wait (session=0x2130d00, cond=0x23dc020, usecs=10000000, run_func=0x4200b7 <__sweep_server_run_chk>) at ../src/include/misc.i:19
      #3  0x0000000000420134 in __sweep_server (arg=0x2130d00) at ../src/conn/conn_sweep.c:281
      #4  0x00007f77ebd0fdc5 in start_thread () from /lib64/libpthread.so.0
      #5  0x00007f77eb40b73d in clone () from /lib64/libc.so.6
      
      Thread 9 (Thread 0x7f77e27fc700 (LWP 32502)):
      #0  0x00007f77ebd13a82 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
      #1  0x0000000000450127 in __wt_cond_wait_signal (session=0x21306c0, cond=0x23c42d0, usecs=10000, run_func=0x0, signalled=0x7f77e27fbe4f) at ../src/os_posix/os_mtx_cond.c:87
      #2  0x000000000042ac16 in __wt_cond_wait (session=0x21306c0, cond=0x23c42d0, usecs=10000, run_func=0x0) at ../src/include/misc.i:19
      #3  0x000000000042d0fa in __evict_lru_pages (session=0x21306c0, is_server=false) at ../src/evict/evict_lru.c:1103
      #4  0x000000000042b5aa in __wt_evict_thread_run (session=0x21306c0, thread=0x23ca1e0) at ../src/evict/evict_lru.c:335
      #5  0x000000000048f7f7 in __wt_thread_run (arg=0x23ca1e0) at ../src/support/thread_group.c:25
      #6  0x00007f77ebd0fdc5 in start_thread () from /lib64/libpthread.so.0
      #7  0x00007f77eb40b73d in clone () from /lib64/libc.so.6
      
      Thread 8 (Thread 0x7f77e1ffb700 (LWP 32518)):
      #0  0x00007f77ebd13a82 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
      #1  0x0000000000450127 in __wt_cond_wait_signal (session=0x21309e0, cond=0x211bd50, usecs=1000, run_func=0x0, signalled=0x7f77e1ffad7f) at ../src/os_posix/os_mtx_cond.c:87
      #2  0x000000000042ac16 in __wt_cond_wait (session=0x21309e0, cond=0x211bd50, usecs=1000, run_func=0x0) at ../src/include/misc.i:19
      #3  0x000000000042c2e3 in __evict_pass (session=0x21309e0) at ../src/evict/evict_lru.c:731
      #4  0x000000000042b7d4 in __evict_server (session=0x21309e0, did_work=0x7f77e1ffaeaf) at ../src/evict/evict_lru.c:387
      #5  0x000000000042b48a in __wt_evict_thread_run (session=0x21309e0, thread=0x23d0040) at ../src/evict/evict_lru.c:308
      #6  0x000000000048f7f7 in __wt_thread_run (arg=0x23d0040) at ../src/support/thread_group.c:25
      #7  0x00007f77ebd0fdc5 in start_thread () from /lib64/libpthread.so.0
      #8  0x00007f77eb40b73d in clone () from /lib64/libc.so.6
      
      Thread 7 (Thread 0x7f77e37fe700 (LWP 16977)):
      #0  0x00007f77ebd13a82 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
      #1  0x0000000000450127 in __wt_cond_wait_signal (session=0x2131020, cond=0x23c42d0, usecs=10000, run_func=0x0, signalled=0x7f77e37fc92f) at ../src/os_posix/os_mtx_cond.c:87
      #2  0x000000000042ac16 in __wt_cond_wait (session=0x2131020, cond=0x23c42d0, usecs=10000, run_func=0x0) at ../src/include/misc.i:19
      #3  0x000000000042f825 in __wt_cache_eviction_worker (session=0x2131020, busy=true, pct_full=107) at ../src/evict/evict_lru.c:2196
      #4  0x00000000004b7bfc in __wt_cache_eviction_check (session=0x2131020, busy=true, didworkp=0x0) at ../src/include/cache.i:393
      #5  0x00000000004ba63a in __wt_page_in_func (session=0x2131020, ref=0x7f77740f4360, flags=256, file=0x565318 "../src/btree/row_srch.c", line=446) at ../src/btree/bt_read.c:521
      #6  0x00000000004e0f73 in __wt_page_swap_func (session=0x2131020, held=0x4412f40, want=0x7f77740f4360, flags=256, file=0x565318 "../src/btree/row_srch.c", line=446) at ../src/include/btree.i:1442
      #7  0x00000000004e25c1 in __wt_row_search (session=0x2131020, srch_key=0x7f7788033678, leaf=0x0, cbt=0x7f77880335a0, insert=true) at ../src/btree/row_srch.c:445
      #8  0x000000000053759b in __cursor_row_search (session=0x2131020, cbt=0x7f77880335a0, leaf=0x0, insert=true) at ../src/btree/bt_cursor.c:272
      #9  0x0000000000539058 in __wt_btcur_update (cbt=0x7f77880335a0) at ../src/btree/bt_cursor.c:805
      #10 0x00000000004f38f5 in __curfile_update (cursor=0x7f77880335a0) at ../src/cursor/cur_file.c:284
      #11 0x00000000004084fb in row_update (cursor=0x7f77880335a0, key=0x7f77e37fce10, value=0x7f77e37fcde0, keyno=59831) at ../../../test/format/ops.c:1064
      #12 0x00000000004078c3 in ops (arg=0x4795f60) at ../../../test/format/ops.c:677
      #13 0x00007f77ebd0fdc5 in start_thread () from /lib64/libpthread.so.0
      #14 0x00007f77eb40b73d in clone () from /lib64/libc.so.6
      
      Thread 6 (Thread 0x7f77e3fff700 (LWP 16978)):
      ---Type <return> to continue, or q <return> to quit---
      #0  0x00007f77ebd13a82 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
      #1  0x0000000000450127 in __wt_cond_wait_signal (session=0x2131340, cond=0x23c42d0, usecs=10000, run_func=0x0, signalled=0x7f77e3ffda7f) at ../src/os_posix/os_mtx_cond.c:87
      #2  0x000000000042ac16 in __wt_cond_wait (session=0x2131340, cond=0x23c42d0, usecs=10000, run_func=0x0) at ../src/include/misc.i:19
      #3  0x000000000042f825 in __wt_cache_eviction_worker (session=0x2131340, busy=false, pct_full=107) at ../src/evict/evict_lru.c:2196
      #4  0x0000000000535b54 in __wt_cache_eviction_check (session=0x2131340, busy=false, didworkp=0x0) at ../src/include/cache.i:393
      #5  0x0000000000536c93 in __cursor_enter (session=0x2131340) at ../src/include/cursor.i:56
      #6  0x0000000000536d70 in __curfile_enter (cbt=0x7f77740368b0) at ../src/include/cursor.i:90
      #7  0x0000000000536f1e in __cursor_func_init (cbt=0x7f77740368b0, reenter=true) at ../src/include/cursor.i:263
      #8  0x00000000005381f0 in __wt_btcur_insert (cbt=0x7f77740368b0) at ../src/btree/bt_cursor.c:532
      #9  0x00000000004f3139 in __curfile_insert (cursor=0x7f77740368b0) at ../src/cursor/cur_file.c:245
      #10 0x0000000000408994 in row_insert (cursor=0x7f77740368b0, key=0x7f77e3ffde10, value=0x7f77e3ffdde0, keyno=89841) at ../../../test/format/ops.c:1257
      #11 0x00000000004076ee in ops (arg=0x214ade0) at ../../../test/format/ops.c:641
      #12 0x00007f77ebd0fdc5 in start_thread () from /lib64/libpthread.so.0
      #13 0x00007f77eb40b73d in clone () from /lib64/libc.so.6
      
      Thread 5 (Thread 0x7f77e88eb700 (LWP 16979)):
      #0  0x00007f77ebd13a82 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
      #1  0x0000000000450127 in __wt_cond_wait_signal (session=0x2131980, cond=0x23c42d0, usecs=10000, run_func=0x0, signalled=0x7f77e88e9a9f) at ../src/os_posix/os_mtx_cond.c:87
      #2  0x000000000042ac16 in __wt_cond_wait (session=0x2131980, cond=0x23c42d0, usecs=10000, run_func=0x0) at ../src/include/misc.i:19
      #3  0x000000000042f825 in __wt_cache_eviction_worker (session=0x2131980, busy=false, pct_full=107) at ../src/evict/evict_lru.c:2196
      #4  0x0000000000535b54 in __wt_cache_eviction_check (session=0x2131980, busy=false, didworkp=0x0) at ../src/include/cache.i:393
      #5  0x0000000000535eff in __wt_txn_idle_cache_check (session=0x2131980) at ../src/include/txn.i:319
      #6  0x0000000000536eef in __cursor_func_init (cbt=0x7f77ac038400, reenter=true) at ../src/include/cursor.i:260
      #7  0x00000000005381f0 in __wt_btcur_insert (cbt=0x7f77ac038400) at ../src/btree/bt_cursor.c:532
      #8  0x00000000004f3139 in __curfile_insert (cursor=0x7f77ac038400) at ../src/cursor/cur_file.c:245
      #9  0x0000000000408994 in row_insert (cursor=0x7f77ac038400, key=0x7f77e88e9e10, value=0x7f77e88e9de0, keyno=89806) at ../../../test/format/ops.c:1257
      #10 0x00000000004076ee in ops (arg=0x4412b30) at ../../../test/format/ops.c:641
      #11 0x00007f77ebd0fdc5 in start_thread () from /lib64/libpthread.so.0
      #12 0x00007f77eb40b73d in clone () from /lib64/libc.so.6
      
      Thread 4 (Thread 0x7f77e90ec700 (LWP 16980)):
      #0  0x00007f77ebd13a82 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
      #1  0x0000000000450127 in __wt_cond_wait_signal (session=0x2131660, cond=0x23c42d0, usecs=10000, run_func=0x0, signalled=0x7f77e90eaa7f) at ../src/os_posix/os_mtx_cond.c:87
      #2  0x000000000042ac16 in __wt_cond_wait (session=0x2131660, cond=0x23c42d0, usecs=10000, run_func=0x0) at ../src/include/misc.i:19
      #3  0x000000000042f825 in __wt_cache_eviction_worker (session=0x2131660, busy=true, pct_full=107) at ../src/evict/evict_lru.c:2196
      #4  0x0000000000535b54 in __wt_cache_eviction_check (session=0x2131660, busy=true, didworkp=0x0) at ../src/include/cache.i:393
      #5  0x0000000000536c93 in __cursor_enter (session=0x2131660) at ../src/include/cursor.i:56
      #6  0x0000000000536d70 in __curfile_enter (cbt=0x7f775003aa20) at ../src/include/cursor.i:90
      #7  0x0000000000536f1e in __cursor_func_init (cbt=0x7f775003aa20, reenter=true) at ../src/include/cursor.i:263
      #8  0x00000000005381f0 in __wt_btcur_insert (cbt=0x7f775003aa20) at ../src/btree/bt_cursor.c:532
      #9  0x00000000004f3139 in __curfile_insert (cursor=0x7f775003aa20) at ../src/cursor/cur_file.c:245
      #10 0x0000000000408994 in row_insert (cursor=0x7f775003aa20, key=0x7f77e90eae10, value=0x7f77e90eade0, keyno=77784) at ../../../test/format/ops.c:1257
      #11 0x00000000004076ee in ops (arg=0x445b260) at ../../../test/format/ops.c:641
      #12 0x00007f77ebd0fdc5 in start_thread () from /lib64/libpthread.so.0
      #13 0x00007f77eb40b73d in clone () from /lib64/libc.so.6
      
      Thread 3 (Thread 0x7f77ea0ee700 (LWP 16981)):
      #0  0x00007f77ebd13a82 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
      #1  0x0000000000450127 in __wt_cond_wait_signal (session=0x2131fc0, cond=0x23c42d0, usecs=10000, run_func=0x0, signalled=0x7f77ea0eca9f) at ../src/os_posix/os_mtx_cond.c:87
      #2  0x000000000042ac16 in __wt_cond_wait (session=0x2131fc0, cond=0x23c42d0, usecs=10000, run_func=0x0) at ../src/include/misc.i:19
      #3  0x000000000042f825 in __wt_cache_eviction_worker (session=0x2131fc0, busy=false, pct_full=107) at ../src/evict/evict_lru.c:2196
      #4  0x0000000000535b54 in __wt_cache_eviction_check (session=0x2131fc0, busy=false, didworkp=0x0) at ../src/include/cache.i:393
      #5  0x0000000000535eff in __wt_txn_idle_cache_check (session=0x2131fc0) at ../src/include/txn.i:319
      #6  0x0000000000536eef in __cursor_func_init (cbt=0x7f77a4038de0, reenter=true) at ../src/include/cursor.i:260
      #7  0x0000000000538f4e in __wt_btcur_update (cbt=0x7f77a4038de0) at ../src/btree/bt_cursor.c:780
      #8  0x00000000004f38f5 in __curfile_update (cursor=0x7f77a4038de0) at ../src/cursor/cur_file.c:284
      #9  0x00000000004084fb in row_update (cursor=0x7f77a4038de0, key=0x7f77ea0ece10, value=0x7f77ea0ecde0, keyno=57708) at ../../../test/format/ops.c:1064
      #10 0x00000000004078c3 in ops (arg=0x445b2d0) at ../../../test/format/ops.c:677
      #11 0x00007f77ebd0fdc5 in start_thread () from /lib64/libpthread.so.0
      #12 0x00007f77eb40b73d in clone () from /lib64/libc.so.6
      
      Thread 2 (Thread 0x7f77e98ed700 (LWP 16982)):
      #0  0x00007f77ebd13a82 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
      #1  0x0000000000450127 in __wt_cond_wait_signal (session=0x2131ca0, cond=0x23c42d0, usecs=10000, run_func=0x0, signalled=0x7f77e98eb92f) at ../src/os_posix/os_mtx_cond.c:87
      #2  0x000000000042ac16 in __wt_cond_wait (session=0x2131ca0, cond=0x23c42d0, usecs=10000, run_func=0x0) at ../src/include/misc.i:19
      #3  0x000000000042f825 in __wt_cache_eviction_worker (session=0x2131ca0, busy=true, pct_full=107) at ../src/evict/evict_lru.c:2196
      #4  0x00000000004b7bfc in __wt_cache_eviction_check (session=0x2131ca0, busy=true, didworkp=0x0) at ../src/include/cache.i:393
      #5  0x00000000004ba63a in __wt_page_in_func (session=0x2131ca0, ref=0x7f77740f0a20, flags=256, file=0x565318 "../src/btree/row_srch.c", line=446) at ../src/btree/bt_read.c:521
      #6  0x00000000004e0f73 in __wt_page_swap_func (session=0x2131ca0, held=0x4412f40, want=0x7f77740f0a20, flags=256, file=0x565318 "../src/btree/row_srch.c", line=446) at ../src/include/btree.i:1442
      #7  0x00000000004e25c1 in __wt_row_search (session=0x2131ca0, srch_key=0x7f77b0038518, leaf=0x0, cbt=0x7f77b0038440, insert=true) at ../src/btree/row_srch.c:445
      #8  0x000000000053759b in __cursor_row_search (session=0x2131ca0, cbt=0x7f77b0038440, leaf=0x0, insert=true) at ../src/btree/bt_cursor.c:272
      #9  0x0000000000539058 in __wt_btcur_update (cbt=0x7f77b0038440) at ../src/btree/bt_cursor.c:805
      #10 0x00000000004f38f5 in __curfile_update (cursor=0x7f77b0038440) at ../src/cursor/cur_file.c:284
      #11 0x00000000004084fb in row_update (cursor=0x7f77b0038440, key=0x7f77e98ebe10, value=0x7f77e98ebde0, keyno=55103) at ../../../test/format/ops.c:1064
      #12 0x00000000004078c3 in ops (arg=0x44134a0) at ../../../test/format/ops.c:677
      #13 0x00007f77ebd0fdc5 in start_thread () from /lib64/libpthread.so.0
      #14 0x00007f77eb40b73d in clone () from /lib64/libc.so.6
      
      Thread 1 (Thread 0x7f77ec738740 (LWP 26720)):
      #0  0x00007f77eb3d266d in nanosleep () from /lib64/libc.so.6
      #1  0x00007f77eb4032c4 in usleep () from /lib64/libc.so.6
      #2  0x00000000004064c7 in wts_ops (lastrun=0) at ../../../test/format/ops.c:179
      #3  0x0000000000409a77 in main (argc=0, argv=0x7fff72514c40) at ../../../test/format/t.c:209
      (gdb)
      
      $4 = {bytes_dirty_intl = 114217, pages_dirty_intl = 6, bytes_dirty_leaf = 8847976, pages_dirty_leaf = 17, bytes_evict = 2608880456680, pages_evict = 3439128, pages_evicted = 0, bytes_image = 7671485, bytes_inmem = 8963430, pages_inmem = 3439154, bytes_internal = 115454, bytes_read = 94350632416, bytes_written = 14920319476, app_waits = 23553975,
        app_evicts = 993600, server_evicts = 172, worker_evicts = 3401821, evict_max_page_size = 765024, stuck_ts = {tv_sec = 1488822736, tv_nsec = 617486631}, read_gen = 18638119, read_gen_oldest = 19686760, evict_pass_gen = 18638019, evict_cond = 0x211bd50, evict_walk_lock = {{{lock = {__data = {__lock = 0, __count = 0, __owner = 0, __nusers = 0, __kind = 0,
                  __spins = 0, __list = {__prev = 0x0, __next = 0x0}}, __size = '\000' <repeats 39 times>, __align = 0}, name = 0x54d48e "cache walk", stat_count_off = -1, stat_app_usecs_off = -1, stat_int_usecs_off = -1, initialized = 1 '\001'},
            __padding = '\000' <repeats 40 times>, "\216\324T\000\000\000\000\000\377\377\377\377\377\377\001\000\000\000\000\000\000\000\000"}}, eviction_dirty_target = 5, eviction_dirty_trigger = 95, eviction_trigger = 95, eviction_target = 80, eviction_checkpoint_target = 5, eviction_scrub_limit = 0, overhead_pct = 8, pass_intr = 0, evict_pass_lock = {{{lock = {
                __data = {__lock = 1, __count = 0, __owner = 32518, __nusers = 1, __kind = 0, __spins = 0, __list = {__prev = 0x0, __next = 0x0}}, __size = "\001\000\000\000\000\000\000\000\006\177\000\000\001", '\000' <repeats 26 times>, __align = 1}, name = 0x54d46e "evict pass", stat_count_off = -1, stat_app_usecs_off = -1, stat_int_usecs_off = -1,
              initialized = 1 '\001'}, __padding = "\001\000\000\000\000\000\000\000\006\177\000\000\001", '\000' <repeats 27 times>, "n\324T\000\000\000\000\000\377\377\377\377\377\377\001\000\000\000\000\000\000\000\000"}}, walk_session = 0x212f400, evict_file_next = 0x0, evict_queue_lock = {{{lock = {__data = {__lock = 0, __count = 0, __owner = 0, __nusers = 0,
                  __kind = 0, __spins = 0, __list = {__prev = 0x0, __next = 0x0}}, __size = '\000' <repeats 39 times>, __align = 0}, name = 0x54d479 "cache eviction queue", stat_count_off = -1, stat_app_usecs_off = -1, stat_int_usecs_off = -1, initialized = 1 '\001'},
            __padding = '\000' <repeats 40 times>, "y\324T\000\000\000\000\000\377\377\377\377\377\377\001\000\000\000\000\000\000\000\000"}}, evict_queues = {{evict_lock = {{{lock = {__data = {__lock = 0, __count = 0, __owner = 0, __nusers = 0, __kind = 0, __spins = 0, __list = {__prev = 0x0, __next = 0x0}}, __size = '\000' <repeats 39 times>, __align = 0},
                  name = 0x54d4cc "cache eviction", stat_count_off = -1, stat_app_usecs_off = -1, stat_int_usecs_off = -1, initialized = 1 '\001'}, __padding = '\000' <repeats 40 times>, "\314\324T\000\000\000\000\000\377\377\377\377\377\377\001\000\000\000\000\000\000\000\000"}}, evict_queue = 0x2125e00, evict_current = 0x0, evict_candidates = 1, evict_entries = 1,
            evict_max = 400}, {evict_lock = {{{lock = {__data = {__lock = 0, __count = 0, __owner = 0, __nusers = 0, __kind = 0, __spins = 0, __list = {__prev = 0x0, __next = 0x0}}, __size = '\000' <repeats 39 times>, __align = 0}, name = 0x54d4cc "cache eviction", stat_count_off = -1, stat_app_usecs_off = -1, stat_int_usecs_off = -1, initialized = 1 '\001'},
                __padding = '\000' <repeats 40 times>, "\314\324T\000\000\000\000\000\377\377\377\377\377\377\001\000\000\000\000\000\000\000\000"}}, evict_queue = 0x2128390, evict_current = 0x0, evict_candidates = 0, evict_entries = 0, evict_max = 400}, {evict_lock = {{{lock = {__data = {__lock = 0, __count = 0, __owner = 0, __nusers = 0, __kind = 0, __spins = 0,
                      __list = {__prev = 0x0, __next = 0x0}}, __size = '\000' <repeats 39 times>, __align = 0}, name = 0x54d4cc "cache eviction", stat_count_off = -1, stat_app_usecs_off = -1, stat_int_usecs_off = -1, initialized = 1 '\001'},
                __padding = '\000' <repeats 40 times>, "\314\324T\000\000\000\000\000\377\377\377\377\377\377\001\000\000\000\000\000\000\000\000"}}, evict_queue = 0x212a920, evict_current = 0x0, evict_candidates = 1, evict_entries = 0, evict_max = 1}}, evict_current_queue = 0x211bba8, evict_fill_queue = 0x211bc08, evict_other_queue = 0x211bc08,
        evict_urgent_queue = 0x211bc68, evict_slots = 400, evict_aggressive_score = 2, evict_empty_score = 100, cp_pass_pressure = 0, cp_quota = 0, cp_reserved = 0, cp_session = 0x0, cp_skip_count = 0, cp_tid = 0, cp_saved_app_evicts = 0, cp_saved_app_waits = 0, cp_saved_read = 0, flags = 15}
      
      186 #define WT_CACHE_EVICT_CLEAN      0x001 /* Evict clean pages */
      187 #define WT_CACHE_EVICT_CLEAN_HARD 0x002 /* Clean % blocking app threads */
      188 #define WT_CACHE_EVICT_DIRTY      0x004 /* Evict dirty pages */
      189 #define WT_CACHE_EVICT_DIRTY_HARD 0x008 /* Dirty % blocking app threads */
      
      ############################################
      #  RUN PARAMETERS
      ############################################
      abort=0
      alter=0
      auto_throttle=0
      backups=0
      bitcnt=7
      bloom=1
      bloom_bit_count=60
      bloom_hash_count=24
      bloom_oldest=0
      cache=9
      checkpoints=1
      checksum=uncompressed
      chunk_size=1
      compaction=0
      compression=lz4
      data_extend=0
      data_source=file
      delete_pct=4
      dictionary=0
      direct_io=0
      encryption=none
      evict_max=3
      file_type=row-store
      firstfit=0
      huffman_key=0
      huffman_value=0
      in_memory=0
      insert_pct=52
      internal_key_truncation=1
      internal_page_max=12
      isolation=read-committed
      key_gap=4
      key_max=89
      key_min=14
      leaf_page_max=16
      leak_memory=0
      logging=1
      logging_archive=1
      logging_compression=snappy
      logging_prealloc=0
      long_running_txn=0
      lsm_worker_threads=4
      merge_max=9
      mmap=1
      ops=100000
      prefix_compression=1
      prefix_compression_min=8
      quiet=1
      read_pct=18
      rebalance=1
      repeat_data_pct=12
      reverse=0
      rows=100000
      runs=100
      salvage=1
      split_pct=60
      statistics=0
      statistics_server=0
      threads=6
      timer=20
      transaction-frequency=39
      value_max=3029
      value_min=17
      verify=1
      wiredtiger_config=
      write_pct=26
      ############################################
      
      0x21306c0:=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=
      0x21306c0:cache dump
      0x21306c0:file:wt(<live>):
      0x21306c0:internal: 7 pages, 0MB, 1/6 clean/dirty pages, 0/0 clean/dirty MB, 0MB max page, 0MB max dirty page
      0x21306c0:leaf: 16 pages, 7MB, 0/16 clean/dirty pages, 0/7 clean/dirty MB, 0MB max page, 0MB max dirty page
      0x21306c0:file:WiredTigerLAS.wt(<live>):
      0x21306c0:internal: 1 pages, 0MB, 1/0 clean/dirty pages, 0/0 clean/dirty MB, 0MB max page, 0MB max dirty page
      0x21306c0:file:WiredTiger.wt(<live>):
      0x21306c0:internal: 1 pages, 0MB, 1/0 clean/dirty pages, 0/0 clean/dirty MB, 0MB max page, 0MB max dirty page
      0x21306c0:cache dump: total found: 8MB vs tracked inuse 9MB
      0x21306c0:total dirty bytes: 7MB
      0x21306c0:=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=
      

            Assignee:
            backlog-server-execution [DO NOT USE] Backlog - Storage Execution Team
            Reporter:
            david.hows David Hows
            Votes:
            0 Vote for this issue
            Watchers:
            2 Start watching this issue

              Created:
              Updated:
              Resolved: