__step=000833
__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 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000833.txt
__path_data=data/data000833.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=216918.100954720
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=2000000
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.022s
prefilling_size=1000252 prefilling_elapsed_millis=1s
finished prefilling to size 1000264 for expected size 1000000 keysum=999864405746, performing 35373593 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=1000264
pref_millis=1101
prefill_elapsed_ms=1117
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=1024

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=216919.251263391
REALTIME_END_PERF_FORMAT=216929.251303097

###############################################################################
################################## TIME IS UP #################################
###############################################################################

joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################

10.1s
PRODUCING OUTPUT
computing tree_stats in PARALLEL...
bounded depth BFS to partition into subtrees for parallel computation (256 threads)...
partitioned into 1930 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.114s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 254 501 965 1792 3222 5444 8787 13502 20043 28263 38083 48894 59957 69647 77326 81522 82007 78979 73131 65425 56335 47153 38034 29614 22160 16255 11434 7878 5260 3372 2078 1077 566 284 127 45 9 3 1 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 2 7 37 138 362 1000 2101 4072 6961 11823 18443 27272 37831 50267 61968 73130 81037 85035 84827 80837 74515 65517 56272 46454 37068 28065 21076 14990 10496 7148 4666 3079 1588 848 441 209 81 15 5 1 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 508 1002 1930 3584 6444 10888 17574 27004 40086 56526 76166 97788 119914 139294 154652 163044 164014 157958 146262 130850 112670 94306 76068 59228 44320 32510 22868 15756 10520 6744 4156 2154 1132 568 254 90 18 6 2 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 2 7 37 138 362 1000 2101 4072 6961 11823 18443 27272 37831 50267 61968 73130 81037 85035 84827 80837 74515 65517 56272 46454 37068 28065 21076 14990 10496 7148 4666 3079 1588 848 441 209 81 15 5 1 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99219 1.98622 1.96307 1.9285 1.899 1.84482 1.80704 1.76829 1.74222 1.70506 1.67373 1.64194 1.61313 1.58081 1.55513 1.52713 1.50297 1.48154 1.46298 1.44731 1.43053 1.41851 1.4033 1.38931 1.37415 1.36676 1.35171 1.3445 1.33384 1.32053 1.30813 1.25914 1.26277 1.25088 1.22359 1.17717 1.1 1.16667 1.16667 1.5 1

tree_stats_height=49
tree_stats_numInternals=999685
tree_stats_numLeaves=999686
tree_stats_numNodes=1999371
tree_stats_numKeys=999686

tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=26.1352

tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8192 16256 32064 61760 114688 206208 348416 562368 864128 1282752 1808832 2437312 3129216 3837248 4457408 4948864 5217408 5248448 5054656 4680384 4187200 3605440 3017792 2434176 1895296 1418240 1040320 731776 504192 336640 215808 132992 68928 36224 18176 8128 2880 576 192 64 64
tree_stats_sizeInBytes=63979872

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:59 4:7 8:14 16:23 32:80 64:132 128:235159 256:396667 512:245 1024:194
    (2^01, 2^02]: 59
    (2^02, 2^03]: 7
    (2^03, 2^04]: 14
    (2^04, 2^05]: 23
    (2^05, 2^06]: 80
    (2^06, 2^07]: 132
    (2^07, 2^08]: 235159
    (2^08, 2^09]: 396667
    (2^09, 2^10]: 245
    (2^10, 2^11]: 194
sum_limbo_reclamation_event_size_total=168830618
count_limbo_reclamation_event_size_by_thread=9887 9880 9885 9886 9887 9887 9886 9886 9885 9885 9885 9879 9886 9885 9885 9886 9886 9885 9881 9880 9878 9885 9887 9883 9886 9886 9884 9883 9880 9881 9880 9881 9884 9883 9880 9883 9883 9883 9885 9885 9884 9886 9884 9886 9886 9886 9885 9883 9884 9885 9884 9880 9887 9885 9884 9886 9885 9886 9886 9886 9886 9881 9878 9885
count_limbo_reclamation_event_size_total=632580
sum_limbo_reclamation_event_count_total=632929
first_thread_announced_epoch_by_thread=21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834 21834
sum_num_inserts_by_thread=2647542 2654729 2651791 2646284 2657438 2657471 2653392 2639743 2628212 2631969 2627073 2618356 2627858 2629215 2618986 2649176 2652499 2648479 2643447 2640955 2641134 2636497 2627363 2621906 2615547 2616893 2609103 2611745 2608715 2644866 2633371 2631622 2650442 2648928 2641462 2646911 2649124 2641171 2634491 2633938 2629926 2634101 2623952 2645356 2648140 2649994 2647108 2645384 2644429 2646250 2629160 2621730 2634173 2632932 2628047 2629748 2636644 2653940 2639436 2646756 2654722 2659386 2651750 2657606
sum_num_inserts_total=168860514
sum_num_deletes_by_thread=2647466 2659391 2653098 2645816 2658497 2656215 2651208 2643237 2625990 2638623 2627222 2618251 2627965 2627336 2618831 2649307 2653843 2652062 2641309 2642363 2642695 2633851 2629212 2622672 2616991 2613331 2611071 2610262 2615000 2642717 2634287 2630686 2651279 2651308 2640982 2642270 2650705 2644795 2635513 2633756 2631584 2632732 2621920 2643725 2645762 2652064 2645149 2643944 2640760 2638837 2628468 2622553 2632566 2631408 2627501 2630520 2633376 2656819 2639441 2648106 2652641 2653269 2650321 2654580
sum_num_deletes_total=168849459
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5295008 5314120 5304889 5292100 5315935 5313686 5304600 5282980 5254202 5270592 5254295 5236607 5255823 5256551 5237817 5298483 5306342 5300541 5284756 5283318 5283829 5270348 5256575 5244578 5232538 5230224 5220174 5222007 5223715 5287583 5267658 5262308 5301721 5300236 5282444 5289181 5299829 5285966 5270004 5267694 5261510 5266833 5245872 5289081 5293902 5302058 5292257 5289328 5285189 5285087 5257628 5244283 5266739 5264340 5255548 5260268 5270020 5310759 5278877 5294862 5307363 5312655 5302071 5312186
average_num_operations_total=5276718
stdev_num_operations_total=3239
sum_num_operations_total=337709973
min_num_operations_total=5220174
max_num_operations_total=5315935
first_time_thread_terminate_by_thread=10000064 10000040 10000091 10000039 10000148 10000041 10000179 10000044 10000075 10000049 10000040 10000089 10000040 10000056 10000162 10000072 10000167 10000131 10000041 10000217 10000040 10000127 10000095 10000040 10000065 10000164 10000039 10000039 10000200 10000160 10000192 10000106 10000050 10000069 10000058 10000069 10000166 10000176 10000140 10000075 10000068 10000177 10000041 10000041 10000039 10000039 10000047 10000194 10000199 10000205 10000201 10000177 10000041 10000120 10000112 10000041 10000178 10000054 10000040 10000070 10000198 10000041 10000161 10000199
min_time_thread_terminate_total=10000039
max_time_thread_terminate_total=10000217
first_time_thread_start_by_thread=4 4 4 4 3 3 3 3 5 5 5 5 4 4 4 4 5 5 5 5 8 8 7 8 5 5 5 5 5 5 5 5 4 4 4 4 6 6 6 6 6 6 6 6 4 4 4 4 8 8 8 8 7 7 7 7 7 6 7 7 6 6 6 6
min_time_thread_start_total=3
max_time_thread_start_total=8
sum_duration_all_ops_total=

threads_final_keysum=1000152282113
threads_final_size=999686
final_keysum=1000152282113
final_size=999686
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=168860514
total_deletes=168849459
total_updates=337709973
total_queries=0
total_ops=337709973
find_throughput=0
rq_throughput=0
update_throughput=33770997
query_throughput=0
total_throughput=33770997


total find                    : 0
total rq                      : 0
total inserts                 : 168860514
total deletes                 : 168849459
total updates                 : 337709973
total queries                 : 0
total ops                     : 337709973
find throughput               : 0
rq throughput                 : 0
update throughput             : 33770997
query throughput              : 0
total throughput              : 33770997

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

garbage=0
total_execution_walltime=11.449s
REALTIME_MAIN_END_PERF_FORMAT=216929.551078157
[time_cmd_output] time_elapsed_sec=11.55, faults_major=0, faults_minor=92621, mem_maxresident_kb=370776, user_cputime=726.66, sys_cputime=10.73, percent_cpu=6379%
timeout=false
algorithm=natarajan_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1