__step=000609
__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 5.0 5.0 -k 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000609.txt
__path_data=data/data000609.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=214154.830868824
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=5
DEL_FRAC=5
RQ=0
RQSIZE=0
MAXKEY=200000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=5.0 5.0
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.019s
prefilling_size=100102 prefilling_elapsed_millis=1s
finished prefilling to size 100104 for expected size 100000 keysum=10010702821, performing 45698340 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=100104
pref_millis=1101
prefill_elapsed_ms=1113
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=1496
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=214155.981376776
REALTIME_END_PERF_FORMAT=214165.981452210
###############################################################################
################################## 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 1468 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.117s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 60 112 224 424 734 1178 1821 2725 3901 5342 6868 8274 9553 10215 10234 9481 8353 6794 5035 3496 2284 1408 845 479 259 109 54 18 4 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 4 8 0 24 114 290 535 917 1549 2460 3816 5462 6995 8891 10196 10987 10609 9912 8553 6574 4708 3160 1971 1211 699 409 164 90 32 6 4
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 120 224 448 848 1468 2356 3642 5450 7802 10684 13736 16548 19106 20430 20468 18962 16706 13588 10070 6992 4568 2816 1690 958 518 218 108 36 8 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 4 8 0 24 114 290 535 917 1549 2460 3816 5462 6995 8891 10196 10987 10609 9912 8553 6574 4708 3160 1971 1211 699 409 164 90 32 6 4
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.9375 1.93333 2 1.94643 1.86557 1.80245 1.77292 1.74822 1.71578 1.6847 1.64283 1.60236 1.57729 1.53465 1.50093 1.46321 1.44051 1.40668 1.37055 1.34717 1.32666 1.30823 1.30007 1.28343 1.27035 1.21042 1.24771 1.16667 1.11111 1.25 1
tree_stats_height=37
tree_stats_numInternals=100349
tree_stats_numLeaves=100350
tree_stats_numNodes=200699
tree_stats_numKeys=100350
tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=21.2983
tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 3840 7168 14336 27136 46976 75392 116544 174400 249664 341888 439552 529536 611392 653760 654976 606784 534592 434816 322240 223744 146176 90112 54080 30656 16576 6976 3456 1152 256 128
tree_stats_sizeInBytes=6422368
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=32505
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:11 4:368 8:20950 16:403345 32:214921 64:24 128:238 256:14
(2^01, 2^02]: 11
(2^02, 2^03]: 368
(2^03, 2^04]: 20950
(2^04, 2^05]: 403345
(2^05, 2^06]: 214921
(2^06, 2^07]: 24
(2^07, 2^08]: 238
(2^08, 2^09]: 14
sum_limbo_reclamation_event_size_total=17998880
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=639871
sum_limbo_reclamation_event_count_total=1984561
first_thread_announced_epoch_by_thread=65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010 65010
sum_num_inserts_by_thread=821549 826792 820280 810549 806711 804194 797268 794700 889918 819205 904889 901053 800051 799712 798555 794232 834221 917246 902951 813307 873696 874337 870166 922204 988285 887372 884305 881893 909899 905159 887657 873161 862068 862046 855707 856213 852101 928925 916305 914283 910330 917086 916965 911871 748997 736325 727985 727591 853741 856948 853981 919923 921893 924932 925825 928563 933168 937578 936204 930498 936330 946817 947010 955334
sum_num_inserts_total=55769060
sum_num_deletes_by_thread=822348 827367 819185 810590 805871 804709 797083 795373 887944 819257 905987 900087 801485 800351 797159 795789 835297 919032 904592 812509 870802 874943 871332 922535 990484 886218 886925 883839 910220 906170 889126 872785 862948 861625 854907 856221 852893 929875 912481 913661 911158 916123 913233 912688 748314 737410 728948 729620 854394 857606 852336 920424 921760 924568 926371 927183 933622 934548 936085 930201 937256 945492 947416 954280
sum_num_deletes_total=55773041
sum_num_searches_by_thread=14793641 14880349 14740209 14580800 14539373 14481059 14363803 14317566 16010273 14756154 16283247 16217247 14415033 14399122 14349831 14324907 15031535 16514218 16267465 14636566 15691794 15727354 15655947 16610977 17804867 15967685 15938271 15907046 16367837 16294899 15971086 15713927 15536335 15514308 15391957 15400197 15335445 16712093 16480074 16448054 16412352 16494159 16453859 16432946 13471244 13258173 13131289 13100972 15354123 15412815 15351124 16582655 16594857 16648211 16673322 16696618 16806801 16844421 16819144 16749948 16874607 17016697 17061603 17186267
sum_num_searches_total=1003800758
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=16437538 16534508 16379674 16201939 16151955 16089962 15958154 15907639 17788135 16394616 18094123 18018387 16016569 15999185 15945545 15914928 16701053 18350496 18075008 16262382 17436292 17476634 17397445 18455716 19783636 17741275 17709501 17672778 18187956 18106228 17747869 17459873 17261351 17237979 17102571 17112631 17040439 18570893 18308860 18275998 18233840 18327368 18284057 18257505 14968555 14731908 14588222 14558183 17062258 17127369 17057441 18423002 18438510 18497711 18525518 18552364 18673591 18716547 18691433 18610647 18748193 18909006 18956029 19095881
average_num_operations_total=17427232
stdev_num_operations_total=151326
sum_num_operations_total=1115342859
min_num_operations_total=14558183
max_num_operations_total=19783636
first_time_thread_terminate_by_thread=10000078 10000078 10000078 10000078 10000076 10000076 10000075 10000076 10000077 10000077 10000077 10000077 10000076 10000076 10000078 10000076 10000077 10000077 10000077 10000077 10000075 10000075 10000075 10000075 10000075 10000075 10000075 10000075 10000078 10000078 10000078 10000078 10000078 10000076 10000076 10000076 10000075 10000075 10000077 10000077 10000076 10000076 10000076 10000076 10000078 10000078 10000078 10000078 10000077 10000077 10000077 10000077 10000077 10000077 10000077 10000077 10000076 10000076 10000076 10000076 10000078 10000078 10000078 10000078
min_time_thread_terminate_total=10000075
max_time_thread_terminate_total=10000078
first_time_thread_start_by_thread=6 6 5 5 6 6 6 6 9 9 9 9 6 7 7 7 8 8 8 8 7 7 7 7 5 5 5 5 9 8 9 9 9 9 9 9 9 9 9 9 10 10 10 10 6 6 6 6 8 8 8 8 7 7 7 7 8 8 8 8 10 10 10 10
min_time_thread_start_total=5
max_time_thread_start_total=10
sum_duration_all_ops_total=
threads_final_keysum=10051511942
threads_final_size=100350
final_keysum=10051511942
final_size=100350
validate_result=success
Validation OK.
Structural validation OK.
total_find=1003800758
total_rq=0
total_inserts=55769060
total_deletes=55773041
total_updates=111542101
total_queries=1003800758
total_ops=1115342859
find_throughput=100380075
rq_throughput=0
update_throughput=11154210
query_throughput=100380075
total_throughput=111534285
total find : 1003800758
total rq : 0
total inserts : 55769060
total deletes : 55773041
total updates : 111542101
total queries : 1003800758
total ops : 1115342859
find throughput : 100380075
rq throughput : 0
update throughput : 11154210
query throughput : 100380075
total throughput : 111534285
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=14736491497173
total_execution_walltime=11.352s
REALTIME_MAIN_END_PERF_FORMAT=214166.184026470
[time_cmd_output] time_elapsed_sec=11.46, faults_major=0, faults_minor=78498, mem_maxresident_kb=310128, user_cputime=739.15, sys_cputime=4.96, percent_cpu=6491%
timeout=false
algorithm=natarajan_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1