__step=000946
__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" ./natarajan_ext_bst_lf.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=data000946.txt
__path_data=data/data000946.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=218231.243230700
binary=./natarajan_ext_bst_lf.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=natarajan_ext_bst_lf
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=32
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.019s
prefilling_size=99583 prefilling_elapsed_millis=1s
finished prefilling to size 99662 for expected size 100000 keysum=9974956326, performing 40332140 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=99662
pref_millis=1101
prefill_elapsed_ms=1119
6node_tIxPvE_object_size=32
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=1139
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=218232.394981491
REALTIME_END_PERF_FORMAT=218242.395079997
###############################################################################
################################## 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 1286 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.102s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 63 119 213 368 643 1053 1691 2514 3577 4722 6065 7467 8639 9498 9576 9202 8323 7079 5704 4512 3316 2320 1486 879 465 229 95 38 12 3 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 1 7 25 58 93 233 415 868 1451 2432 3379 4663 6295 7780 9420 9950 10081 9567 8454 6896 5708 4312 3154 2093 1293 701 363 152 64 21 5 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 126 238 426 736 1286 2106 3382 5028 7154 9444 12130 14934 17278 18996 19152 18404 16646 14158 11408 9024 6632 4640 2972 1758 930 458 190 76 24 6 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 1 7 25 58 93 233 415 868 1451 2432 3379 4663 6295 7780 9420 9950 10081 9567 8454 6896 5708 4312 3154 2093 1293 701 363 152 64 21 5 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.98438 1.94444 1.89496 1.86385 1.87364 1.81882 1.80294 1.74335 1.71142 1.66005 1.64221 1.61558 1.57848 1.54972 1.50411 1.48047 1.45224 1.42527 1.40288 1.39551 1.36746 1.34982 1.32026 1.29576 1.26451 1.24624 1.20742 1.2 1.15789 1.125 1.16667 1
tree_stats_height=38
tree_stats_numInternals=99935
tree_stats_numLeaves=99936
tree_stats_numNodes=199871
tree_stats_numKeys=99936
tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=21.8182
tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4032 7616 13632 23552 41152 67392 108224 160896 228928 302208 388160 477888 552896 607872 612864 588928 532672 453056 365056 288768 212224 148480 95104 56256 29760 14656 6080 2432 768 192 64
tree_stats_sizeInBytes=6395872
6node_tIxPvE_object_size=32
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=12465
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:54 4:4 8:7 16:26 32:71 64:168 128:223004 256:415997 512:382
(2^01, 2^02]: 54
(2^02, 2^03]: 4
(2^03, 2^04]: 7
(2^04, 2^05]: 26
(2^05, 2^06]: 71
(2^06, 2^07]: 168
(2^07, 2^08]: 223004
(2^08, 2^09]: 415997
(2^09, 2^10]: 382
sum_limbo_reclamation_event_size_total=170795854
count_limbo_reclamation_event_size_by_thread=9996 9997 9996 9995 9995 9995 9994 9997 9995 9995 9996 9997 9994 9997 9995 9996 9996 9994 9994 9997 9995 9993 9997 9996 9995 9995 9996 9995 9994 9993 9994 9995 9996 9996 9995 9998 9995 9997 9996 9995 9996 9997 9997 9996 9996 9994 9996 9994 9996 9994 9998 9995 9994 9998 9995 9997 9995 9993 9995 9996 9997 9996 9994 9997
count_limbo_reclamation_event_size_total=639713
sum_limbo_reclamation_event_count_total=724704
first_thread_announced_epoch_by_thread=24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930 24930
sum_num_inserts_by_thread=3063420 3069236 3043087 3032227 3025262 3022382 3015912 3017455 3019536 3053827 3042186 3037179 3035794 3040558 3031722 3031927 3019408 3003419 2984154 2984520 2977952 2979527 2977232 2966370 3044551 3032728 3023618 3021855 3031877 3032876 3018930 2998386 2991785 2996302 2981913 2979713 2990596 2987844 3034633 3029824 3031461 3035170 3023082 3026695 3020643 3013291 2995424 2991762 2992478 2997155 2998988 2998919 3050932 3053881 3045429 3050073 3060122 3063888 3051786 3066930 3059337 3069450 3064963 3070429
sum_num_inserts_total=193504011
sum_num_deletes_by_thread=3063529 3068639 3047914 3033294 3029164 3018993 3018897 3013391 3016933 3049574 3039992 3036081 3036961 3039270 3033021 3032318 3020348 3003917 2983517 2980273 2981832 2986464 2976801 2971641 3042345 3033651 3027590 3023891 3028436 3031006 3016052 2997238 2991199 2992689 2983415 2982240 2994495 2991187 3033885 3025114 3030378 3033124 3022947 3022600 3016706 3015106 2999651 2993250 2997385 2999963 2996267 2997091 3049614 3054303 3044959 3047516 3064552 3065646 3057793 3063972 3058466 3069868 3064858 3069496
sum_num_deletes_total=193512708
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=6126949 6137875 6091001 6065521 6054426 6041375 6034809 6030846 6036469 6103401 6082178 6073260 6072755 6079828 6064743 6064245 6039756 6007336 5967671 5964793 5959784 5965991 5954033 5938011 6086896 6066379 6051208 6045746 6060313 6063882 6034982 5995624 5982984 5988991 5965328 5961953 5985091 5979031 6068518 6054938 6061839 6068294 6046029 6049295 6037349 6028397 5995075 5985012 5989863 5997118 5995255 5996010 6100546 6108184 6090388 6097589 6124674 6129534 6109579 6130902 6117803 6139318 6129821 6139925
average_num_operations_total=6047136
stdev_num_operations_total=6964
sum_num_operations_total=387016719
min_num_operations_total=5938011
max_num_operations_total=6139925
first_time_thread_terminate_by_thread=10000097 10000097 10000097 10000097 10000098 10000098 10000098 10000098 10000099 10000099 10000099 10000099 10000098 10000098 10000098 10000098 10000097 10000097 10000097 10000097 10000099 10000099 10000099 10000099 10000098 10000098 10000098 10000098 10000099 10000099 10000099 10000099 10000097 10000097 10000097 10000100 10000099 10000099 10000099 10000099 10000097 10000097 10000097 10000097 10000100 10000100 10000100 10000100 10000100 10000100 10000100 10000100 10000097 10000097 10000097 10000098 10000099 10000100 10000099 10000100 10000098 10000098 10000098 10000098
min_time_thread_terminate_total=10000097
max_time_thread_terminate_total=10000100
first_time_thread_start_by_thread=5 5 5 5 3 3 3 3 4 4 4 4 4 4 4 4 5 5 5 5 5 5 5 5 3 3 3 3 2 2 2 2 4 4 4 4 2 2 2 2 6 6 6 6 3 3 3 3 3 3 3 3 5 5 5 5 5 5 5 5 4 4 4 4
min_time_thread_start_total=2
max_time_thread_start_total=6
sum_duration_all_ops_total=
threads_final_keysum=9995965533
threads_final_size=99936
final_keysum=9995965533
final_size=99936
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=193504011
total_deletes=193512708
total_updates=387016719
total_queries=0
total_ops=387016719
find_throughput=0
rq_throughput=0
update_throughput=38701671
query_throughput=0
total_throughput=38701671
total find : 0
total rq : 0
total inserts : 193504011
total deletes : 193512708
total updates : 387016719
total queries : 0
total ops : 387016719
find throughput : 0
rq throughput : 0
update throughput : 38701671
query throughput : 0
total throughput : 38701671
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=0
total_execution_walltime=11.35s
REALTIME_MAIN_END_PERF_FORMAT=218242.594235867
[time_cmd_output] time_elapsed_sec=11.45, faults_major=0, faults_minor=77760, mem_maxresident_kb=311708, user_cputime=729.89, sys_cputime=8.28, percent_cpu=6444%
timeout=false
algorithm=natarajan_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2