__step=000162
__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 0.5 0.5 -k 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000162.txt
__path_data=data/data000162.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=208806.99913438
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=0.5
DEL_FRAC=0.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=0.5 0.5
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.021s
prefilling_size=999823 prefilling_elapsed_millis=1s
finished prefilling to size 999813 for expected size 1000000 keysum=1000405279856, performing 35323042 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=999813
pref_millis=1101
prefill_elapsed_ms=1120
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=1029

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=208807.255116666
REALTIME_END_PERF_FORMAT=208817.255206583

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

tree_stats_computeWalltime=0.134s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 127 247 479 883 1584 2757 4594 7367 11215 16426 23168 31481 41069 51380 61578 70356 77598 81740 82063 78909 72517 63729 53819 43632 34536 26596 19494 13947 9504 6262 3984 2552 1650 1027 655 428 303 175 104 60 40 33 22 17 15 6 2 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 7 15 75 182 411 920 1821 3519 6004 9684 14855 21893 30758 41182 52800 63114 73456 81417 85217 85301 81305 73639 64006 52728 42476 33698 25041 18390 12746 8540 5416 3454 2273 1399 882 553 431 246 148 80 47 44 27 19 24 10 3 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 254 494 958 1766 3168 5514 9188 14734 22430 32852 46336 62962 82138 102760 123156 140712 155196 163480 164126 157818 145034 127458 107638 87264 69072 53192 38988 27894 19008 12524 7968 5104 3300 2054 1310 856 606 350 208 120 80 66 44 34 30 12 4 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 1 7 15 75 182 411 920 1821 3519 6004 9684 14855 21893 30758 41182 52800 63114 73456 81417 85217 85301 81305 73639 64006 52728 42476 33698 25041 18390 12746 8540 5416 3454 2273 1399 882 553 431 246 148 80 47 44 27 19 24 10 3 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.99219 1.97244 1.96964 1.92171 1.89694 1.87027 1.83315 1.80181 1.76116 1.73232 1.70522 1.67941 1.65228 1.62553 1.59924 1.57128 1.55147 1.52669 1.50198 1.48078 1.4595 1.43941 1.42225 1.40536 1.39576 1.38505 1.36648 1.35773 1.34072 1.32944 1.31811 1.32028 1.32328 1.31121 1.31889 1.32672 1.35397 1.28878 1.29714 1.28846 1.33333 1.4125 1.33333 1.38636 1.44118 1.2 1.16667 1.25 1

tree_stats_height=56
tree_stats_numInternals=1000258
tree_stats_numLeaves=1000259
tree_stats_numNodes=2000517
tree_stats_numKeys=1000259

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

tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8128 15808 30656 56512 101376 176448 294016 471488 717760 1051264 1482752 2014784 2628416 3288320 3940992 4502784 4966272 5231360 5252032 5050176 4641088 4078656 3444416 2792448 2210304 1702144 1247616 892608 608256 400768 254976 163328 105600 65728 41920 27392 19392 11200 6656 3840 2560 2112 1408 1088 960 384 128 64
tree_stats_sizeInBytes=64016544

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:212080 4:244193 8:43837 16:319 32:17
    (2^01, 2^02]: 212080
    (2^02, 2^03]: 244193
    (2^03, 2^04]: 43837
    (2^04, 2^05]: 319
    (2^05, 2^06]: 17
sum_limbo_reclamation_event_size_total=1955678
count_limbo_reclamation_event_size_by_thread=7886 7881 7847 7835 7836 7881 7881 7859 7955 7846 7867 7850 7860 7818 7790 7814 7818 7878 7769 7745 7845 7875 7872 7793 7837 7789 7784 7830 7813 7621 7776 7743 7855 7760 7873 7874 7818 7853 7831 7853 7837 7791 7704 7765 7847 7816 7762 7758 7849 7853 7851 7813 7786 7897 7827 7724 7830 7741 7828 7756 7776 7789 7785 7850
count_limbo_reclamation_event_size_total=500446
sum_limbo_reclamation_event_count_total=798208
first_thread_announced_epoch_by_thread=27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002 27002
sum_num_inserts_by_thread=38553 38834 38477 38076 38402 38703 38458 38792 38921 38830 38294 39077 38372 37866 38052 37633 38012 37660 37708 37685 38572 38180 38169 38038 37949 38219 38180 38169 38097 37494 37709 37371 37412 37831 38888 38793 38529 38588 38241 38410 38485 38357 37773 37750 37735 37750 37498 37571 38104 38144 38203 38318 38239 38389 38102 37573 37599 37576 37745 37246 37525 37761 38679 38846
sum_num_inserts_total=2440212
sum_num_deletes_by_thread=38891 39231 38190 38246 38360 38803 38471 38472 38999 38488 38648 38500 38319 38109 37721 37713 37591 38012 37357 37223 38396 38595 38353 38143 38179 38112 37885 37999 37945 37761 37726 37186 38041 37383 38692 38963 38712 38643 38197 38299 38571 37985 37492 37599 37432 37924 37467 37582 38681 38250 38201 38066 37659 38537 38265 37780 37842 37787 37872 37397 37588 37648 38344 38325
sum_num_deletes_total=2438848
sum_num_searches_by_thread=7659842 7683537 7641766 7582961 7624070 7696300 7635931 7655522 7665876 7651303 7615248 7605300 7587824 7537308 7488647 7479295 7479119 7465697 7437399 7408109 7627789 7601456 7569759 7567277 7574191 7571976 7533729 7483785 7484429 7449908 7434905 7408714 7479103 7460900 7657210 7629206 7633913 7632532 7590316 7596079 7613990 7568104 7490265 7471941 7486880 7459234 7450354 7431089 7619832 7588702 7562149 7560183 7565539 7564306 7536191 7482085 7468102 7445302 7424106 7409720 7470697 7481285 7657879 7639749
sum_num_searches_total=483035915
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=7737286 7761602 7718433 7659283 7700832 7773806 7712860 7732786 7743796 7728621 7692190 7682877 7664515 7613283 7564420 7554641 7554722 7541369 7512464 7483017 7704757 7678231 7646281 7643458 7650319 7648307 7609794 7559953 7560471 7525163 7510340 7483271 7554556 7536114 7734790 7706962 7711154 7709763 7666754 7672788 7691046 7644446 7565530 7547290 7562047 7534908 7525319 7506242 7696617 7665096 7638553 7636567 7641437 7641232 7612558 7557438 7543543 7520665 7499723 7484363 7545810 7556694 7734902 7716920
average_num_operations_total=7623671
stdev_num_operations_total=10487
sum_num_operations_total=487914975
min_num_operations_total=7483017
max_num_operations_total=7773806
first_time_thread_terminate_by_thread=10000093 10000093 10000093 10000093 10000089 10000089 10000089 10000090 10000090 10000090 10000090 10000090 10000091 10000091 10000091 10000091 10000090 10000090 10000090 10000090 10000091 10000091 10000091 10000091 10000091 10000091 10000091 10000091 10000091 10000091 10000091 10000091 10000089 10000089 10000089 10000089 10000092 10000092 10000092 10000092 10000090 10000090 10000090 10000090 10000092 10000092 10000092 10000092 10000089 10000089 10000089 10000089 10000092 10000092 10000092 10000092 10000093 10000093 10000093 10000093 10000092 10000092 10000092 10000092
min_time_thread_terminate_total=10000089
max_time_thread_terminate_total=10000093
first_time_thread_start_by_thread=8 8 8 8 7 7 7 6 10 10 10 10 10 10 10 10 8 8 8 8 9 9 9 9 11 11 11 11 11 11 11 11 11 12 11 11 10 10 10 10 11 11 11 11 11 11 11 11 9 9 9 9 10 10 10 10 8 8 8 8 8 8 8 8
min_time_thread_start_total=6
max_time_thread_start_total=12
sum_duration_all_ops_total=

threads_final_keysum=999846164168
threads_final_size=1000259
final_keysum=999846164168
final_size=1000259
validate_result=success
Validation OK.
Structural validation OK.

total_find=483035915
total_rq=0
total_inserts=2440212
total_deletes=2438848
total_updates=4879060
total_queries=483035915
total_ops=487914975
find_throughput=48303591
rq_throughput=0
update_throughput=487906
query_throughput=48303591
total_throughput=48791497


total find                    : 483035915
total rq                      : 0
total inserts                 : 2440212
total deletes                 : 2438848
total updates                 : 4879060
total queries                 : 483035915
total ops                     : 487914975
find throughput               : 48303591
rq throughput                 : 0
update throughput             : 487906
query throughput              : 48303591
total throughput              : 48791497

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=48919559847750
total_execution_walltime=11.376s
REALTIME_MAIN_END_PERF_FORMAT=208817.477170132
[time_cmd_output] time_elapsed_sec=11.48, faults_major=0, faults_minor=91667, mem_maxresident_kb=367844, user_cputime=742.17, sys_cputime=5.78, percent_cpu=6513%
timeout=false
algorithm=natarajan_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2