__step=000953
__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=data000953.txt
__path_data=data/data000953.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=218312.920339712
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.022s
prefilling_size=99530 prefilling_elapsed_millis=1s
finished prefilling to size 99549 for expected size 100000 keysum=9973100018, performing 38615380 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=99549
pref_millis=1101
prefill_elapsed_ms=1119
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=1036

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=218314.73505270
REALTIME_END_PERF_FORMAT=218324.73569794

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

tree_stats_computeWalltime=0.089s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 118 229 423 748 1257 1952 2803 3707 4512 5077 5377 5510 5537 5310 5082 4613 3936 3137 2317 1545 970 586 354 193 93 42 17 10 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 7 2 18 58 129 308 590 999 1589 2077 2600 2783 2852 2986 2925 2894 2778 2448 2069 1570 1088 691 412 261 151 78 32 11 11 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 125 231 441 806 1386 2260 3393 4706 6101 7154 7977 8293 8389 8296 8007 7507 6714 5585 4386 3115 2058 1277 766 454 244 120 49 21 13 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 125 231 441 806 1386 2260 3393 4706 6101 7154 7977 8293 8389 8296 8007 7507 6714 5585 4386 3115 2058 1277 766 454 244 120 49 21 13 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.95312 1.904 1.91775 1.86848 1.79156 1.72367 1.63761 1.56086 1.50871 1.43304 1.40537 1.36555 1.34716 1.32888 1.3251 1.30286 1.27987 1.24561 1.22363 1.18194 1.16469 1.14917 1.14096 1.13055 1.11233 1.11066 1.05833 1.08163 1.14286 1 1

tree_stats_height=37
tree_stats_numInternals=65584
tree_stats_numLeaves=34419
tree_stats_numNodes=100003
tree_stats_numKeys=100003

tree_stats_avgDegreeInternal=1.52481
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34418
tree_stats_avgKeyDepth=19.3769

tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24000 44352 84672 154752 266112 433920 651456 903552 1171392 1373568 1531584 1592256 1610688 1592832 1537344 1441344 1289088 1072320 842112 598080 395136 245184 147072 87168 46848 23040 9408 4032 2496 384
tree_stats_sizeInBytes=19200576

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:29 2:5 4:4 8:12 16:13 32:49 64:43021 128:595974 256:569 512:126
    [2^00, 2^01]: 29
    (2^01, 2^02]: 5
    (2^02, 2^03]: 4
    (2^03, 2^04]: 12
    (2^04, 2^05]: 13
    (2^05, 2^06]: 49
    (2^06, 2^07]: 43021
    (2^07, 2^08]: 595974
    (2^08, 2^09]: 569
    (2^09, 2^10]: 126
sum_limbo_reclamation_event_size_total=93331928
count_limbo_reclamation_event_size_by_thread=9997 9997 9996 9997 9997 9997 9996 9997 9996 9997 9996 9997 9998 9997 9998 9998 9997 9998 9998 9998 9997 9997 9996 9997 9997 9996 9997 9996 9996 9995 9998 9997 9997 9998 9997 9997 9997 9996 9997 9997 9996 9996 9998 9996 9996 9997 9996 9998 9996 9997 9997 9997 9998 9997 9996 9998 9997 9997 9998 9998 9996 9997 9997 9996
count_limbo_reclamation_event_size_total=639802
sum_limbo_reclamation_event_count_total=664125
first_thread_announced_epoch_by_thread=22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826 22826
sum_num_inserts_by_thread=3022650 3024062 3006677 2998224 3049332 2990293 2985935 3063394 3072538 3013913 3009218 3057403 3032065 3021477 3002396 2993951 2958333 3040053 3031614 3038333 2968909 3070478 3003950 3058456 3010194 3014749 3005412 3044884 2981682 2977959 3023574 3027379 2981411 2986795 3019834 3022828 3083859 3022469 3015617 3077646 3013253 3013741 3050626 3042049 3039318 2976385 3027593 2974669 3003418 3183719 3032291 3176710 3012010 3006850 3067379 3063404 3051871 2994907 3048946 2995612 3011365 3079523 3015407 3082053
sum_num_inserts_total=193773045
sum_num_deletes_by_thread=3021056 3026457 3008435 2996052 3047329 2992678 2984073 3064169 3075270 3010968 3011942 3062998 3035864 3023683 3001036 2996170 2957233 3042766 3032496 3043236 2970157 3072826 3004292 3058988 3013538 3012540 3005898 3043534 2984734 2972754 3022024 3028248 2983508 2986301 3019924 3017963 3083976 3020932 3017470 3075301 3014815 3013384 3049063 3042363 3040743 2975622 3027939 2974243 3005217 3183906 3032391 3171542 3005590 3007658 3064911 3067442 3053548 2992460 3046854 2994457 3011686 3080756 3015422 3080665
sum_num_deletes_total=193781496
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=6043706 6050519 6015112 5994276 6096661 5982971 5970008 6127563 6147808 6024881 6021160 6120401 6067929 6045160 6003432 5990121 5915566 6082819 6064110 6081569 5939066 6143304 6008242 6117444 6023732 6027289 6011310 6088418 5966416 5950713 6045598 6055627 5964919 5973096 6039758 6040791 6167835 6043401 6033087 6152947 6028068 6027125 6099689 6084412 6080061 5952007 6055532 5948912 6008635 6367625 6064682 6348252 6017600 6014508 6132290 6130846 6105419 5987367 6095800 5990069 6023051 6160279 6030829 6162718
average_num_operations_total=6055539
stdev_num_operations_total=10309
sum_num_operations_total=387554541
min_num_operations_total=5915566
max_num_operations_total=6367625
first_time_thread_terminate_by_thread=10000066 10000066 10000066 10000066 10000063 10000063 10000063 10000068 10000067 10000063 10000063 10000063 10000065 10000065 10000065 10000065 10000064 10000064 10000064 10000064 10000065 10000065 10000065 10000065 10000064 10000064 10000064 10000064 10000063 10000063 10000063 10000063 10000066 10000066 10000066 10000066 10000065 10000065 10000065 10000065 10000068 10000068 10000062 10000062 10000064 10000064 10000064 10000064 10000066 10000066 10000066 10000066 10000064 10000064 10000064 10000064 10000063 10000063 10000069 10000063 10000065 10000065 10000065 10000065
min_time_thread_terminate_total=10000062
max_time_thread_terminate_total=10000069
first_time_thread_start_by_thread=2 2 2 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 5 6 6 6 4 5 5 5 5 5 5 5 4 3 4 3 5 5 5 5 4 4 4 4 5 5 5 5 6 6 6 6 4 4 4 4 4 4 4 4 3 2 2 3
min_time_thread_start_total=2
max_time_thread_start_total=6
sum_duration_all_ops_total=

threads_final_keysum=9982697644
threads_final_size=100003
final_keysum=9982697644
final_size=100003
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=193773045
total_deletes=193781496
total_updates=387554541
total_queries=0
total_ops=387554541
find_throughput=0
rq_throughput=0
update_throughput=38755454
query_throughput=0
total_throughput=38755454


total find                    : 0
total rq                      : 0
total inserts                 : 193773045
total deletes                 : 193781496
total updates                 : 387554541
total queries                 : 0
total ops                     : 387554541
find throughput               : 0
rq throughput                 : 0
update throughput             : 38755454
query throughput              : 0
total throughput              : 38755454

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=0
total_execution_walltime=11.331s
REALTIME_MAIN_END_PERF_FORMAT=218324.251856477
[time_cmd_output] time_elapsed_sec=11.43, faults_major=0, faults_minor=83358, mem_maxresident_kb=334216, user_cputime=730.79, sys_cputime=4.56, percent_cpu=6430%
timeout=false
algorithm=drachsler_pext_bst_lock.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1