__step=000170
__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 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000170.txt
__path_data=data/data000170.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=208898.929870362
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=0.5
DEL_FRAC=0.5
RQ=0
RQSIZE=0
MAXKEY=2000000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=0.5 0.5
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


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.02s
prefilling_size=999992 prefilling_elapsed_millis=1s
finished prefilling to size 999942 for expected size 1000000 keysum=1000191411263, performing 35057013 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=999942
pref_millis=1101
prefill_elapsed_ms=1111
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=928

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=208900.81051542
REALTIME_END_PERF_FORMAT=208910.81146340

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

tree_stats_computeWalltime=0.12s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 503 963 1793 3195 5394 8525 12707 17911 23777 30359 36930 43316 48877 52424 53376 52769 49759 44918 39085 32577 26538 20879 15819 11439 7927 5118 3170 1938 1156 650 343 153 66 29 6 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 6 24 77 213 540 1221 2406 4067 6522 9253 12628 16473 20122 24146 27376 28572 29303 28643 26528 24016 20203 16729 13527 10455 7806 5630 3714 2272 1382 841 505 271 116 49 27 6 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 509 987 1870 3408 5934 9746 15113 21978 30299 39612 49558 59789 68999 76570 80752 81341 79062 73561 65613 56593 46741 37608 29346 21894 15733 10748 6884 4210 2538 1491 848 424 182 78 33 7 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 509 987 1870 3408 5934 9746 15113 21978 30299 39612 49558 59789 68999 76570 80752 81341 79062 73561 65613 56593 46741 37608 29346 21894 15733 10748 6884 4210 2538 1491 848 424 182 78 33 7 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.98828 1.95088 1.91895 1.86364 1.8037 1.7334 1.67597 1.61345 1.56365 1.52262 1.48468 1.46126 1.42956 1.40135 1.36996 1.34631 1.32324 1.30105 1.28133 1.26684 1.25028 1.23684 1.22514 1.20701 1.19613 1.1793 1.16431 1.15107 1.14252 1.13199 1.1328 1.09552 1.0684 1.06593 1.05128 1.0303 1 1

tree_stats_height=46
tree_stats_numInternals=654901
tree_stats_numLeaves=345670
tree_stats_numNodes=1000571
tree_stats_numKeys=1000571

tree_stats_avgDegreeInternal=1.52782
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34547
tree_stats_avgKeyDepth=23.9958

tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24576 49152 97728 189504 359040 654336 1139328 1871232 2901696 4219776 5817408 7605504 9515136 11479488 13247808 14701440 15504384 15617472 15179904 14123712 12597696 10865856 8974272 7220736 5634432 4203648 3020736 2063616 1321728 808320 487296 286272 162816 81408 34944 14976 6336 1344 192
tree_stats_sizeInBytes=192109632

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:217533 2:233457 4:37795 8:246 16:30
    [2^00, 2^01]: 217533
    (2^01, 2^02]: 233457
    (2^02, 2^03]: 37795
    (2^03, 2^04]: 246
    (2^04, 2^05]: 30
sum_limbo_reclamation_event_size_total=927806
count_limbo_reclamation_event_size_by_thread=7910 7840 7882 7958 7734 7703 7715 7788 7746 7730 7783 7657 7695 7699 7679 7682 7616 7721 7567 7652 7689 7720 7618 7721 7773 7633 7698 7644 7564 7598 7647 7625 7682 7754 7711 7698 7752 7698 7771 7678 7720 7545 7568 7622 7714 7566 7634 7729 7688 7693 7675 7667 6966 6947 6828 6822 7642 7577 7640 7637 7694 7684 7725 7647
count_limbo_reclamation_event_size_total=489061
sum_limbo_reclamation_event_count_total=911808
first_thread_announced_epoch_by_thread=30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350 30350
sum_num_inserts_by_thread=44656 44734 44007 44585 42372 42029 42681 42344 42493 42476 42491 41796 41824 41544 41804 41363 41361 40943 40599 42006 41556 42051 41821 42026 42175 41791 41498 41011 40600 40636 40025 40316 41299 41885 42052 41679 42031 41965 42027 42394 41111 40908 40744 40668 40801 40514 40210 42170 42159 42073 41931 41911 34030 33588 33645 32997 41602 41389 41451 41331 41859 43180 42731 42685
sum_num_inserts_total=2644634
sum_num_deletes_by_thread=44743 44468 44031 44659 43031 42571 42496 42554 42625 42621 42212 42105 41808 41827 41548 41400 40956 41186 41025 42044 41922 41800 41836 41804 42113 41444 41926 41031 40871 40848 40300 40368 40821 42285 41903 41708 42374 41977 42094 41857 41356 40509 40368 40836 40683 40434 40441 41932 42013 41586 41738 41799 33825 33984 33471 33252 41301 41104 41393 41440 41784 42832 42696 42534
sum_num_deletes_total=2644503
sum_num_searches_by_thread=8824186 8825452 8706646 8836562 8464344 8438519 8394719 8418002 8438096 8432353 8381992 8344055 8267501 8218922 8219969 8163718 8150023 8120645 8110160 8322564 8321531 8283451 8280913 8286805 8280357 8260012 8177661 8113368 8061538 8057475 7988279 8016489 8113112 8365147 8313183 8298760 8352794 8304928 8295016 8311950 8194279 8084087 8038651 8072177 8062251 8059328 8032032 8335861 8331039 8311787 8266646 8297102 6734134 6718157 6644631 6601339 8165598 8164014 8201508 8245468 8258867 8488991 8438834 8447501
sum_num_searches_total=523755479
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=8913585 8914654 8794684 8925806 8549747 8523119 8479896 8502900 8523214 8517450 8466695 8427956 8351133 8302293 8303321 8246481 8232340 8202774 8191784 8406614 8405009 8367302 8364570 8370635 8364645 8343247 8261085 8195410 8143009 8138959 8068604 8097173 8195232 8449317 8397138 8382147 8437199 8388870 8379137 8396201 8276746 8165504 8119763 8153681 8143735 8140276 8112683 8419963 8415211 8395446 8350315 8380812 6801989 6785729 6711747 6667588 8248501 8246507 8284352 8328239 8342510 8575003 8524261 8532720
average_num_operations_total=8266322
stdev_num_operations_total=55177
sum_num_operations_total=529044616
min_num_operations_total=6667588
max_num_operations_total=8925806
first_time_thread_terminate_by_thread=10000097 10000097 10000097 10000097 10000095 10000097 10000095 10000095 10000096 10000096 10000096 10000097 10000098 10000098 10000098 10000098 10000096 10000096 10000096 10000096 10000100 10000100 10000100 10000100 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000099 10000099 10000099 10000099 10000099 10000099 10000099 10000099 10000096 10000096 10000096 10000096 10000094 10000094 10000094 10000094 10000097 10000097 10000097 10000097 10000098 10000098 10000098 10000098 10000099 10000099 10000099 10000099 10000097 10000097 10000097 10000097
min_time_thread_terminate_total=10000094
max_time_thread_terminate_total=10000100
first_time_thread_start_by_thread=7 7 7 7 7 7 7 7 9 9 9 9 9 9 9 9 6 6 6 6 11 11 11 11 12 12 12 12 7 7 7 7 14 14 14 15 13 13 13 13 14 14 14 14 5 4 4 4 6 6 6 6 8 8 7 8 8 8 8 8 9 9 9 9
min_time_thread_start_total=4
max_time_thread_start_total=15
sum_duration_all_ops_total=

threads_final_keysum=1000445463796
threads_final_size=1000571
final_keysum=1000445463796
final_size=1000571
validate_result=success
Validation OK.
Structural validation OK.

total_find=523755479
total_rq=0
total_inserts=2644634
total_deletes=2644503
total_updates=5289137
total_queries=523755479
total_ops=529044616
find_throughput=52375547
rq_throughput=0
update_throughput=528913
query_throughput=52375547
total_throughput=52904461


total find                    : 523755479
total rq                      : 0
total inserts                 : 2644634
total deletes                 : 2644503
total updates                 : 5289137
total queries                 : 523755479
total ops                     : 529044616
find throughput               : 52375547
rq throughput                 : 0
update throughput             : 528913
query throughput              : 52375547
total throughput              : 52904461

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=58782230415937
total_execution_walltime=11.357s
REALTIME_MAIN_END_PERF_FORMAT=208910.287647598
[time_cmd_output] time_elapsed_sec=11.47, faults_major=0, faults_minor=125053, mem_maxresident_kb=501168, user_cputime=740.49, sys_cputime=4.41, percent_cpu=6492%
timeout=false
algorithm=drachsler_pext_bst_lock.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2