__step=000049
__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" ./natarajan_ext_bst_lf.debra -nwork 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000049.txt
__path_data=data/data000049.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=207410.88709097
binary=./natarajan_ext_bst_lf.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=natarajan_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=20000000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
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=32
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


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.02s
prefilling_size=7753857 prefilling_elapsed_millis=1s
prefilling_size=8003143 prefilling_elapsed_millis=1.101s
prefilling_size=8221597 prefilling_elapsed_millis=1.201s
prefilling_size=8412482 prefilling_elapsed_millis=1.301s
prefilling_size=8580377 prefilling_elapsed_millis=1.401s
prefilling_size=8730157 prefilling_elapsed_millis=1.502s
prefilling_size=8861834 prefilling_elapsed_millis=1.602s
prefilling_size=8979223 prefilling_elapsed_millis=1.702s
prefilling_size=9084290 prefilling_elapsed_millis=1.802s
prefilling_size=9176160 prefilling_elapsed_millis=1.902s
prefilling_size=9260240 prefilling_elapsed_millis=2.003s
prefilling_size=9335791 prefilling_elapsed_millis=2.103s
prefilling_size=9400655 prefilling_elapsed_millis=2.203s
prefilling_size=9461468 prefilling_elapsed_millis=2.303s
prefilling_size=9514425 prefilling_elapsed_millis=2.404s
prefilling_size=9561679 prefilling_elapsed_millis=2.504s
prefilling_size=9605702 prefilling_elapsed_millis=2.604s
prefilling_size=9646216 prefilling_elapsed_millis=2.704s
prefilling_size=9682356 prefilling_elapsed_millis=2.804s
prefilling_size=9714284 prefilling_elapsed_millis=2.905s
prefilling_size=9740477 prefilling_elapsed_millis=3.006s
prefilling_size=9766541 prefilling_elapsed_millis=3.106s
prefilling_size=9789808 prefilling_elapsed_millis=3.206s
prefilling_size=9809015 prefilling_elapsed_millis=3.306s
finished prefilling to size 9809036 for expected size 10000000 keysum=98101273429162, performing 79580655 updates; total_prefilling_elapsed_ms=3407 ms)
pref_size=9809036
pref_millis=3407
prefill_elapsed_ms=3419
6node_tIxPvE_object_size=32
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=2111

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=207413.548775264
REALTIME_END_PERF_FORMAT=207423.548837987

###############################################################################
################################## 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 2000 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.141s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 509 1000 1929 3665 6804 12297 21559 36154 58128 89833 133828 190518 260775 342676 432215 522651 606415 675388 723609 747134 743464 713947 660356 589697 509652 424811 342934 270097 206917 154113 112009 79384 55386 37229 24355 15591 9724 5796 3343 1953 1049 568 295 151 75 37 21 20 19 10 5 2 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 3 18 71 193 526 1311 3035 6964 14180 26423 45838 77138 120261 178874 253137 341779 438887 537442 627167 700084 750804 772981 767538 731015 669742 594493 506688 415771 333277 259721 196217 144634 103382 73543 50103 33119 21458 13652 8249 4733 2857 1530 841 439 227 113 53 22 21 28 15 8 2 4
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1018 2000 3858 7330 13608 24594 43118 72308 116256 179666 267656 381036 521550 685352 864430 1045302 1212830 1350776 1447218 1494268 1486928 1427894 1320712 1179394 1019304 849622 685868 540194 413834 308226 224018 158768 110772 74458 48710 31182 19448 11592 6686 3906 2098 1136 590 302 150 74 42 40 38 20 10 4 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 3 18 71 193 526 1311 3035 6964 14180 26423 45838 77138 120261 178874 253137 341779 438887 537442 627167 700084 750804 772981 767538 731015 669742 594493 506688 415771 333277 259721 196217 144634 103382 73543 50103 33119 21458 13652 8249 4733 2857 1530 841 439 227 113 53 22 21 28 15 8 2 4
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 1.99414 1.98232 1.9645 1.94997 1.92824 1.90366 1.8766 1.83849 1.80389 1.77272 1.74487 1.7118 1.68438 1.65703 1.63065 1.60462 1.58013 1.55687 1.5357 1.51626 1.49754 1.48015 1.46247 1.4465 1.43213 1.41677 1.40363 1.3938 1.38304 1.3724 1.3634 1.35436 1.34885 1.33609 1.3271 1.32008 1.31185 1.29803 1.28839 1.2921 1.26856 1.27073 1.25968 1.25593 1.24834 1.24667 1.28378 1.47619 1.475 1.26316 1.25 1.2 1.5 1

tree_stats_height=63
tree_stats_numInternals=9830610
tree_stats_numLeaves=9830611
tree_stats_numNodes=19661221
tree_stats_numKeys=9830611

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

tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8192 16384 32576 64000 123456 234560 435456 787008 1379776 2313856 3720192 5749312 8564992 12193152 16689600 21931264 27661760 33449664 38810560 43224832 46310976 47816576 47581696 45692608 42262784 37740608 32617728 27187904 21947776 17286208 13242688 9863232 7168576 5080576 3544704 2382656 1558720 997824 622336 370944 213952 124992 67136 36352 18880 9664 4800 2368 1344 1280 1216 640 320 128 128
tree_stats_sizeInBytes=629159072

6node_tIxPvE_object_size=32
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=8611


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:138291 4:158135 8:27908 16:147
    (2^01, 2^02]: 138291
    (2^02, 2^03]: 158135
    (2^03, 2^04]: 27908
    (2^04, 2^05]: 147
sum_limbo_reclamation_event_size_total=1261692
count_limbo_reclamation_event_size_by_thread=5095 5101 5090 5103 5096 5082 5008 5033 5071 5023 5074 5036 5023 5089 5098 5018 5043 5064 5061 5075 5058 5140 5084 5016 5027 5057 5128 5055 5062 5044 5125 5040 5128 5084 5041 5090 5092 5074 5026 5031 5028 5023 5135 5108 5048 5114 5108 5058 5086 5047 5008 5055 5030 5049 5093 5125 5033 5053 5064 5132 5107 5082 5092 5118
count_limbo_reclamation_event_size_total=324481
sum_limbo_reclamation_event_count_total=416000
first_thread_announced_epoch_by_thread=17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222 17222
sum_num_inserts_by_thread=20375 20029 20247 19979 20083 20132 20281 20146 20159 19875 19791 19966 20210 19749 19922 20186 20247 19878 20090 19909 19985 19823 20084 19836 19832 19863 19777 19823 20257 20368 19809 20386 20409 20164 20054 19933 19990 20183 19783 20008 20437 20241 20183 19949 20109 20100 20265 19923 20086 20253 19760 19845 20034 19851 20082 20184 20123 20264 20332 19968 20086 20179 20175 20225
sum_num_inserts_total=1284275
sum_num_deletes_by_thread=20223 20091 20281 20038 20136 20076 19948 20187 20165 19938 19982 20013 19921 20209 20360 20184 20133 20411 20126 20037 19768 20395 19892 19925 19798 19826 20118 20040 20039 19987 20038 20264 20363 20230 20088 20112 20011 19837 19974 19692 20085 19766 20171 20096 20165 20281 20110 20241 20202 19926 19524 20165 19853 20097 20241 20184 20306 20213 20115 20080 20165 20193 20225 20202
sum_num_deletes_total=1285462
sum_num_searches_by_thread=4009285 4012452 4001734 3983368 4001458 3995334 3976218 3968079 3967444 3957714 3945760 3936674 3987264 3981155 3969102 3971485 3999157 3993357 3984378 3968286 3967296 3959827 3953753 3949219 3948983 3943059 3983026 3980859 3979895 3980792 3974554 3974310 4005555 3990593 3970918 3956531 3973767 3963873 3957881 3949741 4011665 4000067 3984438 3980580 3998302 3998757 3979957 3973888 3958338 3949977 3939924 3927333 3937412 3940770 3980612 3977156 3985847 3988351 3974728 3967891 3980639 3981780 3962942 3961572
sum_num_searches_total=254317062
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4049883 4052572 4042262 4023385 4041677 4035542 4016447 4008412 4007768 3997527 3985533 3976653 4027395 4021113 4009384 4011855 4039537 4033646 4024594 4008232 4007049 4000045 3993729 3988980 3988613 3982748 4022921 4020722 4020191 4021147 4014401 4014960 4046327 4030987 4011060 3996576 4013768 4003893 3997638 3989441 4052187 4040074 4024792 4020625 4038576 4039138 4020332 4014052 3998626 3990156 3979208 3967343 3977299 3980718 4020935 4017524 4026276 4028828 4015175 4007939 4020890 4022152 4003342 4001999
average_num_operations_total=4013856
stdev_num_operations_total=2543
sum_num_operations_total=256886799
min_num_operations_total=3967343
max_num_operations_total=4052572
first_time_thread_terminate_by_thread=10000065 10000065 10000065 10000065 10000065 10000065 10000065 10000065 10000064 10000064 10000064 10000064 10000066 10000066 10000066 10000066 10000064 10000064 10000064 10000063 10000064 10000064 10000064 10000064 10000063 10000063 10000063 10000063 10000065 10000065 10000065 10000065 10000066 10000066 10000066 10000066 10000062 10000062 10000062 10000062 10000064 10000064 10000064 10000065 10000065 10000065 10000065 10000065 10000062 10000062 10000063 10000063 10000064 10000064 10000062 10000064 10000066 10000066 10000066 10000066 10000063 10000063 10000063 10000063
min_time_thread_terminate_total=10000062
max_time_thread_terminate_total=10000066
first_time_thread_start_by_thread=8 8 8 8 5 5 5 5 7 7 7 7 6 6 6 6 8 8 8 8 9 9 9 9 8 8 8 8 9 10 9 10 9 9 9 9 4 4 4 4 8 8 8 8 7 7 7 7 9 9 9 9 7 7 7 7 7 7 7 7 6 6 6 6
min_time_thread_start_total=4
max_time_thread_start_total=10
sum_duration_all_ops_total=

threads_final_keysum=98315998725377
threads_final_size=9830611
final_keysum=98315998725377
final_size=9830611
validate_result=success
Validation OK.
Structural validation OK.

total_find=254317062
total_rq=0
total_inserts=1284275
total_deletes=1285462
total_updates=2569737
total_queries=254317062
total_ops=256886799
find_throughput=25431706
rq_throughput=0
update_throughput=256973
query_throughput=25431706
total_throughput=25688679


total find                    : 254317062
total rq                      : 0
total inserts                 : 1284275
total deletes                 : 1285462
total updates                 : 2569737
total queries                 : 254317062
total ops                     : 256886799
find throughput               : 25431706
rq throughput                 : 0
update throughput             : 256973
query throughput              : 25431706
total throughput              : 25688679

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=331937132011271
total_execution_walltime=13.658s
REALTIME_MAIN_END_PERF_FORMAT=207423.747843779
[time_cmd_output] time_elapsed_sec=13.80, faults_major=0, faults_minor=233621, mem_maxresident_kb=935704, user_cputime=890.50, sys_cputime=6.13, percent_cpu=6494%
timeout=false
algorithm=natarajan_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1