__step=000286
__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 0.5 0.5 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000286.txt
__path_data=data/data000286.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6982224.831852877
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=0.5
DEL_FRAC=0.5
RQ=0
RQSIZE=0
MAXKEY=200000
PREFILL_THREADS=144
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=144
WORK_THREADS=144
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,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.018s
prefilling_size=100296 prefilling_elapsed_millis=1.001s
finished prefilling to size 100251 for expected size 100000 keysum=10026761911, performing 79158436 updates; total_prefilling_elapsed_ms=1103 ms)
pref_size=100251
pref_millis=1103
prefill_elapsed_ms=1124
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=532

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6982226.190199646
REALTIME_END_PERF_FORMAT=6982236.190349389

###############################################################################
################################## 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 837 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 124 237 442 774 1281 1981 2838 3821 4692 5342 5737 6057 6006 5588 4927 4182 3354 2572 1823 1255 851 509 309 159 79 26 3 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 5 15 63 159 325 619 973 1569 2157 2607 2867 3257 3402 3262 3033 2587 2131 1743 1236 869 617 365 240 123 68 25 2 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 125 242 457 837 1440 2306 3457 4794 6261 7499 8344 8924 9263 8990 8189 7215 5941 4703 3566 2491 1720 1126 674 399 202 94 28 3 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 125 242 457 837 1440 2306 3457 4794 6261 7499 8344 8924 9263 8990 8189 7215 5941 4703 3566 2491 1720 1126 674 399 202 94 28 3 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.95312 1.944 1.90909 1.86433 1.7957 1.71181 1.64007 1.56581 1.50897 1.44833 1.40032 1.38195 1.35926 1.32214 1.28932 1.2794 1.2438 1.22707 1.21135 1.18732 1.18667 1.15988 1.14654 1.13353 1.10777 1.07426 1.02128 1 1 1

tree_stats_height=36
tree_stats_numInternals=65097
tree_stats_numLeaves=34321
tree_stats_numNodes=99418
tree_stats_numKeys=99418

tree_stats_avgDegreeInternal=1.52723
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34522
tree_stats_avgKeyDepth=19.0873

tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24000 46464 87744 160704 276480 442752 663744 920448 1202112 1439808 1602048 1713408 1778496 1726080 1572288 1385280 1140672 902976 684672 478272 330240 216192 129408 76608 38784 18048 5376 576 192
tree_stats_sizeInBytes=19088256

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:151512 2:579645 4:628057 8:37170 16:1
    [2^00, 2^01]: 151512
    (2^01, 2^02]: 579645
    (2^02, 2^03]: 628057
    (2^03, 2^04]: 37170
    (2^04, 2^05]: 1
sum_limbo_reclamation_event_size_total=5026717
count_limbo_reclamation_event_size_by_thread=9688 9684 9706 9732 9692 9670 9729 9694 9702 9689 9718 9707 9676 9687 9694 9717 9685 9741 9690 9695 9684 9702 9695 9695 9713 9725 9686 9696 9715 9706 9706 9710 9747 9728 9693 9698 9699 9677 9690 9687 9705 9706 9720 9649 9687 9703 9677 9683 9682 9704 9694 9707 9682 9697 9700 9699 9700 9703 9694 9705 9706 9711 9713 9725 9689 9724 9724 9689 9722 9730 9690 9684 9703 9698 9708 9692 9701 9693 9697 9728 9667 9681 9709 9717 9689 9702 9712 9708 9699 9735 9720 9684 9710 9723 9697 9726 9668 9712 9701 9692 9694 9705 9695 9726 9698 9696 9714 9677 9683 9703 9702 9693 9713 9677 9665 9678 9720 9697 9713 9684 9672 9644 9698 9671 9665 9660 9690 9684 9692 9706 9704 9659 9670 9681 9662 9675 9677 9694 9672 9660 9693 9721 9683 9695
count_limbo_reclamation_event_size_total=1396385
sum_limbo_reclamation_event_count_total=1932048
first_thread_announced_epoch_by_thread=27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898 27898
sum_num_inserts_by_thread=93958 94570 94489 94859 94044 93732 94194 94703 95072 94622 94101 93000 92564 93899 94391 94827 94972 93534 92719 94035 94894 94768 94223 93975 93303 93458 94603 94584 94087 92986 93695 93710 94543 94695 93432 92770 92695 93501 95352 94100 94008 94098 93997 93381 94194 94977 93995 93296 94014 94355 95023 94212 93611 93746 94304 94888 94973 95257 94048 93142 93447 94868 94933 94718 93963 93221 93080 93645 94762 94510 94209 93605 92344 94226 94952 93959 93777 93311 93851 94169 95021 95804 94604 93472 93675 94316 93998 94189 94568 93540 93288 93439 94799 95219 94392 93402 92446 93421 93657 93278 93085 92927 93073 93278 93860 93047 91888 91849 91606 93179 93357 92759 92443 92110 91454 92346 92903 93475 92997 91689 91113 92065 93043 92164 92923 92226 92425 91856 94091 93337 93089 92218 92041 93411 94006 92857 92594 91594 93335 93148 93382 94392 94202 92480
sum_num_inserts_total=13486573
sum_num_deletes_by_thread=94116 95035 94803 95381 93752 93550 94227 94483 94510 94997 94159 93627 93172 93832 94546 94853 95008 93307 93256 94029 94889 95226 94497 93949 93075 93387 94800 94279 93903 93498 94410 93795 94834 94874 93327 93080 93527 93419 95537 94814 94475 93894 92831 92952 93997 94913 93695 93348 93825 94284 95262 94747 93403 93857 93928 94656 95052 95023 94431 93282 93364 94839 95182 94817 94179 93660 93743 93162 94158 94327 93666 93885 93320 93862 94658 94255 93963 93333 93679 93766 95499 95194 94298 93162 93749 94142 95059 94162 94120 93708 94092 93335 95205 95141 93765 93402 92271 92856 93875 93342 93999 92793 92613 92669 93637 93074 92254 92227 91993 92960 93876 92670 92761 91874 91435 91913 92643 93797 92773 92668 91779 91677 92468 91721 92592 91921 92284 92827 94770 94137 93368 91980 92237 92665 94073 92648 93252 92074 93247 93102 93505 93657 94034 92445
sum_num_deletes_total=13492905
sum_num_searches_by_thread=18618930 18723448 18721126 18772295 18647133 18556850 18628344 18768692 18759321 18812094 18606071 18471321 18397253 18597633 18673140 18793860 18770259 18607035 18511633 18643213 18787995 18803290 18628208 18567763 18446141 18505891 18693689 18721004 18626193 18451818 18616123 18623842 18771179 18760487 18490906 18445765 18421579 18556071 18832009 18763293 18667415 18643451 18489140 18466387 18650715 18708392 18613530 18455487 18650336 18651138 18724475 18693970 18513126 18638932 18645843 18780947 18815829 18868559 18712917 18462799 18519944 18772995 18787350 18802556 18663665 18529764 18546240 18521826 18718027 18687102 18613533 18530401 18442585 18613451 18733094 18593534 18575033 18498780 18551005 18541947 18833958 18883808 18752865 18551340 18522570 18623680 18752239 18655588 18632012 18524040 18602449 18564450 18754516 18827596 18656808 18454775 18293760 18384903 18506093 18445409 18466805 18389648 18372349 18434455 18484368 18502883 18283766 18206786 18215527 18439005 18554397 18497108 18323200 18184664 18181490 18237113 18395048 18500529 18397928 18186127 18121653 18197406 18333452 18216618 18337356 18239122 18326276 18383232 18707391 18649012 18473763 18296428 18237851 18393894 18525463 18444033 18367928 18217925 18395236 18460543 18582815 18653554 18569353 18370050
sum_num_searches_total=2671665526
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=18807004 18913053 18910418 18962535 18834929 18744132 18816765 18957878 18948903 19001713 18794331 18657948 18582989 18785364 18862077 18983540 18960239 18793876 18697608 18831277 18977778 18993284 18816928 18755687 18632519 18692736 18883092 18909867 18814183 18638302 18804228 18811347 18960556 18950056 18677665 18631615 18607801 18742991 19022898 18952207 18855898 18831443 18675968 18652720 18838906 18898282 18801220 18642131 18838175 18839777 18914760 18882929 18700140 18826535 18834075 18970491 19005854 19058839 18901396 18649223 18706755 18962702 18977465 18992091 18851807 18716645 18733063 18708633 18906947 18875939 18801408 18717891 18628249 18801539 18922704 18781748 18762773 18685424 18738535 18729882 19024478 19074806 18941767 18737974 18709994 18812138 18941296 18843939 18820700 18711288 18789829 18751224 18944520 19017956 18844965 18641579 18478477 18571180 18693625 18632029 18653889 18575368 18558035 18620402 18671865 18689004 18467908 18390862 18399126 18625144 18741630 18682537 18508404 18368648 18364379 18421372 18580594 18687801 18583698 18370484 18304545 18381148 18518963 18400503 18522871 18423269 18510985 18567915 18896252 18836486 18660220 18480626 18422129 18579970 18713542 18629538 18553774 18401593 18581818 18646793 18769702 18841603 18757589 18554975
average_num_operations_total=18740590
stdev_num_operations_total=14712
sum_num_operations_total=2698645004
min_num_operations_total=18304545
max_num_operations_total=19074806
first_time_thread_terminate_by_thread=10000149 10000149 10000150 10000150 10000149 10000151 10000149 10000151 10000152 10000150 10000151 10000149 10000149 10000152 10000151 10000151 10000149 10000152 10000152 10000151 10000151 10000150 10000152 10000149 10000149 10000149 10000150 10000150 10000149 10000151 10000149 10000151 10000152 10000150 10000151 10000149 10000149 10000152 10000151 10000151 10000149 10000152 10000152 10000151 10000151 10000150 10000152 10000149 10000152 10000149 10000152 10000151 10000149 10000148 10000149 10000150 10000150 10000152 10000150 10000150 10000149 10000150 10000150 10000150 10000150 10000149 10000149 10000149 10000151 10000150 10000149 10000152 10000152 10000149 10000152 10000151 10000153 10000148 10000149 10000150 10000150 10000152 10000150 10000150 10000149 10000150 10000150 10000150 10000150 10000149 10000149 10000149 10000151 10000150 10000149 10000152 10000153 10000151 10000153 10000152 10000148 10000149 10000148 10000149 10000149 10000152 10000148 10000153 10000153 10000151 10000148 10000150 10000153 10000150 10000149 10000149 10000148 10000150 10000152 10000152 10000153 10000151 10000153 10000152 10000148 10000149 10000148 10000149 10000149 10000152 10000148 10000153 10000153 10000151 10000148 10000150 10000153 10000150 10000149 10000149 10000148 10000150 10000152 10000152
min_time_thread_terminate_total=10000148
max_time_thread_terminate_total=10000153
first_time_thread_start_by_thread=4 4 3 4 3 3 4 4 4 3 4 4 3 4 3 4 4 3 4 3 3 4 4 4 4 4 3 4 3 3 4 4 4 3 4 4 3 4 3 4 4 3 4 3 3 4 4 4 3 4 3 4 3 3 4 3 4 4 4 4 4 3 4 4 4 4 3 3 3 4 4 4 3 4 3 4 3 3 4 3 4 4 4 4 4 3 4 4 4 4 3 3 3 4 4 4 4 4 3 4 3 3 3 3 3 3 4 4 3 3 3 4 4 3 3 3 4 3 3 4 4 4 3 4 3 3 3 3 3 3 4 4 3 3 3 4 4 3 3 3 4 3 3 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=9958425648
threads_final_size=99418
final_keysum=9958425648
final_size=99418
validate_result=success
Validation OK.
Structural validation OK.

total_find=2671665526
total_rq=0
total_inserts=13486573
total_deletes=13492905
total_updates=26979478
total_queries=2671665526
total_ops=2698645004
find_throughput=267166552
rq_throughput=0
update_throughput=2697947
query_throughput=267166552
total_throughput=269864500


total find                    : 2671665526
total rq                      : 0
total inserts                 : 13486573
total deletes                 : 13492905
total updates                 : 26979478
total queries                 : 2671665526
total ops                     : 2698645004
find throughput               : 267166552
rq throughput                 : 0
update throughput             : 2697947
query throughput              : 267166552
total throughput              : 269864500

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=4.11596
PAPI_L3_TCM=0.129429
PAPI_TOT_CYC=1483.76
PAPI_TOT_INS=321.995
garbage=133566389857631
total_execution_walltime=11.545s
REALTIME_MAIN_END_PERF_FORMAT=6982236.377874294
[time_cmd_output] time_elapsed_sec=11.68, faults_major=0, faults_minor=90676, mem_maxresident_kb=356128, user_cputime=1626.26, sys_cputime=3.41, percent_cpu=13949%
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=2