__step=000955
__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 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000955.txt
__path_data=data/data000955.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=218335.925374424
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=200000
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.04s
prefilling_size=100105 prefilling_elapsed_millis=1s
finished prefilling to size 100088 for expected size 100000 keysum=10014833507, performing 58062572 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=100088
pref_millis=1102
prefill_elapsed_ms=1117
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=422

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=218337.107308795
REALTIME_END_PERF_FORMAT=218347.107393266

###############################################################################
################################## 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 1496 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 64 127 246 458 794 1355 2150 3260 4502 5796 6819 7384 7345 6667 5657 4499 3318 2153 1312 681 302 131 82 61 42 38 36 31 34 29 28 20 16 20 21 17 13 10 8 6 4 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 6 19 67 141 317 563 1120 1758 2580 3338 3894 4233 4009 3568 2884 2299 1509 1019 551 239 95 53 38 27 19 23 14 22 13 22 13 9 10 11 13 9 4 6 5 5 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 127 252 477 861 1496 2467 3823 5622 7554 9399 10722 11239 10900 9666 8067 6202 4452 2821 1700 853 370 177 114 80 65 55 54 48 51 41 42 29 29 31 28 26 19 12 12 9 7 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 127 252 477 861 1496 2467 3823 5622 7554 9399 10722 11239 10900 9666 8067 6202 4452 2821 1700 853 370 177 114 80 65 55 54 48 51 41 42 29 29 31 28 26 19 12 12 9 7 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.98438 1.98425 1.91667 1.84486 1.81533 1.74332 1.67815 1.61784 1.54287 1.47697 1.41526 1.35954 1.31631 1.27514 1.24933 1.21111 1.18284 1.15004 1.13754 1.10118 1.07972 1.12432 1.18079 1.16667 1.2875 1.26154 1.32727 1.31481 1.35417 1.23529 1.34146 1.21429 1.44828 1.37931 1.22581 1.32143 1.23077 1.10526 1.33333 1.25 1.33333 1 1

tree_stats_height=49
tree_stats_numInternals=65601
tree_stats_numLeaves=34527
tree_stats_numNodes=100128
tree_stats_numKeys=100128

tree_stats_avgDegreeInternal=1.52632
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34483
tree_stats_avgKeyDepth=18.19

tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24384 48384 91584 165312 287232 473664 734016 1079424 1450368 1804608 2058624 2157888 2092800 1855872 1548864 1190784 854784 541632 326400 163776 71040 33984 21888 15360 12480 10560 10368 9216 9792 7872 8064 5568 5568 5952 5376 4992 3648 2304 2304 1728 1344 384
tree_stats_sizeInBytes=19224576

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:86 2:0 4:4 8:2 16:3 32:18 64:137 128:165532 256:364400 512:131 1024:127
    [2^00, 2^01]: 86
    (2^01, 2^02]: 0
    (2^02, 2^03]: 4
    (2^03, 2^04]: 2
    (2^04, 2^05]: 3
    (2^05, 2^06]: 18
    (2^06, 2^07]: 137
    (2^07, 2^08]: 165532
    (2^08, 2^09]: 364400
    (2^09, 2^10]: 131
    (2^10, 2^11]: 127
sum_limbo_reclamation_event_size_total=143014616
count_limbo_reclamation_event_size_by_thread=4142 4146 4142 4141 4145 4145 4146 4145 4143 4144 4143 4143 4141 4146 4146 4140 4143 4146 4143 4143 4142 4143 4146 4141 4144 4145 4145 4143 4145 4143 4142 4142 4146 4143 4143 4143 4144 4146 4146 4143 4145 4146 4142 4142 4145 4145 4142 4145 4146 4146 4145 4146 4145 4144 4145 4143 4142 4145 4141 4146 4146 4146 4146 4141 4145 4146 4146 4145 4141 4143 4146 4143 4144 4145 4143 4146 4146 4142 4141 4141 4145 4146 4145 4145 4145 4144 4145 4146 4144 4145 4143 4145 4145 4142 4143 4142 4146 4145 4145 4142 4146 4144 4142 4146 4145 4145 4142 4146 4143 4143 4146 4142 4146 4144 4146 4142 4145 4142 4145 4141 4146 4144 4143 4143 4144 4143 4146 4146
count_limbo_reclamation_event_size_total=530440
sum_limbo_reclamation_event_count_total=530908
first_thread_announced_epoch_by_thread=9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140 9140
sum_num_inserts_by_thread=2211853 2279316 2200739 2196755 2274034 2270595 2270048 2263898 2252841 2245235 2250310 2241352 2227888 2250292 2244645 2218706 2190681 2256912 2186162 2181676 2193516 2201801 2267190 2209786 2253172 2235889 2243059 2237201 2232860 2255421 2227890 2218383 2245300 2194880 2192324 2192916 2196344 2272909 2262406 2212901 2246539 2244648 2229225 2221293 2238447 2237483 2184899 2231535 2270338 2257514 2266363 2287159 2249787 2235101 2243481 2228912 2218161 2236853 2207521 2213634 2234692 2194403 2236375 2182879 2252567 2284969 2279391 2272131 2204726 2203803 2280165 2202570 2226535 2210204 2220714 2202016 2223391 2198821 2195530 2225247 2285811 2286870 2274104 2279311 2263898 2226298 2242960 2237070 2218474 2202596 2217186 2206436 2203507 2224901 2249965 2247510 2274346 2271647 2264241 2223677 2266836 2207347 2198389 2252660 2214586 2214527 2219262 2241674 2229508 2225625 2272223 2223179 2311446 2205985 2305499 2199085 2231817 2244902 2255139 2237168 2253105 2235649 2241188 2231444 2231364 2237828 2277696 2274600
sum_num_inserts_total=286180647
sum_num_deletes_by_thread=2212198 2281030 2199815 2194270 2273456 2271034 2272654 2263502 2254316 2245743 2247147 2239056 2226527 2251237 2245970 2217197 2191438 2260385 2187317 2182502 2195110 2205071 2266481 2212301 2250240 2237773 2242854 2233162 2233165 2252581 2223806 2219862 2246966 2195200 2191794 2195859 2193119 2272851 2264053 2214771 2248591 2246240 2230632 2219875 2238297 2233159 2186623 2233372 2272629 2255943 2269079 2284319 2246678 2232000 2245429 2227992 2217837 2238497 2203500 2212296 2237708 2199094 2235727 2183841 2252848 2282382 2274697 2271585 2203584 2205488 2278856 2204290 2229446 2210193 2217543 2203975 2221144 2200757 2192925 2225748 2284883 2287337 2272506 2277639 2262740 2225421 2243487 2235769 2219910 2202770 2217417 2205947 2202234 2224477 2249803 2249641 2271222 2269976 2264896 2224502 2267127 2202547 2198230 2251697 2216426 2216734 2224348 2239570 2230178 2225900 2273111 2224578 2312309 2206047 2304168 2200241 2233930 2243434 2252154 2240366 2255634 2235274 2239431 2234855 2230792 2236919 2276838 2273070
sum_num_deletes_total=286177117
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4424051 4560346 4400554 4391025 4547490 4541629 4542702 4527400 4507157 4490978 4497457 4480408 4454415 4501529 4490615 4435903 4382119 4517297 4373479 4364178 4388626 4406872 4533671 4422087 4503412 4473662 4485913 4470363 4466025 4508002 4451696 4438245 4492266 4390080 4384118 4388775 4389463 4545760 4526459 4427672 4495130 4490888 4459857 4441168 4476744 4470642 4371522 4464907 4542967 4513457 4535442 4571478 4496465 4467101 4488910 4456904 4435998 4475350 4411021 4425930 4472400 4393497 4472102 4366720 4505415 4567351 4554088 4543716 4408310 4409291 4559021 4406860 4455981 4420397 4438257 4405991 4444535 4399578 4388455 4450995 4570694 4574207 4546610 4556950 4526638 4451719 4486447 4472839 4438384 4405366 4434603 4412383 4405741 4449378 4499768 4497151 4545568 4541623 4529137 4448179 4533963 4409894 4396619 4504357 4431012 4431261 4443610 4481244 4459686 4451525 4545334 4447757 4623755 4412032 4609667 4399326 4465747 4488336 4507293 4477534 4508739 4470923 4480619 4466299 4462156 4474747 4554534 4547670
average_num_operations_total=4471545
stdev_num_operations_total=5095
sum_num_operations_total=572357764
min_num_operations_total=4364178
max_num_operations_total=4623755
first_time_thread_terminate_by_thread=10000086 10000086 10000086 10000086 10000084 10000084 10000084 10000084 10000084 10000084 10000084 10000084 10000086 10000086 10000086 10000086 10000083 10000084 10000084 10000084 10000086 10000086 10000084 10000086 10000084 10000085 10000084 10000084 10000084 10000084 10000084 10000084 10000085 10000085 10000086 10000086 10000085 10000085 10000085 10000085 10000083 10000085 10000083 10000087 10000085 10000085 10000085 10000085 10000085 10000086 10000085 10000085 10000084 10000084 10000085 10000084 10000082 10000082 10000082 10000082 10000083 10000083 10000083 10000083 10000086 10000086 10000086 10000086 10000085 10000084 10000084 10000084 10000084 10000084 10000084 10000084 10000086 10000086 10000086 10000086 10000083 10000084 10000083 10000083 10000086 10000084 10000084 10000086 10000084 10000085 10000084 10000085 10000084 10000084 10000084 10000084 10000085 10000085 10000086 10000086 10000085 10000085 10000085 10000085 10000083 10000083 10000083 10000083 10000085 10000085 10000085 10000085 10000085 10000085 10000085 10000085 10000085 10000084 10000085 10000085 10000082 10000082 10000082 10000082 10000083 10000083 10000083 10000083
min_time_thread_terminate_total=10000082
max_time_thread_terminate_total=10000087
first_time_thread_start_by_thread=5 5 5 5 5 5 5 5 5 5 5 5 6 6 6 6 7 7 7 7 6 6 6 6 6 6 6 6 5 5 5 5 5 5 5 5 7 8 7 8 7 7 7 7 6 6 6 6 8 8 8 8 8 8 8 8 8 8 8 8 7 7 7 7 5 5 5 5 5 5 5 5 5 5 5 5 6 6 6 6 7 7 7 7 6 6 6 6 6 6 6 6 5 5 5 5 5 5 5 5 7 8 7 8 7 7 7 7 6 6 6 7 8 8 8 8 8 8 8 8 8 8 8 8 7 7 7 7
min_time_thread_start_total=5
max_time_thread_start_total=8
sum_duration_all_ops_total=

threads_final_keysum=10014408219
threads_final_size=100128
final_keysum=10014408219
final_size=100128
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=286180647
total_deletes=286177117
total_updates=572357764
total_queries=0
total_ops=572357764
find_throughput=0
rq_throughput=0
update_throughput=57235776
query_throughput=0
total_throughput=57235776


total find                    : 0
total rq                      : 0
total inserts                 : 286180647
total deletes                 : 286177117
total updates                 : 572357764
total queries                 : 0
total ops                     : 572357764
find throughput               : 0
rq throughput                 : 0
update throughput             : 57235776
query throughput              : 0
total throughput              : 57235776

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=0
total_execution_walltime=11.353s
REALTIME_MAIN_END_PERF_FORMAT=218347.279521701
[time_cmd_output] time_elapsed_sec=11.45, faults_major=0, faults_minor=91451, mem_maxresident_kb=362684, user_cputime=1382.81, sys_cputime=24.63, percent_cpu=12283%
timeout=false
algorithm=drachsler_pext_bst_lock.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1