__step=000954
__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 50.0 50.0 -k 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000954.txt
__path_data=data/data000954.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=218324.413939540
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=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
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


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.021s
prefilling_size=99911 prefilling_elapsed_millis=1s
finished prefilling to size 99912 for expected size 100000 keysum=9980355619, performing 39188713 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=99912
pref_millis=1101
prefill_elapsed_ms=1110
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=1034

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=218325.563021201
REALTIME_END_PERF_FORMAT=218335.563095890

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

tree_stats_computeWalltime=0.091s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 126 239 445 740 1150 1715 2318 2979 3764 4580 5350 6029 6462 6410 5974 5107 4002 2853 1878 1186 708 444 288 188 117 68 42 30 23 12 8 8 8 4 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 8 17 83 184 308 593 910 1171 1561 2045 2528 2985 3426 3608 3650 3231 2703 2012 1320 867 515 320 193 140 89 50 33 18 25 7 4 4 8 2 3
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 127 247 462 823 1334 2023 2911 3889 4935 6141 7395 8557 9447 9836 9582 8757 7233 5556 3890 2506 1575 959 608 381 257 157 92 63 41 37 15 12 12 12 4 3
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 127 247 462 823 1334 2023 2911 3889 4935 6141 7395 8557 9447 9836 9582 8757 7233 5556 3890 2506 1575 959 608 381 257 157 92 63 41 37 15 12 12 12 4 3
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.98438 1.95276 1.90283 1.81818 1.72175 1.65442 1.5912 1.53968 1.50296 1.48166 1.45839 1.43367 1.39944 1.35715 1.32249 1.29044 1.24278 1.21485 1.18665 1.16144 1.15523 1.15937 1.17101 1.15296 1.1811 1.15564 1.15287 1.22826 1.1746 1.34146 1.08108 1.26667 1.33333 1.33333 1 1.25 1

tree_stats_height=43
tree_stats_numInternals=65384
tree_stats_numLeaves=34622
tree_stats_numNodes=100006
tree_stats_numKeys=100006

tree_stats_avgDegreeInternal=1.52952
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.3462
tree_stats_avgKeyDepth=19.5286

tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24384 47424 88704 158016 256128 388416 558912 746688 947520 1179072 1419840 1642944 1813824 1888512 1839744 1681344 1388736 1066752 746880 481152 302400 184128 116736 73152 49344 30144 17664 12096 7872 7104 2880 2304 2304 2304 768 576
tree_stats_sizeInBytes=19201152

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:3 2:0 4:2 8:14 16:30 32:80 64:24650 128:614364 256:590 512:126
    [2^00, 2^01]: 3
    (2^01, 2^02]: 0
    (2^02, 2^03]: 2
    (2^03, 2^04]: 14
    (2^04, 2^05]: 30
    (2^05, 2^06]: 80
    (2^06, 2^07]: 24650
    (2^07, 2^08]: 614364
    (2^08, 2^09]: 590
    (2^09, 2^10]: 126
sum_limbo_reclamation_event_size_total=94883095
count_limbo_reclamation_event_size_by_thread=9997 9997 9997 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9997 9998 9998 9997 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9997 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9997 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=639859
sum_limbo_reclamation_event_count_total=667776
first_thread_announced_epoch_by_thread=22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936 22936
sum_num_inserts_by_thread=3056121 3064765 3054634 3025902 3020821 3067545 3064408 3066447 3072112 3071231 3097456 3032453 3091511 3043589 3028756 3071842 3149445 3159040 3147140 3050420 3109301 3155172 3149150 3095358 3154768 3199203 3188971 3137568 3193939 3192515 3136650 3114051 3004958 3057432 3051122 3045965 3061947 3062485 3007624 3044968 3062075 3061679 3086994 3052223 3157777 3154356 3127812 3153284 3088960 3087856 3083531 3081249 3107591 3198738 3190396 3138770 3097260 3041034 3098739 3095748 3056412 3056783 3056361 3096814
sum_num_inserts_total=198031227
sum_num_deletes_by_thread=3054852 3061516 3056392 3027741 3019439 3067304 3064516 3062459 3074936 3070951 3093390 3028762 3088727 3044095 3028399 3075277 3148230 3156771 3144663 3047124 3109566 3155721 3149684 3097642 3151296 3198639 3192001 3138922 3193664 3194413 3137302 3119397 3005092 3056401 3055025 3049195 3061574 3059273 3012438 3048123 3062961 3060311 3083345 3054194 3155781 3153555 3124029 3154122 3086304 3091336 3086027 3078775 3104354 3197634 3193443 3138552 3098598 3045650 3096423 3099325 3057699 3054968 3056415 3092627
sum_num_deletes_total=198027340
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=6110973 6126281 6111026 6053643 6040260 6134849 6128924 6128906 6147048 6142182 6190846 6061215 6180238 6087684 6057155 6147119 6297675 6315811 6291803 6097544 6218867 6310893 6298834 6193000 6306064 6397842 6380972 6276490 6387603 6386928 6273952 6233448 6010050 6113833 6106147 6095160 6123521 6121758 6020062 6093091 6125036 6121990 6170339 6106417 6313558 6307911 6251841 6307406 6175264 6179192 6169558 6160024 6211945 6396372 6383839 6277322 6195858 6086684 6195162 6195073 6114111 6111751 6112776 6189441
average_num_operations_total=6188415
stdev_num_operations_total=12922
sum_num_operations_total=396058567
min_num_operations_total=6010050
max_num_operations_total=6397842
first_time_thread_terminate_by_thread=10000073 10000073 10000073 10000073 10000073 10000074 10000073 10000073 10000074 10000074 10000074 10000074 10000075 10000075 10000075 10000075 10000074 10000074 10000074 10000074 10000074 10000074 10000074 10000074 10000075 10000075 10000075 10000075 10000073 10000073 10000073 10000073 10000074 10000074 10000074 10000074 10000072 10000072 10000076 10000072 10000073 10000073 10000073 10000075 10000075 10000073 10000073 10000073 10000074 10000074 10000074 10000074 10000075 10000075 10000075 10000075 10000072 10000073 10000073 10000072 10000074 10000074 10000074 10000074
min_time_thread_terminate_total=10000072
max_time_thread_terminate_total=10000076
first_time_thread_start_by_thread=4 4 4 4 3 4 3 3 4 4 4 4 5 5 5 4 7 7 7 7 5 5 5 5 5 5 5 5 7 7 7 7 4 4 4 4 6 6 6 6 5 5 5 5 6 6 6 6 7 7 7 7 6 6 6 6 3 3 3 3 6 6 6 6
min_time_thread_start_total=3
max_time_thread_start_total=7
sum_duration_all_ops_total=

threads_final_keysum=9998677219
threads_final_size=100006
final_keysum=9998677219
final_size=100006
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=198031227
total_deletes=198027340
total_updates=396058567
total_queries=0
total_ops=396058567
find_throughput=0
rq_throughput=0
update_throughput=39605856
query_throughput=0
total_throughput=39605856


total find                    : 0
total rq                      : 0
total inserts                 : 198031227
total deletes                 : 198027340
total updates                 : 396058567
total queries                 : 0
total ops                     : 396058567
find throughput               : 0
rq throughput                 : 0
update throughput             : 39605856
query throughput              : 0
total throughput              : 39605856

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=0
total_execution_walltime=11.337s
REALTIME_MAIN_END_PERF_FORMAT=218335.751559697
[time_cmd_output] time_elapsed_sec=11.43, faults_major=0, faults_minor=82982, mem_maxresident_kb=332972, user_cputime=733.25, sys_cputime=4.51, percent_cpu=6449%
timeout=false
algorithm=drachsler_pext_bst_lock.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2