__step=000506
__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 5.0 5.0 -k 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000506.txt
__path_data=data/data000506.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=212958.860676692
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=5
DEL_FRAC=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=5.0 5.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.022s
prefilling_size=1000581 prefilling_elapsed_millis=1s
finished prefilling to size 1000588 for expected size 1000000 keysum=1000084529188, performing 35964539 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=1000588
pref_millis=1101
prefill_elapsed_ms=1115
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=937

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=212960.13992928
REALTIME_END_PERF_FORMAT=212970.14075191

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

tree_stats_computeWalltime=0.117s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 124 240 467 897 1681 3043 5217 8494 13107 19173 26443 34716 43228 50712 56295 59431 59500 57039 51410 44088 35757 27812 20157 13984 9222 5708 3343 1795 887 430 178 87 30 12 13 8 3 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 2 4 8 19 69 175 483 1052 2127 3840 6444 9725 14198 19145 23985 28303 31365 32753 33000 30683 27404 22777 18475 13731 9692 6557 4156 2540 1366 692 365 133 75 26 6 8 7 2 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 126 244 475 916 1750 3218 5700 9546 15234 23013 32887 44441 57426 69857 80280 87734 90865 89792 84410 74771 63161 50589 38632 27715 18914 12265 7499 4335 2253 1122 543 220 105 38 19 16 10 3 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 126 244 475 916 1750 3218 5700 9546 15234 23013 32887 44441 57426 69857 80280 87734 90865 89792 84410 74771 63161 50589 38632 27715 18914 12265 7499 4335 2253 1122 543 220 105 38 19 16 10 3 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.96875 1.95238 1.96311 1.94526 1.93122 1.87829 1.82567 1.75947 1.70605 1.65026 1.59592 1.54727 1.51101 1.46371 1.42326 1.39162 1.35829 1.33337 1.30483 1.27676 1.25509 1.23483 1.21388 1.19564 1.17788 1.16089 1.14603 1.13228 1.10565 1.10431 1.10071 1.07735 1.08182 1.07619 1.18421 1.15789 1.125 1 1.33333 1

tree_stats_height=46
tree_stats_numInternals=654859
tree_stats_numLeaves=345394
tree_stats_numNodes=1000253
tree_stats_numKeys=1000253

tree_stats_avgDegreeInternal=1.52743
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34531
tree_stats_avgKeyDepth=23.2385

tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24192 46848 91200 175872 336000 617856 1094400 1832832 2924928 4418496 6314304 8532672 11025792 13412544 15413760 16844928 17446080 17240064 16206720 14356032 12126912 9713088 7417344 5321280 3631488 2354880 1439808 832320 432576 215424 104256 42240 20160 7296 3648 3072 1920 576 384
tree_stats_sizeInBytes=192048576

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:9 2:275 4:17461 8:374243 16:247400 32:137 64:275 128:68
    [2^00, 2^01]: 9
    (2^01, 2^02]: 275
    (2^02, 2^03]: 17461
    (2^03, 2^04]: 374243
    (2^04, 2^05]: 247400
    (2^05, 2^06]: 137
    (2^06, 2^07]: 275
    (2^07, 2^08]: 68
sum_limbo_reclamation_event_size_total=9328502
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998
count_limbo_reclamation_event_size_total=639868
sum_limbo_reclamation_event_count_total=920896
first_thread_announced_epoch_by_thread=30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652 30652
sum_num_inserts_by_thread=445252 450134 443332 445535 441063 439258 439187 438289 439100 435517 431982 445889 365220 363726 363145 363509 440663 441980 436525 430933 434303 429764 430970 427368 407550 417577 418110 416147 441334 440672 435079 438963 434508 432061 427912 428340 426906 431023 428596 445199 443572 442605 438927 438441 438302 438909 437896 433503 367483 366050 364961 362765 417304 415194 429073 428577 440488 442271 439725 442276 360196 359564 358298 359280
sum_num_inserts_total=26958281
sum_num_deletes_by_thread=445234 450637 443089 443711 441521 438627 440292 439777 438845 435418 432556 445528 363989 364726 362998 363198 439691 441749 437281 430796 433121 431196 431101 428140 406721 418096 418891 415188 442091 439048 435916 439207 434222 431871 428537 427663 426731 430133 428307 445353 444443 442558 437939 439270 438686 439685 438883 433187 365701 365186 364931 363038 417241 414890 429708 429170 439901 443367 438894 442574 361220 360345 359534 359491
sum_num_deletes_total=26961038
sum_num_searches_by_thread=8029265 8098947 7981841 8003034 7925977 7896241 7905828 7899564 7900105 7840081 7786980 8035028 6573551 6561908 6545716 6536464 7906366 7951947 7882408 7765440 7798783 7739866 7756476 7706578 7337165 7522311 7530756 7463454 7941397 7922757 7835986 7905911 7829735 7751231 7710660 7707106 7697289 7743679 7715439 8028659 7982271 7958714 7891391 7885755 7901368 7895904 7876730 7792800 6605366 6579629 6573904 6529068 7520175 7474038 7732366 7701894 7921634 7967124 7905977 7964794 6490925 6484958 6471138 6472207
sum_num_searches_total=485252059
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=8919751 8999718 8868262 8892280 8808561 8774126 8785307 8777630 8778050 8711016 8651518 8926445 7302760 7290360 7271859 7263171 8786720 8835676 8756214 8627169 8666207 8600826 8618547 8562086 8151436 8357984 8367757 8294789 8824822 8802477 8706981 8784081 8698465 8615163 8567109 8563109 8550926 8604835 8572342 8919211 8870286 8843877 8768257 8763466 8778356 8774498 8753509 8659490 7338550 7310865 7303796 7254871 8354720 8304122 8591147 8559641 8802023 8852762 8784596 8849644 7212341 7204867 7188970 7190978
average_num_operations_total=8424552
stdev_num_operations_total=73929
sum_num_operations_total=539171378
min_num_operations_total=7188970
max_num_operations_total=8999718
first_time_thread_terminate_by_thread=10000083 10000083 10000083 10000083 10000081 10000082 10000082 10000081 10000084 10000084 10000084 10000084 10000082 10000082 10000082 10000082 10000086 10000086 10000086 10000086 10000085 10000085 10000085 10000084 10000084 10000083 10000084 10000083 10000082 10000082 10000082 10000082 10000085 10000085 10000085 10000085 10000083 10000083 10000083 10000083 10000085 10000085 10000085 10000085 10000083 10000084 10000083 10000084 10000083 10000083 10000083 10000083 10000082 10000082 10000082 10000082 10000084 10000084 10000084 10000084 10000085 10000085 10000085 10000085
min_time_thread_terminate_total=10000081
max_time_thread_terminate_total=10000086
first_time_thread_start_by_thread=6 6 6 6 5 5 5 5 7 7 7 7 6 6 6 6 9 9 9 9 8 8 8 8 7 7 7 7 7 7 7 7 10 10 10 10 9 9 9 9 8 8 8 8 8 9 9 9 9 9 9 9 6 6 6 6 5 5 5 5 5 5 5 5
min_time_thread_start_total=5
max_time_thread_start_total=10
sum_duration_all_ops_total=

threads_final_keysum=999723591893
threads_final_size=1000253
final_keysum=999723591893
final_size=1000253
validate_result=success
Validation OK.
Structural validation OK.

total_find=485252059
total_rq=0
total_inserts=26958281
total_deletes=26961038
total_updates=53919319
total_queries=485252059
total_ops=539171378
find_throughput=48525205
rq_throughput=0
update_throughput=5391931
query_throughput=48525205
total_throughput=53917137


total find                    : 485252059
total rq                      : 0
total inserts                 : 26958281
total deletes                 : 26961038
total updates                 : 53919319
total queries                 : 485252059
total ops                     : 539171378
find throughput               : 48525205
rq throughput                 : 0
update throughput             : 5391931
query throughput              : 48525205
total throughput              : 53917137

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=93755922004020
total_execution_walltime=11.364s
REALTIME_MAIN_END_PERF_FORMAT=212970.225026407
[time_cmd_output] time_elapsed_sec=11.47, faults_major=0, faults_minor=125162, mem_maxresident_kb=501528, user_cputime=739.11, sys_cputime=4.42, percent_cpu=6478%
timeout=false
algorithm=drachsler_pext_bst_lock.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2