__step=000845
__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 144 -nprefill 144 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000845.txt
__path_data=data/data000845.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6989159.373566427
binary=./drachsler_pext_bst_lock.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
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=144
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=144
WORK_THREADS=144
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,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,64,65,66,67,68,69,70,71,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.044s
prefilling_size=1000822 prefilling_elapsed_millis=1s
finished prefilling to size 1000769 for expected size 1000000 keysum=1000947661203, performing 64796633 updates; total_prefilling_elapsed_ms=1103 ms)
pref_size=1000769
pref_millis=1103
prefill_elapsed_ms=1140
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=388

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6989160.777776089
REALTIME_END_PERF_FORMAT=6989170.777924991

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

tree_stats_computeWalltime=0.032s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 507 979 1834 3298 5609 9171 14303 21128 29343 38179 46988 54362 59192 61150 60346 56374 49841 41335 32341 24118 17005 11167 7081 4247 2447 1277 596 295 136 57 33 9 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 3 22 75 199 548 1146 2175 4047 6962 11039 15705 21175 26398 30357 32706 33826 33074 30621 26418 21085 16187 11835 7935 5150 3098 1866 994 454 239 113 43 27 7 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 510 1001 1909 3497 6157 10317 16478 25175 36305 49218 62693 75537 85590 91507 93052 90200 82915 71956 58759 45203 33192 23002 15016 9397 5545 3143 1590 749 375 170 76 36 9 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 510 1001 1909 3497 6157 10317 16478 25175 36305 49218 62693 75537 85590 91507 93052 90200 82915 71956 58759 45203 33192 23002 15016 9397 5545 3143 1590 749 375 170 76 36 9 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99219 1.96863 1.92907 1.87114 1.81756 1.76466 1.70825 1.65979 1.60286 1.54745 1.49807 1.45538 1.41341 1.37756 1.34863 1.32083 1.29425 1.26672 1.24215 1.21889 1.20074 1.18068 1.16733 1.15424 1.13813 1.12552 1.09959 1.09623 1.10681 1.09067 1.11176 1.03947 1 1 1

tree_stats_height=43
tree_stats_numInternals=655261
tree_stats_numLeaves=345531
tree_stats_numNodes=1000792
tree_stats_numKeys=1000792

tree_stats_avgDegreeInternal=1.52732
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34526
tree_stats_avgKeyDepth=22.8704

tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24576 49152 97920 192192 366528 671424 1182144 1980864 3163776 4833600 6970560 9449856 12037056 14503104 16433280 17569344 17865984 17318400 15919680 13815552 11281728 8678976 6372864 4416384 2883072 1804224 1064640 603456 305280 143808 72000 32640 14592 6912 1728 384
tree_stats_sizeInBytes=192152064

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:3 2:0 4:4 8:6 16:6 32:26 64:1112 128:163822 256:422889 512:62
    [2^00, 2^01]: 3
    (2^01, 2^02]: 0
    (2^02, 2^03]: 4
    (2^03, 2^04]: 6
    (2^04, 2^05]: 6
    (2^05, 2^06]: 26
    (2^06, 2^07]: 1112
    (2^07, 2^08]: 163822
    (2^08, 2^09]: 422889
    (2^09, 2^10]: 62
sum_limbo_reclamation_event_size_total=165470716
count_limbo_reclamation_event_size_by_thread=4082 4083 4083 4082 4083 4083 4082 4083 4083 4083 4083 4080 4083 4083 4083 4083 4083 4083 4082 4083 4082 4083 4083 4083 4082 4083 4083 4083 4083 4083 4083 4082 4083 4083 4082 4083 4083 4083 4083 4083 4083 4083 4083 4083 4082 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 4082 4083 4083 4083 4083 4083 4082 4083 4083 4083 4083 4083 4082 4083 4083 4083 4082 4083 4083 4083 4083 4083 4083 4082 4082 4083 4082 4082 4083 4083 4083 4083 4083 4083 4082 4083 4083 4083 4083 4083 4083 4082
count_limbo_reclamation_event_size_total=587930
sum_limbo_reclamation_event_count_total=588239
first_thread_announced_epoch_by_thread=8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946 8946
sum_num_inserts_by_thread=2281085 2284191 2307057 2315998 2330769 2269269 2282982 2298749 2306684 2324774 2295063 2276698 2279346 2326642 2306632 2317958 2329807 2289542 2273095 2289115 2307121 2303694 2317100 2273258 2282392 2272758 2307970 2306913 2327616 2264183 2277527 2287110 2309799 2329335 2288097 2287228 2283608 2329882 2303107 2318710 2338071 2282734 2274863 2281316 2310843 2297172 2322139 2275234 2276574 2288897 2330103 2319501 2311209 2273321 2280617 2287417 2324734 2300784 2280900 2279879 2311837 2291944 2323862 2302566 2320980 2297574 2274043 2277053 2326556 2301498 2319000 2305205 2277522 2281472 2327541 2319809 2315492 2278923 2278785 2288659 2331989 2298196 2295539 2275720 2308260 2297511 2323158 2293761 2320532 2296583 2260730 2280971 2320209 2290177 2314043 2301336 2269371 2280871 2328684 2297719 2297227 2296977 2298526 2290562 2311055 2315026 2288028 2312328 2280732 2302245 2324155 2327703 2287696 2263973 2292112 2310345 2315099 2337263 2283326 2273948 2271820 2274194 2326035 2294221 2301430 2301517 2297549 2288664 2306890 2301779 2295623 2311661 2286150 2295030 2325425 2336301 2284436 2281760 2297339 2324088 2327293 2337431 2294513 2266717
sum_num_inserts_total=331141045
sum_num_deletes_by_thread=2278603 2284539 2308630 2314759 2331093 2269450 2280492 2298190 2307566 2325916 2295472 2276568 2282973 2326873 2304573 2320656 2331513 2287780 2274748 2290048 2306252 2305924 2323497 2272478 2281829 2276739 2310099 2307430 2326572 2263509 2280585 2286519 2313299 2325902 2291957 2284329 2288383 2332156 2302704 2317066 2335814 2283582 2276618 2279602 2310449 2296459 2320446 2273246 2274193 2284795 2328267 2318804 2313063 2276361 2279819 2283901 2325702 2299462 2280592 2280838 2311861 2292020 2327770 2305506 2322346 2303355 2268576 2280366 2327293 2302941 2318158 2302729 2278169 2280701 2328259 2319501 2315073 2281164 2278698 2288788 2330123 2298353 2293923 2277095 2312414 2293620 2320812 2297882 2317098 2298190 2262815 2279534 2319770 2291829 2314338 2305330 2268726 2283148 2325437 2297434 2293317 2300680 2298741 2292418 2310094 2316539 2287428 2310017 2278645 2300000 2323642 2331101 2286721 2265156 2294514 2309033 2313268 2338690 2282144 2273144 2273527 2271391 2329415 2295311 2299273 2302473 2300147 2284591 2305656 2304525 2293687 2311683 2285291 2297347 2325744 2335614 2285063 2276639 2299212 2323291 2326464 2337339 2294482 2265530
sum_num_deletes_total=331159816
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4559688 4568730 4615687 4630757 4661862 4538719 4563474 4596939 4614250 4650690 4590535 4553266 4562319 4653515 4611205 4638614 4661320 4577322 4547843 4579163 4613373 4609618 4640597 4545736 4564221 4549497 4618069 4614343 4654188 4527692 4558112 4573629 4623098 4655237 4580054 4571557 4571991 4662038 4605811 4635776 4673885 4566316 4551481 4560918 4621292 4593631 4642585 4548480 4550767 4573692 4658370 4638305 4624272 4549682 4560436 4571318 4650436 4600246 4561492 4560717 4623698 4583964 4651632 4608072 4643326 4600929 4542619 4557419 4653849 4604439 4637158 4607934 4555691 4562173 4655800 4639310 4630565 4560087 4557483 4577447 4662112 4596549 4589462 4552815 4620674 4591131 4643970 4591643 4637630 4594773 4523545 4560505 4639979 4582006 4628381 4606666 4538097 4564019 4654121 4595153 4590544 4597657 4597267 4582980 4621149 4631565 4575456 4622345 4559377 4602245 4647797 4658804 4574417 4529129 4586626 4619378 4628367 4675953 4565470 4547092 4545347 4545585 4655450 4589532 4600703 4603990 4597696 4573255 4612546 4606304 4589310 4623344 4571441 4592377 4651169 4671915 4569499 4558399 4596551 4647379 4653757 4674770 4588995 4532247
average_num_operations_total=4599311
stdev_num_operations_total=3257
sum_num_operations_total=662300861
min_num_operations_total=4523545
max_num_operations_total=4675953
first_time_thread_terminate_by_thread=10000149 10000152 10000149 10000153 10000151 10000148 10000150 10000149 10000152 10000151 10000153 10000153 10000151 10000149 10000153 10000152 10000148 10000148 10000149 10000149 10000151 10000153 10000149 10000149 10000149 10000150 10000149 10000149 10000151 10000149 10000149 10000149 10000151 10000151 10000153 10000153 10000151 10000151 10000150 10000152 10000148 10000148 10000153 10000149 10000148 10000153 10000149 10000149 10000151 10000154 10000152 10000151 10000154 10000152 10000150 10000150 10000151 10000152 10000150 10000150 10000154 10000153 10000151 10000154 10000151 10000152 10000151 10000150 10000154 10000154 10000152 10000153 10000151 10000154 10000153 10000154 10000151 10000152 10000153 10000151 10000152 10000152 10000150 10000153 10000154 10000153 10000151 10000154 10000151 10000154 10000151 10000153 10000153 10000154 10000152 10000153 10000147 10000152 10000150 10000147 10000149 10000147 10000152 10000152 10000147 10000147 10000147 10000147 10000147 10000147 10000150 10000147 10000151 10000151 10000150 10000149 10000149 10000149 10000149 10000150 10000147 10000148 10000149 10000147 10000149 10000150 10000152 10000151 10000147 10000148 10000152 10000147 10000147 10000147 10000150 10000148 10000151 10000148 10000147 10000151 10000149 10000148 10000147 10000149
min_time_thread_terminate_total=10000147
max_time_thread_terminate_total=10000154
first_time_thread_start_by_thread=5 4 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 4 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 5 4 5 5 4 5 4 5 5 4 5 5 5 5 5 4 5 4 5 5 5 4 5 4 5 5 5 5 4 5 4 5 5 4 5 5 5 5 5 5 5 4 5 5 5 4 5 4 5 5 5 6 5 5 5 5 5 5 5 5 5 5 5 5 5 5 6 6 6 6 6 6 5 5 5 6 5 5 5 5 5 5 5 5 5 5 5 5 5 5 6 6 6 5 6 6 5 5
min_time_thread_start_total=4
max_time_thread_start_total=6
sum_duration_all_ops_total=

threads_final_keysum=1000771869319
threads_final_size=1000792
final_keysum=1000771869319
final_size=1000792
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=331141045
total_deletes=331159816
total_updates=662300861
total_queries=0
total_ops=662300861
find_throughput=0
rq_throughput=0
update_throughput=66230086
query_throughput=0
total_throughput=66230086


total find                    : 0
total rq                      : 0
total inserts                 : 331141045
total deletes                 : 331159816
total updates                 : 662300861
total queries                 : 0
total ops                     : 662300861
find throughput               : 0
rq throughput                 : 0
update throughput             : 66230086
query throughput              : 0
total throughput              : 66230086

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=21.8424
PAPI_L3_TCM=8.39625
PAPI_TOT_CYC=6055.34
PAPI_TOT_INS=616.646
garbage=0
total_execution_walltime=11.532s
REALTIME_MAIN_END_PERF_FORMAT=6989170.906598007
[time_cmd_output] time_elapsed_sec=11.66, faults_major=0, faults_minor=138770, mem_maxresident_kb=546588, user_cputime=1622.58, sys_cputime=8.05, percent_cpu=13977%
timeout=false
algorithm=drachsler_pext_bst_lock.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1