__step=000148
__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 128 -nprefill 128 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000148.txt
__path_data=data/data000148.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=208643.447551590
binary=./ellen_ext_bst_lf.debra
parsed custom binding: 0-63,128-191,64-127,192-255
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=0.5
DEL_FRAC=0.5
RQ=0
RQSIZE=0
MAXKEY=2000000
PREFILL_THREADS=128
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=128
WORK_THREADS=128
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=0.5 0.5
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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189,190,191


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.038s
prefilling_size=999126 prefilling_elapsed_millis=1s
finished prefilling to size 999153 for expected size 1000000 keysum=999274099758, performing 34628891 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=999153
pref_millis=1102
prefill_elapsed_ms=1114
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=292

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=208644.625213477
REALTIME_END_PERF_FORMAT=208654.625291801

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

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

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

tree_stats_computeWalltime=0.112s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 255 505 992 1886 3446 5961 9838 15511 23216 32759 43955 55716 66999 76762 83445 86439 85485 80926 72828 63055 52540 41815 31740 22835 15828 10519 6408 3745 2034 1092 603 324 171 95 50 24 3 2 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 1 5 18 98 326 931 2084 4165 7806 13673 21563 32194 44433 57236 70079 80451 87393 90044 89024 82601 73570 63265 51890 40645 29842 21137 14630 9071 5456 2976 1581 882 477 247 140 76 45 4 4
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 510 1010 1984 3772 6892 11922 19676 31022 46432 65518 87910 111432 133998 153524 166890 172878 170970 161852 145656 126110 105080 83630 63480 45670 31656 21038 12816 7490 4068 2184 1206 648 342 190 100 48 6 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 1 5 18 98 326 931 2084 4165 7806 13673 21563 32194 44433 57236 70079 80451 87393 90044 89024 82601 73570 63265 51890 40645 29842 21137 14630 9071 5456 2976 1581 882 477 247 140 76 45 4 4
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 1.99609 1.9902 1.98218 1.9506 1.91357 1.86492 1.8252 1.78832 1.74837 1.70553 1.67088 1.63378 1.60125 1.57286 1.54353 1.51794 1.49448 1.47333 1.44997 1.4329 1.41662 1.39793 1.37953 1.35972 1.34657 1.33229 1.30459 1.29221 1.27156 1.26844 1.2761 1.26866 1.26389 1.27778 1.26316 1.24 1.0625 1.33333 1

tree_stats_height=49
tree_stats_numInternals=1000064
tree_stats_numLeaves=1000065
tree_stats_numNodes=2000129
tree_stats_numKeys=1000063

tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=0.999998
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=27.4611

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 20400 40400 79360 150880 275680 476880 787040 1240880 1857280 2620720 3516400 4457280 5359920 6140960 6675600 6915120 6838800 6474080 5826240 5044400 4203200 3345200 2539200 1826800 1266240 841520 512640 299600 162720 87360 48240 25920 13680 7600 4000 1920 240 160
tree_stats_sizeInBytes=80005160

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=4752

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:10637 2:94859 4:501806 8:492675 16:38581 32:430 64:2
    [2^00, 2^01]: 10637
    (2^01, 2^02]: 94859
    (2^02, 2^03]: 501806
    (2^03, 2^04]: 492675
    (2^04, 2^05]: 38581
    (2^05, 2^06]: 430
    (2^06, 2^07]: 2
sum_limbo_reclamation_event_size_total=8843437
count_limbo_reclamation_event_size_by_thread=8908 8894 8898 8884 8898 8894 8900 8900 8906 8898 8890 8890 8898 8894 8908 8904 8902 8896 8900 8888 8896 8908 8896 8910 8898 8902 8898 8900 8902 8892 8904 8906 8908 8890 8906 8896 8904 8904 8898 8900 8906 8900 8892 8888 8894 8900 8894 8902 8904 8900 8894 8896 8906 8900 8886 8900 8898 8896 8900 8902 8900 8890 8906 8898 8906 8904 8892 8896 8902 8904 8902 8894 8894 8908 8896 8896 8902 8894 8898 8884 8908 8890 8892 8896 8904 8888 8892 8904 8906 8890 8900 8900 8892 8900 8900 8906 8898 8892 8892 8896 8896 8898 8894 8898 8894 8906 8894 8904 8896 8896 8896 8904 8886 8900 8904 8888 8900 8898 8902 8904 8896 8894 8896 8908 8900 8902 8900 8898
count_limbo_reclamation_event_size_total=1138990
sum_limbo_reclamation_event_count_total=1141760
first_thread_announced_epoch_by_thread=9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504 9504
sum_num_inserts_by_thread=28021 28070 28053 27995 28138 27808 28131 27873 27801 27896 27780 27520 27682 27453 27607 27750 27492 27512 27922 27959 27806 27941 27846 27775 27852 27222 27151 27397 27654 27337 27185 27890 28240 27847 27847 27584 28278 28051 28041 27851 27813 27547 27575 27328 27737 27826 27981 27602 27373 27902 27558 27680 27414 27435 27266 27456 27516 27448 27005 27857 27549 27667 27448 27822 27448 27651 27539 27425 27384 27310 27387 26807 27282 27634 27629 27549 28011 27910 27647 27704 27771 27524 27370 27306 27378 27224 27194 26996 27580 27848 27390 27460 27583 27611 27658 27284 27619 27598 27633 27481 27591 27301 27847 27678 27771 27754 27670 27728 27743 27531 27675 27521 27238 27349 27350 27204 27794 27860 27450 27768 27717 27420 28042 27514 27562 27231 27462 27971
sum_num_inserts_total=3535630
sum_num_deletes_by_thread=27786 28155 28415 27825 28537 27915 28062 28098 28130 28014 27670 27929 27645 27522 27519 27990 27430 27800 27868 27772 27948 27982 27927 27536 27336 27536 27417 27757 27499 27392 27671 28029 28090 27912 28063 27493 27904 27942 27600 27653 27841 27582 27815 27734 27532 28040 27549 27987 27790 27670 27474 27525 27440 27536 27433 27385 27427 27495 27312 27613 27838 27833 27619 27852 27567 27644 27447 27503 27578 27397 27581 27557 27489 27913 27886 27727 27892 27756 27354 27772 27625 27733 27349 27359 27219 27273 27044 27117 27615 27764 27603 27670 28024 27577 27532 27543 27406 27345 27523 27476 27551 27552 28042 27897 27742 27990 27647 27991 27749 27574 27479 27830 27478 27505 27085 27343 28042 27549 27448 27495 27832 27753 27698 27250 27456 27701 27237 27799
sum_num_deletes_total=3541666
sum_num_searches_by_thread=5523814 5552284 5548164 5519423 5555982 5556754 5550763 5538236 5535929 5507664 5482256 5484738 5490987 5489683 5473774 5484849 5465092 5479295 5496183 5499499 5510564 5511493 5500642 5481387 5480257 5456172 5437797 5443315 5444068 5444597 5434009 5497097 5553605 5541466 5531931 5534531 5544450 5543754 5495388 5476188 5473813 5482799 5462893 5462068 5467638 5542361 5517737 5520250 5490492 5483585 5474904 5471794 5443907 5436102 5407935 5415033 5421390 5424184 5405159 5478855 5480056 5486294 5465016 5465018 5457975 5475775 5436468 5423535 5427588 5433169 5419169 5407774 5407927 5491184 5475796 5470027 5492080 5477981 5459995 5453986 5455755 5455238 5416755 5405923 5429780 5420772 5402027 5387787 5486167 5471449 5447869 5464586 5467170 5459352 5454044 5418265 5469880 5457542 5448242 5431503 5449292 5444191 5515279 5511765 5501029 5524643 5497579 5510271 5515962 5471744 5440710 5450031 5415431 5408942 5393141 5387402 5474833 5477300 5454122 5460639 5473872 5479703 5471080 5447866 5466634 5466011 5458982 5467444
sum_num_searches_total=700373796
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5579621 5608509 5604632 5575243 5612657 5612477 5606956 5594207 5591860 5563574 5537706 5540187 5546314 5544658 5528900 5540589 5520014 5534607 5551973 5555230 5566318 5567416 5556415 5536698 5535445 5510930 5492365 5498469 5499221 5499326 5488865 5553016 5609935 5597225 5587841 5589608 5600632 5599747 5551029 5531692 5529467 5537928 5518283 5517130 5522907 5598227 5573267 5575839 5545655 5539157 5529936 5526999 5498761 5491073 5462634 5469874 5476333 5479127 5459476 5534325 5535443 5541794 5520083 5520692 5512990 5531070 5491454 5478463 5482550 5487876 5474137 5462138 5462698 5546731 5531311 5525303 5547983 5533647 5514996 5509462 5511151 5510495 5471474 5460588 5484377 5475269 5456265 5441900 5541362 5527061 5502862 5519716 5522777 5514540 5509234 5473092 5524905 5512485 5503398 5486460 5504434 5499044 5571168 5567340 5556542 5580387 5552896 5565990 5571454 5526849 5495864 5505382 5470147 5463796 5447576 5441949 5530669 5532709 5509020 5515902 5529421 5534876 5526820 5502630 5521652 5520943 5513681 5523214
average_num_operations_total=5526961
stdev_num_operations_total=3606
sum_num_operations_total=707451092
min_num_operations_total=5441900
max_num_operations_total=5612657
first_time_thread_terminate_by_thread=10000080 10000080 10000080 10000080 10000082 10000082 10000082 10000082 10000080 10000080 10000080 10000080 10000080 10000080 10000080 10000080 10000082 10000082 10000082 10000082 10000079 10000079 10000079 10000079 10000079 10000079 10000078 10000078 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000082 10000082 10000082 10000082 10000082 10000082 10000082 10000083 10000078 10000079 10000078 10000078 10000081 10000081 10000081 10000081 10000079 10000079 10000079 10000079 10000083 10000083 10000083 10000083 10000082 10000082 10000082 10000082 10000080 10000080 10000080 10000080 10000082 10000082 10000082 10000082 10000080 10000080 10000080 10000080 10000080 10000080 10000080 10000080 10000082 10000082 10000082 10000082 10000079 10000079 10000079 10000079 10000079 10000079 10000079 10000078 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000082 10000082 10000082 10000082 10000082 10000082 10000082 10000083 10000078 10000079 10000079 10000078 10000081 10000081 10000081 10000081 10000079 10000079 10000079 10000079 10000083 10000083 10000083 10000083 10000082 10000082 10000082 10000082
min_time_thread_terminate_total=10000078
max_time_thread_terminate_total=10000083
first_time_thread_start_by_thread=5 5 5 5 5 5 5 5 6 6 6 6 5 5 5 5 4 4 4 4 4 4 4 4 4 3 3 3 3 3 3 3 6 6 6 6 7 7 7 7 7 7 6 7 7 7 7 7 7 7 7 7 5 5 5 5 6 6 6 6 4 4 4 4 5 5 5 5 5 5 5 5 6 6 6 6 5 5 5 5 4 4 4 4 4 4 4 4 4 3 3 3 3 3 3 3 6 6 6 6 7 7 7 7 7 7 7 7 7 7 7 7 7 7 7 7 5 5 5 5 6 6 6 6 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=7
sum_duration_all_ops_total=

threads_final_keysum=999796870197
threads_final_size=1000063
final_keysum=999796870197
final_size=1000063
validate_result=success
Validation OK.
Structural validation OK.

total_find=700373796
total_rq=0
total_inserts=3535630
total_deletes=3541666
total_updates=7077296
total_queries=700373796
total_ops=707451092
find_throughput=70037379
rq_throughput=0
update_throughput=707729
query_throughput=70037379
total_throughput=70745109


total find                    : 700373796
total rq                      : 0
total inserts                 : 3535630
total deletes                 : 3541666
total updates                 : 7077296
total queries                 : 700373796
total ops                     : 707451092
find throughput               : 70037379
rq throughput                 : 0
update throughput             : 707729
query throughput              : 70037379
total throughput              : 70745109

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=38324223341896
total_execution_walltime=11.396s
REALTIME_MAIN_END_PERF_FORMAT=208654.844368735
[time_cmd_output] time_elapsed_sec=11.50, faults_major=0, faults_minor=116385, mem_maxresident_kb=462912, user_cputime=1433.07, sys_cputime=13.71, percent_cpu=12573%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2