__step=000843
__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" ./drachsler_pext_bst_lock.debra -nwork 128 -nprefill 128 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000843.txt
__path_data=data/data000843.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=217034.357566117
binary=./drachsler_pext_bst_lock.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=drachsler_pext_bst_lock
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=2000000
PREFILL_THREADS=128
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=128
WORK_THREADS=128
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=192
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.052s
prefilling_size=1000844 prefilling_elapsed_millis=1s
finished prefilling to size 1000832 for expected size 1000000 keysum=1000036141964, performing 52657263 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=1000832
pref_millis=1102
prefill_elapsed_ms=1110
6node_tIxPvE_object_size=192
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=369

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=217035.562494591
REALTIME_END_PERF_FORMAT=217045.562573578

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

tree_stats_computeWalltime=0.112s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 127 246 464 845 1520 2689 4614 7510 11779 17327 24224 31758 39269 45988 50802 53347 53837 52451 49171 44577 39214 33057 26706 20418 14901 10291 6732 4317 2669 1542 882 465 219 86 21 7 3 1 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 8 17 47 81 192 442 949 1754 3395 5583 9033 13019 17348 21930 25639 27898 29334 29372 28325 26320 23947 20693 17275 13432 10105 7158 4716 3091 1938 1116 672 356 182 80 19 5 3 0 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 254 481 892 1601 2881 5056 8459 13533 20722 29807 40791 52288 63336 72732 78986 81735 81785 78543 72902 65534 57004 47399 37693 28333 20396 13890 9033 5760 3480 1998 1137 575 268 101 26 8 4 1 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 254 481 892 1601 2881 5056 8459 13533 20722 29807 40791 52288 63336 72732 78986 81735 81785 78543 72902 65534 57004 47399 37693 28333 20396 13890 9033 5760 3480 1998 1137 575 268 101 26 8 4 1 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.99219 1.9252 1.88981 1.84753 1.85009 1.82159 1.76048 1.71202 1.66083 1.60226 1.55581 1.5033 1.46028 1.42226 1.3875 1.35941 1.34193 1.31903 1.30214 1.28747 1.27146 1.2516 1.2318 1.20999 1.19394 1.17646 1.16566 1.15975 1.1408 1.13103 1.12763 1.09675 1.08522 1.05597 1.0495 1.03846 1.125 1 2 1

tree_stats_height=47
tree_stats_numInternals=654204
tree_stats_numLeaves=345477
tree_stats_numNodes=999681
tree_stats_numKeys=999681

tree_stats_avgDegreeInternal=1.52809
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34559
tree_stats_avgKeyDepth=23.9137

tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24576 48768 92352 171264 307392 553152 970752 1624128 2598336 3978624 5722944 7831872 10039296 12160512 13964544 15165312 15693120 15702720 15080256 13997184 12582528 10944768 9100608 7237056 5439936 3916032 2666880 1734336 1105920 668160 383616 218304 110400 51456 19392 4992 1536 768 192 384
tree_stats_sizeInBytes=191938752

6node_tIxPvE_object_size=192
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=4074


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:8 2:2 4:0 8:3 16:21 32:21 64:144 128:94240 256:378881 512:494 1024:142
    [2^00, 2^01]: 8
    (2^01, 2^02]: 2
    (2^02, 2^03]: 0
    (2^03, 2^04]: 3
    (2^04, 2^05]: 21
    (2^05, 2^06]: 21
    (2^06, 2^07]: 144
    (2^07, 2^08]: 94240
    (2^08, 2^09]: 378881
    (2^09, 2^10]: 494
    (2^10, 2^11]: 142
sum_limbo_reclamation_event_size_total=130905191
count_limbo_reclamation_event_size_by_thread=3703 3703 3703 3701 3703 3703 3703 3702 3703 3702 3702 3703 3702 3702 3702 3703 3703 3703 3703 3703 3702 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3702 3703 3703 3703 3703 3703 3703 3702 3703 3703 3703 3703 3702 3703 3703 3703 3703 3703 3703 3703 3702 3703 3702 3703 3702 3703 3702 3702 3703 3702 3703 3702 3702 3702 3702 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3702 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3703 3702 3703 3703 3703 3703 3703 3703 3703 3703 3703 3702 3702 3703 3703 3703 3703 3703 3703 3702 3702
count_limbo_reclamation_event_size_total=473956
sum_limbo_reclamation_event_count_total=474239
first_thread_announced_epoch_by_thread=8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148 8148
sum_num_inserts_by_thread=2041800 2081705 2081088 2068180 2085711 2086130 2061776 2052277 2095551 2017388 2007021 2087413 2050911 2054288 2048365 2050952 2055204 2059268 2055893 2057549 2047582 2086900 2079484 2080420 2051536 2049269 2020299 2049953 2055074 2077912 2038645 2069149 2072109 2068764 2067679 2057747 2009542 2011470 2008685 2006976 2102282 1995950 2098888 2094348 2081396 2101117 2040104 2091304 1979170 1985934 1977979 1956691 2043128 2053958 2018368 2039559 2024613 2022025 2040635 2049219 1982587 1991843 1962349 1986972 2069518 2028072 2026804 2021829 2028536 2061361 2031501 2050302 2102964 2096889 2095528 2099125 2061459 2063538 2057650 2043469 2044559 2038774 2035103 2027403 2021752 2017992 2093862 2092302 2038748 2043377 2067644 2041828 2044706 2022110 2048145 2021785 2051762 2050716 2047812 2041728 2031539 2030615 2025646 2028847 2121113 2112778 2123185 2118643 2038284 2094440 2033081 2092451 1971054 1983939 1981173 1986288 2048431 2083028 2051796 2048158 2065899 2064165 2057701 2057552 1980190 2005126 1992484 2003600
sum_num_inserts_total=261989943
sum_num_deletes_by_thread=2040032 2081009 2078503 2070620 2086216 2086409 2059403 2049656 2093572 2018522 2011374 2083754 2052847 2053373 2047754 2054620 2055335 2057356 2057576 2060119 2043418 2089935 2079712 2075934 2053258 2049356 2020448 2050245 2054944 2074777 2038635 2069793 2072828 2073278 2070038 2058260 2010619 2011673 2008115 2006290 2101098 1997285 2098092 2093844 2085271 2101139 2038882 2092823 1980093 1983892 1978141 1956170 2040201 2050537 2019773 2038548 2024741 2023566 2041260 2049064 1980197 1994251 1964905 1987043 2070090 2026564 2025053 2020828 2026332 2060739 2029224 2052096 2104042 2096581 2092075 2099795 2064339 2064202 2059139 2045014 2044536 2037913 2036470 2022905 2023104 2016144 2094781 2093642 2040600 2041422 2068427 2039522 2041435 2024604 2047877 2019610 2054009 2052623 2048659 2042718 2032752 2027939 2026780 2026912 2118168 2114657 2124873 2116637 2038274 2094131 2031183 2089806 1970055 1987588 1980077 1986915 2044997 2082388 2054794 2048592 2063998 2067235 2058778 2058048 1977221 2003037 1991800 2003683
sum_num_deletes_total=261978854
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4081832 4162714 4159591 4138800 4171927 4172539 4121179 4101933 4189123 4035910 4018395 4171167 4103758 4107661 4096119 4105572 4110539 4116624 4113469 4117668 4091000 4176835 4159196 4156354 4104794 4098625 4040747 4100198 4110018 4152689 4077280 4138942 4144937 4142042 4137717 4116007 4020161 4023143 4016800 4013266 4203380 3993235 4196980 4188192 4166667 4202256 4078986 4184127 3959263 3969826 3956120 3912861 4083329 4104495 4038141 4078107 4049354 4045591 4081895 4098283 3962784 3986094 3927254 3974015 4139608 4054636 4051857 4042657 4054868 4122100 4060725 4102398 4207006 4193470 4187603 4198920 4125798 4127740 4116789 4088483 4089095 4076687 4071573 4050308 4044856 4034136 4188643 4185944 4079348 4084799 4136071 4081350 4086141 4046714 4096022 4041395 4105771 4103339 4096471 4084446 4064291 4058554 4052426 4055759 4239281 4227435 4248058 4235280 4076558 4188571 4064264 4182257 3941109 3971527 3961250 3973203 4093428 4165416 4106590 4096750 4129897 4131400 4116479 4115600 3957411 4008163 3984284 4007283
average_num_operations_total=4093506
stdev_num_operations_total=6385
sum_num_operations_total=523968797
min_num_operations_total=3912861
max_num_operations_total=4248058
first_time_thread_terminate_by_thread=10000081 10000081 10000081 10000081 10000080 10000078 10000080 10000080 10000081 10000081 10000081 10000079 10000080 10000080 10000080 10000080 10000082 10000080 10000080 10000080 10000081 10000081 10000080 10000081 10000081 10000081 10000081 10000082 10000081 10000081 10000081 10000081 10000080 10000080 10000080 10000080 10000081 10000081 10000081 10000081 10000082 10000082 10000082 10000082 10000079 10000083 10000081 10000081 10000082 10000082 10000082 10000082 10000082 10000082 10000082 10000082 10000079 10000081 10000079 10000079 10000079 10000079 10000079 10000079 10000081 10000081 10000081 10000081 10000078 10000080 10000080 10000078 10000081 10000079 10000079 10000079 10000080 10000080 10000080 10000080 10000080 10000080 10000080 10000080 10000080 10000080 10000080 10000080 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000078 10000080 10000080 10000127 10000081 10000081 10000081 10000081 10000082 10000082 10000082 10000084 10000081 10000079 10000079 10000079 10000082 10000082 10000082 10000082 10000082 10000082 10000082 10000082 10000081 10000081 10000081 10000081 10000079 10000079 10000081 10000079
min_time_thread_terminate_total=10000078
max_time_thread_terminate_total=10000127
first_time_thread_start_by_thread=10 10 10 10 11 11 11 11 10 10 10 9 8 8 8 8 10 10 10 10 11 11 12 11 10 10 10 10 9 9 9 9 8 7 8 7 10 10 10 10 12 12 12 12 12 12 12 12 11 11 11 11 9 9 9 9 11 11 11 11 12 12 12 12 10 10 10 10 11 11 11 11 10 10 10 9 8 8 8 8 10 10 10 10 11 11 12 11 10 10 10 10 9 9 9 9 8 7 8 15 10 10 10 10 12 12 12 12 12 12 12 12 11 11 11 11 9 9 9 9 11 11 11 11 12 12 12 12
min_time_thread_start_total=7
max_time_thread_start_total=15
sum_duration_all_ops_total=

threads_final_keysum=999454732944
threads_final_size=999681
final_keysum=999454732944
final_size=999681
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=261989943
total_deletes=261978854
total_updates=523968797
total_queries=0
total_ops=523968797
find_throughput=0
rq_throughput=0
update_throughput=52396879
query_throughput=0
total_throughput=52396879


total find                    : 0
total rq                      : 0
total inserts                 : 261989943
total deletes                 : 261978854
total updates                 : 523968797
total queries                 : 0
total ops                     : 523968797
find throughput               : 0
rq throughput                 : 0
update throughput             : 52396879
query throughput              : 0
total throughput              : 52396879

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

garbage=0
total_execution_walltime=11.464s
REALTIME_MAIN_END_PERF_FORMAT=217045.821982399
[time_cmd_output] time_elapsed_sec=11.58, faults_major=0, faults_minor=134100, mem_maxresident_kb=533136, user_cputime=1398.42, sys_cputime=24.37, percent_cpu=12280%
timeout=false
algorithm=drachsler_pext_bst_lock.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1