__step=000710
__cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 60 numactl -i all /usr/bin/time -f "[time_cmd_output] time_elapsed_sec=%e, faults_major=%F, faults_minor=%R, mem_maxresident_kb=%M, user_cputime=%U, sys_cputime=%S, percent_cpu=%P" ./ellen_ext_bst_lf.debra -nwork 144 -nprefill 144 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000710.txt
__path_data=data/data000710.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6987447.6718046
binary=./ellen_ext_bst_lf.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=ellen_ext_bst_lf
FIND_FUNC=FIND_FUNC
INSERT_FUNC=insertIfAbsent
ERASE_FUNC=ERASE_FUNC
RQ_FUNC=RQ_FUNC
RECLAIM=reclaimer_debra
ALLOC=allocator_new
POOL=pool_none
MAX_THREADS_POW2=512
CPU_FREQ_GHZ=2.1
MILLIS_TO_RUN=10000
INS_FRAC=50
DEL_FRAC=50
RQ=0
RQSIZE=0
MAXKEY=20000000
PREFILL_THREADS=144
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=144
WORK_THREADS=144
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=50.0 50.0
PREFILL_TYPE=PREFILL_HYBRID
PREFILL_HYBRID_MIN_MS=1000
PREFILL_HYBRID_MAX_MS=5000
sizes: node=40 descriptor=64
ACTUAL_THREAD_BINDINGS=0,1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,64,65,66,67,68,69,70,71,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.014s
prefilling_size=7591939 prefilling_elapsed_millis=1.001s
prefilling_size=7913773 prefilling_elapsed_millis=1.101s
prefilling_size=8184610 prefilling_elapsed_millis=1.201s
prefilling_size=8413079 prefilling_elapsed_millis=1.302s
prefilling_size=8623104 prefilling_elapsed_millis=1.402s
prefilling_size=8795085 prefilling_elapsed_millis=1.502s
prefilling_size=8953569 prefilling_elapsed_millis=1.602s
prefilling_size=9081171 prefilling_elapsed_millis=1.702s
prefilling_size=9202096 prefilling_elapsed_millis=1.803s
prefilling_size=9300057 prefilling_elapsed_millis=1.903s
prefilling_size=9386805 prefilling_elapsed_millis=2.003s
prefilling_size=9459644 prefilling_elapsed_millis=2.103s
prefilling_size=9531447 prefilling_elapsed_millis=2.203s
prefilling_size=9588981 prefilling_elapsed_millis=2.304s
prefilling_size=9640237 prefilling_elapsed_millis=2.404s
prefilling_size=9684165 prefilling_elapsed_millis=2.504s
prefilling_size=9722463 prefilling_elapsed_millis=2.604s
prefilling_size=9758510 prefilling_elapsed_millis=2.704s
prefilling_size=9787711 prefilling_elapsed_millis=2.805s
prefilling_size=9813741 prefilling_elapsed_millis=2.905s
finished prefilling to size 9813749 for expected size 10000000 keysum=98120751052753, performing 80640409 updates; total_prefilling_elapsed_ms=3007 ms)
pref_size=9813749
pref_millis=3007
prefill_elapsed_ms=3029
6node_tIxPvE_object_size=40
6node_tIxPvE_allocated_count=0
6node_tIxPvE_allocated_size=0MB
6node_tIxPvE_get_from_pool=0
6node_tIxPvE_deallocated=0
6node_tIxPvE_limbo_count=0
6node_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=634

6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=0

main thread: starting timer...

###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################

REALTIME_START_PERF_FORMAT=6987450.273877940
REALTIME_END_PERF_FORMAT=6987460.274018832

###############################################################################
################################## TIME IS UP #################################
###############################################################################

joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################

10.1s
PRODUCING OUTPUT
computing tree_stats in PARALLEL...
bounded depth BFS to partition into subtrees for parallel computation (192 threads)...
partitioned into 1024 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.299s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 256 512 1012 1979 3780 6900 12288 21148 35069 55982 85423 125144 175591 237621 308240 384736 461643 533386 596127 641164 667794 674905 664390 638760 598829 548982 492271 428966 365749 303687 245148 191584 145388 107545 77509 54631 37972 25588 16844 10768 6781 4216 2514 1421 765 405 203 87 38 15 3 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 0 0 12 45 178 660 1512 3428 7227 14156 26541 45702 74697 113561 167002 231744 307829 389900 470645 551090 614534 660683 685420 690020 678691 648676 605693 555576 492183 427811 362226 298712 237780 183231 137581 100387 71290 50356 34332 22920 14755 9346 5918 3607 2077 1125 607 319 136 61 27 6
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 512 1024 2024 3958 7560 13800 24576 42296 70138 111964 170846 250288 351182 475242 616480 769472 923286 1066772 1192254 1282328 1335588 1349810 1328780 1277520 1197658 1097964 984542 857932 731498 607374 490296 383168 290776 215090 155018 109262 75944 51176 33688 21536 13562 8432 5028 2842 1530 810 406 174 76 30 6
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 12 45 178 660 1512 3428 7227 14156 26541 45702 74697 113561 167002 231744 307829 389900 470645 551090 614534 660683 685420 690020 678691 648676 605693 555576 492183 427811 362226 298712 237780 183231 137581 100387 71290 50356 34332 22920 14755 9346 5918 3607 2077 1125 607 319 136 61 27 6
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 2 2 1.98828 1.97777 1.95503 1.9127 1.89043 1.86051 1.82913 1.79817 1.76295 1.7325 1.70156 1.67663 1.6486 1.62409 1.59995 1.5777 1.55881 1.53777 1.52077 1.50532 1.49221 1.48071 1.46874 1.45838 1.44835 1.4357 1.42631 1.41516 1.40362 1.39075 1.37944 1.36986 1.36036 1.35242 1.34753 1.33693 1.32914 1.31964 1.31487 1.31087 1.29815 1.28262 1.26918 1.26471 1.25062 1.21429 1.21839 1.19737 1.1 1

tree_stats_height=62
tree_stats_numInternals=10002016
tree_stats_numLeaves=10002017
tree_stats_numNodes=20004033
tree_stats_numKeys=10002015

tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=33.6357

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 20480 40960 80960 158320 302400 552000 983040 1691840 2805520 4478560 6833840 10011520 14047280 19009680 24659200 30778880 36931440 42670880 47690160 51293120 53423520 53992400 53151200 51100800 47906320 43918560 39381680 34317280 29259920 24294960 19611840 15326720 11631040 8603600 6200720 4370480 3037760 2047040 1347520 861440 542480 337280 201120 113680 61200 32400 16240 6960 3040 1200 240
tree_stats_sizeInBytes=800161320

6node_tIxPvE_object_size=40
6node_tIxPvE_allocated_count=0
6node_tIxPvE_allocated_size=0MB
6node_tIxPvE_get_from_pool=0
6node_tIxPvE_deallocated=0
6node_tIxPvE_limbo_count=0
6node_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=2839

6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=0


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:431 2:159 4:71 8:209 16:616 32:2169 64:11435 128:65110 256:237430 512:299896 1024:16362
    [2^00, 2^01]: 431
    (2^01, 2^02]: 159
    (2^02, 2^03]: 71
    (2^03, 2^04]: 209
    (2^04, 2^05]: 616
    (2^05, 2^06]: 2169
    (2^06, 2^07]: 11435
    (2^07, 2^08]: 65110
    (2^08, 2^09]: 237430
    (2^09, 2^10]: 299896
    (2^10, 2^11]: 16362
sum_limbo_reclamation_event_size_total=336148550
count_limbo_reclamation_event_size_by_thread=4402 4402 4402 4404 4406 4400 4398 4398 4402 4402 4404 4402 4402 4406 4406 4404 4406 4402 4404 4402 4404 4404 4404 4400 4402 4400 4404 4404 4406 4402 4406 4398 4402 4394 4402 4406 4404 4404 4406 4400 4406 4402 4406 4404 4392 4404 4404 4402 4402 4402 4406 4402 4406 4406 4396 4398 4404 4400 4394 4404 4396 4406 4406 4402 4398 4404 4402 4398 4398 4404 4400 4404 4396 4402 4402 4402 4406 4398 4404 4398 4398 4402 4404 4402 4400 4400 4400 4402 4406 4398 4400 4402 4402 4404 4402 4396 4404 4404 4404 4402 4398 4402 4402 4404 4400 4394 4398 4402 4406 4400 4400 4400 4402 4402 4400 4400 4402 4402 4402 4400 4402 4406 4404 4400 4406 4398 4400 4402 4402 4402 4400 4406 4400 4402 4402 4402 4406 4406 4404 4404 4404 4404 4400 4406
count_limbo_reclamation_event_size_total=633888
sum_limbo_reclamation_event_count_total=635040
first_thread_announced_epoch_by_thread=5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678 5678
sum_num_inserts_by_thread=924581 929914 939339 931630 933588 927014 926964 929587 938692 932109 927522 928543 926869 935163 937771 939519 927105 928172 928572 927159 936273 938128 926820 927236 930649 935213 941772 934143 935419 925485 930926 936505 937033 938612 934779 929882 932125 937998 934744 941682 932123 929054 927195 926108 933124 935957 925882 925923 927214 937210 940024 945168 935963 932371 931791 935486 945538 942560 934715 934826 940594 943275 943173 943554 934993 933665 932994 935158 942151 942138 940946 931396 931150 940082 940511 944186 937705 937919 934384 937673 947298 944520 943939 930709 934882 943296 940673 949700 936428 928597 928553 932683 947705 942187 939991 931660 927081 932370 936069 936907 933606 931009 935895 934294 935229 942294 931520 927142 934533 940235 943522 939299 933087 925036 929734 930848 932902 941099 936326 926792 929619 932493 941490 934758 937075 926373 933826 942483 939472 942107 932873 932762 931983 939724 941714 939745 936522 930344 932480 929512 938121 940268 933925 930554
sum_num_inserts_total=134640989
sum_num_deletes_by_thread=924472 931053 937136 931539 935499 927480 927204 929405 936991 932066 930714 928408 927827 934194 937942 938964 926758 928444 927589 927908 936710 940488 925802 926870 930943 934134 940157 933757 934255 924550 930992 936300 938259 938216 934298 929655 933061 939166 936564 938661 933354 929121 925238 925540 933900 936815 924779 927876 930641 938916 938678 945110 935024 933029 931115 935255 944174 943539 937818 935526 940494 941274 940096 940609 934196 934430 933189 934450 942051 938401 941730 931611 930596 937408 939149 945578 938230 939145 932038 937862 944671 943728 940379 932191 935056 944614 939997 952465 937624 931124 930779 932481 948655 942678 939140 931788 929377 932217 936415 937542 934718 929826 934628 935374 934546 940715 932514 929845 935646 939001 945715 940731 933582 924381 930270 928249 933044 939705 936975 926985 929399 937356 941155 935793 940488 928872 935785 944841 941895 942902 933404 931418 932582 941311 941537 940063 936470 927883 934134 929484 938615 940662 933149 929541
sum_num_deletes_total=134660526
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=1849053 1860967 1876475 1863169 1869087 1854494 1854168 1858992 1875683 1864175 1858236 1856951 1854696 1869357 1875713 1878483 1853863 1856616 1856161 1855067 1872983 1878616 1852622 1854106 1861592 1869347 1881929 1867900 1869674 1850035 1861918 1872805 1875292 1876828 1869077 1859537 1865186 1877164 1871308 1880343 1865477 1858175 1852433 1851648 1867024 1872772 1850661 1853799 1857855 1876126 1878702 1890278 1870987 1865400 1862906 1870741 1889712 1886099 1872533 1870352 1881088 1884549 1883269 1884163 1869189 1868095 1866183 1869608 1884202 1880539 1882676 1863007 1861746 1877490 1879660 1889764 1875935 1877064 1866422 1875535 1891969 1888248 1884318 1862900 1869938 1887910 1880670 1902165 1874052 1859721 1859332 1865164 1896360 1884865 1879131 1863448 1856458 1864587 1872484 1874449 1868324 1860835 1870523 1869668 1869775 1883009 1864034 1856987 1870179 1879236 1889237 1880030 1866669 1849417 1860004 1859097 1865946 1880804 1873301 1853777 1859018 1869849 1882645 1870551 1877563 1855245 1869611 1887324 1881367 1885009 1866277 1864180 1864565 1881035 1883251 1879808 1872992 1858227 1866614 1858996 1876736 1880930 1867074 1860095
average_num_operations_total=1870149
stdev_num_operations_total=930
sum_num_operations_total=269301515
min_num_operations_total=1849053
max_num_operations_total=1902165
first_time_thread_terminate_by_thread=10000142 10000141 10000142 10000142 10000140 10000144 10000141 10000147 10000145 10000141 10000147 10000142 10000144 10000148 10000144 10000144 10000142 10000147 10000142 10000142 10000141 10000141 10000144 10000142 10000141 10000141 10000142 10000142 10000140 10000146 10000141 10000146 10000144 10000142 10000147 10000141 10000146 10000147 10000144 10000147 10000145 10000141 10000142 10000141 10000141 10000141 10000146 10000141 10000164 10000140 10000140 10000146 10000143 10000139 10000168 10000146 10000147 10000143 10000141 10000140 10000140 10000146 10000140 10000146 10000146 10000143 10000146 10000145 10000152 10000143 10000146 10000140 10000145 10000143 10000140 10000146 10000143 10000139 10000140 10000146 10000140 10000146 10000141 10000141 10000143 10000146 10000145 10000146 10000147 10000143 10000145 10000140 10000143 10000145 10000146 10000144 10000146 10000144 10000141 10000142 10000143 10000141 10000161 10000140 10000142 10000142 10000140 10000143 10000139 10000142 10000139 10000140 10000140 10000140 10000142 10000141 10000140 10000143 10000143 10000140 10000146 10000144 10000140 10000139 10000140 10000140 10000144 10000142 10000186 10000142 10000140 10000139 10000140 10000143 10000140 10000140 10000140 10000140 10000143 10000141 10000143 10000145 10000142 10000140
min_time_thread_terminate_total=10000139
max_time_thread_terminate_total=10000186
first_time_thread_start_by_thread=4 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 3 3 4 4 4 3 4 4 4 4 4 4 4 4 3 3 4 4 4 4 4 4 4 4 3 3 4 4 4 3 4 4 4 4 4 4 4 4 3 3 4 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=100037089512959
threads_final_size=10002015
final_keysum=100037089512959
final_size=10002015
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=134640989
total_deletes=134660526
total_updates=269301515
total_queries=0
total_ops=269301515
find_throughput=0
rq_throughput=0
update_throughput=26930151
query_throughput=0
total_throughput=26930151


total find                    : 0
total rq                      : 0
total inserts                 : 134640989
total deletes                 : 134660526
total updates                 : 269301515
total queries                 : 0
total ops                     : 269301515
find throughput               : 0
rq throughput                 : 0
update throughput             : 26930151
query throughput              : 0
total throughput              : 26930151

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=61.9414
PAPI_L3_TCM=27.7797
PAPI_TOT_CYC=14259.4
PAPI_TOT_INS=1420.79
garbage=0
total_execution_walltime=13.758s
REALTIME_MAIN_END_PERF_FORMAT=6987460.766152011
[time_cmd_output] time_elapsed_sec=13.95, faults_major=0, faults_minor=349104, mem_maxresident_kb=1335804, user_cputime=1816.28, sys_cputime=25.97, percent_cpu=13200%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2