__step=000731
__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 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000731.txt
__path_data=data/data000731.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=215662.134151834
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=20000000
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.028s
prefilling_size=8584130 prefilling_elapsed_millis=1s
prefilling_size=8805717 prefilling_elapsed_millis=1.101s
prefilling_size=8990265 prefilling_elapsed_millis=1.201s
prefilling_size=9147063 prefilling_elapsed_millis=1.301s
prefilling_size=9277574 prefilling_elapsed_millis=1.401s
prefilling_size=9384896 prefilling_elapsed_millis=1.501s
prefilling_size=9477472 prefilling_elapsed_millis=1.601s
prefilling_size=9556165 prefilling_elapsed_millis=1.701s
prefilling_size=9623250 prefilling_elapsed_millis=1.801s
prefilling_size=9680193 prefilling_elapsed_millis=1.901s
prefilling_size=9729739 prefilling_elapsed_millis=2.002s
prefilling_size=9769269 prefilling_elapsed_millis=2.102s
prefilling_size=9801145 prefilling_elapsed_millis=2.202s
finished prefilling to size 9801181 for expected size 10000000 keysum=98017038343911, performing 78759479 updates; total_prefilling_elapsed_ms=2303 ms)
pref_size=9801181
pref_millis=2303
prefill_elapsed_ms=2319
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=519

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=215664.508758147
REALTIME_END_PERF_FORMAT=215674.508853637

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

tree_stats_computeWalltime=0.218s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 504 980 1891 3610 6691 11943 20637 34268 54231 81911 118547 163626 216189 274184 333313 389494 436516 470329 488291 490046 473857 442765 399353 349298 297135 246039 197790 154680 117491 86295 61465 42401 28890 19015 12024 7236 4128 2206 1178 571 261 121 54 23 9 4 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 3 14 38 86 309 814 1802 3890 7742 14563 24569 39763 59911 85158 115222 147980 182469 213778 239574 257598 267311 265905 255661 236047 210372 182308 154137 125807 99894 77424 57617 42106 28888 20067 13414 8737 5355 3106 1671 920 461 211 98 45 21 7 4 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 507 994 1929 3696 7000 12757 22439 38158 61973 96474 143116 203389 276100 359342 448535 537474 618985 684107 727865 747644 741168 708670 655014 585345 507507 428347 351927 280487 217385 163719 119082 84507 57778 39082 25438 15973 9483 5312 2849 1491 722 332 152 68 30 11 6 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 507 994 1929 3696 7000 12757 22439 38158 61973 96474 143116 203389 276100 359342 448535 537474 618985 684107 727865 747644 741168 708670 655014 585345 507507 428347 351927 280487 217385 163719 119082 84507 57778 39082 25438 15973 9483 5312 2849 1491 722 332 152 68 30 11 6 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.98047 1.96647 1.95473 1.93572 1.91721 1.86657 1.82276 1.78083 1.72606 1.68164 1.63442 1.59282 1.553 1.51848 1.4852 1.45517 1.42698 1.4 1.37646 1.35632 1.33588 1.31681 1.2995 1.28395 1.27028 1.25854 1.2472 1.23498 1.22356 1.21265 1.20026 1.1935 1.18196 1.1764 1.16435 1.15524 1.14067 1.12486 1.12105 1.10986 1.10127 1.09834 1.09337 1.09211 1.10294 1.06667 1.18182 1 1

tree_stats_height=57
tree_stats_numInternals=6542003
tree_stats_numLeaves=3452879
tree_stats_numNodes=9994882
tree_stats_numKeys=9994882

tree_stats_avgDegreeInternal=1.5278
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34546
tree_stats_avgKeyDepth=28.6347

tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24576 49152 97344 190848 370368 709632 1344000 2449344 4308288 7326336 11898816 18523008 27478272 39050688 53011200 68993664 86118720 103195008 118845120 131348544 139750080 143547648 142304256 136064640 125762688 112386240 97441344 82242624 67569984 53853504 41737920 31434048 22863744 16225344 11093376 7503744 4884096 3066816 1820736 1019904 547008 286272 138624 63744 29184 13056 5760 2112 1152 384
tree_stats_sizeInBytes=1919017344

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:1 8:0 16:1 32:1 64:6 128:9177 256:267239 512:438
    (2^02, 2^03]: 1
    (2^03, 2^04]: 0
    (2^04, 2^05]: 1
    (2^05, 2^06]: 1
    (2^06, 2^07]: 6
    (2^07, 2^08]: 9177
    (2^08, 2^09]: 267239
    (2^09, 2^10]: 438
sum_limbo_reclamation_event_size_total=80678064
count_limbo_reclamation_event_size_by_thread=2163 2163 2163 2162 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163 2163
count_limbo_reclamation_event_size_total=276863
sum_limbo_reclamation_event_count_total=277120
first_thread_announced_epoch_by_thread=5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368 5368
sum_num_inserts_by_thread=1266501 1266293 1268414 1261396 1266786 1265803 1265312 1261574 1266194 1274521 1260194 1261337 1273757 1280069 1274780 1259239 1250332 1270464 1265162 1267370 1252099 1263018 1259012 1258722 1264234 1265796 1261916 1264552 1267616 1262178 1254811 1259766 1264031 1265264 1268477 1262847 1263993 1276814 1265033 1268778 1262540 1264859 1270502 1261904 1268294 1259273 1257546 1261612 1263849 1259362 1254652 1250083 1262172 1269129 1265683 1260635 1270966 1256463 1270087 1262575 1257306 1261363 1255414 1256010 1258184 1263101 1259565 1269374 1266094 1263788 1261888 1264656 1261380 1253073 1262319 1261502 1253595 1270522 1267079 1247716 1270959 1273589 1251016 1271265 1265877 1257623 1257874 1257974 1257019 1256006 1255278 1251994 1261951 1253673 1260402 1266452 1268817 1267091 1270686 1271199 1266918 1268770 1263503 1256423 1263601 1257612 1262804 1263777 1271036 1264938 1269371 1261817 1258247 1267312 1259350 1266302 1259485 1264961 1261015 1255200 1271811 1259641 1271310 1256846 1266210 1271212 1265915 1265529
sum_num_inserts_total=161698231
sum_num_deletes_by_thread=1267256 1265654 1269496 1263058 1266866 1266152 1264085 1262407 1268587 1272436 1260765 1259616 1274347 1276252 1273351 1258367 1250545 1270938 1263092 1266425 1254540 1263570 1262362 1258800 1265049 1264978 1262674 1262336 1269832 1262426 1255010 1261477 1264954 1260231 1264308 1262867 1260991 1275556 1263809 1272155 1265069 1267084 1270487 1262942 1268603 1259254 1255022 1264513 1262374 1263396 1254213 1249401 1261561 1267343 1266831 1259506 1270948 1256222 1269242 1264359 1257624 1260107 1255500 1255827 1255770 1263518 1260659 1268802 1265463 1265803 1261275 1265522 1261967 1253278 1263068 1261197 1253845 1269757 1266731 1249202 1271772 1276017 1253682 1272833 1265746 1257871 1254673 1260448 1256198 1257440 1256198 1250392 1260922 1252451 1256946 1268413 1265550 1271443 1270430 1269641 1267085 1272142 1265842 1257957 1263057 1258979 1265349 1262505 1272315 1267683 1268542 1259659 1258072 1268678 1259174 1265704 1259692 1263778 1261784 1256017 1270700 1258443 1269701 1257547 1268752 1269801 1266562 1266536
sum_num_deletes_total=161712027
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2533757 2531947 2537910 2524454 2533652 2531955 2529397 2523981 2534781 2546957 2520959 2520953 2548104 2556321 2548131 2517606 2500877 2541402 2528254 2533795 2506639 2526588 2521374 2517522 2529283 2530774 2524590 2526888 2537448 2524604 2509821 2521243 2528985 2525495 2532785 2525714 2524984 2552370 2528842 2540933 2527609 2531943 2540989 2524846 2536897 2518527 2512568 2526125 2526223 2522758 2508865 2499484 2523733 2536472 2532514 2520141 2541914 2512685 2539329 2526934 2514930 2521470 2510914 2511837 2513954 2526619 2520224 2538176 2531557 2529591 2523163 2530178 2523347 2506351 2525387 2522699 2507440 2540279 2533810 2496918 2542731 2549606 2504698 2544098 2531623 2515494 2512547 2518422 2513217 2513446 2511476 2502386 2522873 2506124 2517348 2534865 2534367 2538534 2541116 2540840 2534003 2540912 2529345 2514380 2526658 2516591 2528153 2526282 2543351 2532621 2537913 2521476 2516319 2535990 2518524 2532006 2519177 2528739 2522799 2511217 2542511 2518084 2541011 2514393 2534962 2541013 2532477 2532065
average_num_operations_total=2526642
stdev_num_operations_total=1054
sum_num_operations_total=323410258
min_num_operations_total=2496918
max_num_operations_total=2556321
first_time_thread_terminate_by_thread=10000094 10000094 10000094 10000096 10000098 10000111 10000095 10000098 10000098 10000097 10000098 10000098 10000097 10000100 10000095 10000097 10000097 10000097 10000097 10000097 10000098 10000098 10000099 10000098 10000097 10000096 10000096 10000097 10000098 10000098 10000097 10000097 10000097 10000097 10000097 10000096 10000098 10000097 10000098 10000098 10000099 10000096 10000096 10000096 10000096 10000097 10000097 10000096 10000094 10000097 10000097 10000107 10000094 10000101 10000096 10000096 10000096 10000101 10000095 10000097 10000099 10000118 10000096 10000096 10000094 10000095 10000096 10000100 10000098 10000095 10000098 10000096 10000098 10000098 10000098 10000098 10000097 10000095 10000096 10000095 10000097 10000097 10000097 10000097 10000099 10000099 10000098 10000099 10000096 10000096 10000098 10000102 10000098 10000098 10000102 10000097 10000097 10000097 10000096 10000096 10000098 10000097 10000097 10000097 10000096 10000094 10000096 10000099 10000096 10000097 10000097 10000100 10000097 10000097 10000097 10000094 10000096 10000096 10000096 10000096 10000096 10000095 10000095 10000096 10000096 10000096 10000096 10000096
min_time_thread_terminate_total=10000094
max_time_thread_terminate_total=10000118
first_time_thread_start_by_thread=4 4 4 4 6 6 6 6 5 5 5 5 5 5 5 5 6 6 6 6 4 4 4 4 6 6 6 6 7 7 7 7 3 3 3 3 5 4 4 5 4 4 4 4 7 7 7 7 6 6 6 6 5 5 5 5 7 7 7 7 8 8 8 8 4 4 4 4 6 6 6 6 5 5 5 5 5 5 5 5 6 6 6 6 4 4 4 4 6 6 6 6 7 7 7 7 3 3 3 3 5 4 4 4 4 4 4 4 7 7 7 7 6 6 6 6 5 5 5 5 7 7 7 7 8 8 8 8
min_time_thread_start_total=3
max_time_thread_start_total=8
sum_duration_all_ops_total=

threads_final_keysum=99923393416852
threads_final_size=9994882
final_keysum=99923393416852
final_size=9994882
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=161698231
total_deletes=161712027
total_updates=323410258
total_queries=0
total_ops=323410258
find_throughput=0
rq_throughput=0
update_throughput=32341025
query_throughput=0
total_throughput=32341025


total find                    : 0
total rq                      : 0
total inserts                 : 161698231
total deletes                 : 161712027
total updates                 : 323410258
total queries                 : 0
total ops                     : 323410258
find throughput               : 0
rq throughput                 : 0
update throughput             : 32341025
query throughput              : 0
total throughput              : 32341025

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=0
total_execution_walltime=12.622s
REALTIME_MAIN_END_PERF_FORMAT=215674.756587835
[time_cmd_output] time_elapsed_sec=12.85, faults_major=0, faults_minor=568917, mem_maxresident_kb=2271444, user_cputime=1566.34, sys_cputime=20.64, percent_cpu=12342%
timeout=false
algorithm=drachsler_pext_bst_lock.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1