__step=000225
__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" ./brown_ext_abtree_lf.debra -nwork 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000225.txt
__path_data=data/data000225.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=209535.72169095
binary=./brown_ext_abtree_lf.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=brown_ext_abtree_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=200000
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
size_node=208
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.016s
prefilling_size=99870 prefilling_elapsed_millis=1s
finished prefilling to size 99832 for expected size 100000 keysum=9982410841, performing 39392259 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=99832
pref_millis=1101
prefill_elapsed_ms=1115
N9abtree_ns4NodeILi11ExEE_object_size=208
N9abtree_ns4NodeILi11ExEE_allocated_count=0
N9abtree_ns4NodeILi11ExEE_allocated_size=0MB
N9abtree_ns4NodeILi11ExEE_get_from_pool=0
N9abtree_ns4NodeILi11ExEE_deallocated=0
N9abtree_ns4NodeILi11ExEE_limbo_count=0
N9abtree_ns4NodeILi11ExEE_limbo_details=0 0 0
global_epoch_counter=1316
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=209536.222946468
REALTIME_END_PERF_FORMAT=209546.223042123
###############################################################################
################################## 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 3017 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.24s
tree_stats_numInternalsAtDepth=1 1 7 53 380 3017 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 19491
tree_stats_numNodesAtDepth=1 1 7 53 380 3017 19491
tree_stats_numKeysAtDepth=0 0 0 0 0 0 99945
tree_stats_avgDegreeAtDepth=1 7 7.57143 7.16981 7.93947 6.46039 5.12775
tree_stats_height=7
tree_stats_numInternals=3459
tree_stats_numLeaves=19491
tree_stats_numNodes=22950
tree_stats_numKeys=99945
tree_stats_avgDegreeInternal=6.63487
tree_stats_avgDegreeLeaves=5.12775
tree_stats_avgDegree=5.3549
tree_stats_avgKeyDepth=6
tree_stats_bytesAtDepth=208 208 1456 11024 79040 627536 4054128
tree_stats_sizeInBytes=4773600
N9abtree_ns4NodeILi11ExEE_object_size=208
N9abtree_ns4NodeILi11ExEE_allocated_count=0
N9abtree_ns4NodeILi11ExEE_allocated_size=0MB
N9abtree_ns4NodeILi11ExEE_get_from_pool=0
N9abtree_ns4NodeILi11ExEE_deallocated=0
N9abtree_ns4NodeILi11ExEE_limbo_count=0
N9abtree_ns4NodeILi11ExEE_limbo_details=0 0 0
global_epoch_counter=57465
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:115751 2:286979 4:182817 8:10570 16:69 32:116 64:4
[2^00, 2^01]: 115751
(2^01, 2^02]: 286979
(2^02, 2^03]: 182817
(2^03, 2^04]: 10570
(2^04, 2^05]: 69
(2^05, 2^06]: 116
(2^06, 2^07]: 4
sum_limbo_reclamation_event_size_total=1800233
count_limbo_reclamation_event_size_by_thread=9474 9501 9498 9424 9475 9465 9454 9465 9389 9427 9245 9375 9279 9399 9253 9376 9327 9329 9354 9363 9280 9291 9326 9289 9193 9226 9193 9175 9149 9281 9298 9303 9249 9321 9235 9256 9214 9248 9120 9252 9109 9160 9095 9323 9216 9303 9241 9272 9235 9315 9254 9245 9166 9281 9260 9312 9321 9483 9412 9488 9513 9547 9544 9440
count_limbo_reclamation_event_size_total=596306
sum_limbo_reclamation_event_count_total=3593501
first_thread_announced_epoch_by_thread=114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930 114930
sum_num_inserts_by_thread=164778 163539 166417 160122 163779 166722 161956 165456 156418 160143 146662 156499 148563 154666 145837 157204 152554 155342 150626 153681 148754 151692 147497 148712 142629 146217 142723 144845 141658 153690 148219 149773 146795 149339 146136 148233 143303 143533 139979 142511 138630 141395 138495 152333 146640 149066 145954 148593 144705 148295 144936 145514 142876 148881 145560 149855 151319 165327 158483 164453 171965 176566 171055 161770
sum_num_inserts_total=9729868
sum_num_deletes_by_thread=164703 163565 167322 160152 163495 166534 160755 165100 156525 159654 146221 156827 148173 154937 145969 156252 152127 156017 149920 153204 148165 151653 147592 149685 142417 146851 142416 142896 142082 153852 148128 151090 146904 149993 146741 148302 143209 143987 140005 142606 137870 141709 138637 152460 146845 148727 146561 148834 144387 149439 145581 144976 143143 148703 146194 149740 151009 163907 156975 164526 171448 176447 172232 161476
sum_num_deletes_total=9727852
sum_num_searches_by_thread=32581444 32391470 33040479 31720652 32413251 33020778 31938960 32798164 31048573 31675606 29038765 31053962 29395211 30681421 28945212 30995618 30182870 30821851 29705619 30322891 29498801 30020638 29189561 29434617 28271278 28998828 28205688 28495296 27948438 30493087 29254682 29819391 28989766 29639166 28975549 29332590 28362708 28439086 27715104 28252536 27309331 27859085 27344155 30117502 28993559 29575416 28996991 29446484 28601000 29605679 28721379 28839687 28398315 29464800 28872566 29759017 29855287 32584967 31244880 32497598 33979223 34870124 33963408 32035926
sum_num_searches_total=1926045986
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=32910925 32718574 33374218 32040926 32740525 33354034 32261671 33128720 31361516 31995403 29331648 31367288 29691947 30991024 29237018 31309074 30487551 31133210 30006165 30629776 29795720 30323983 29484650 29733014 28556324 29291896 28490827 28783037 28232178 30800629 29551029 30120254 29283465 29938498 29268426 29629125 28649220 28726606 27995088 28537653 27585831 28142189 27621287 30422295 29287044 29873209 29289506 29743911 28890092 29903413 29011896 29130177 28684334 29762384 29164320 30058612 30157615 32914201 31560338 32826577 34322636 35223137 34306695 32359172
average_num_operations_total=30398495
stdev_num_operations_total=224847
sum_num_operations_total=1945503706
min_num_operations_total=27585831
max_num_operations_total=35223137
first_time_thread_terminate_by_thread=10000095 10000095 10000095 10000095 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000099 10000099 10000097 10000097 10000097 10000097 10000097 10000097 10000098 10000097 10000096 10000096 10000096 10000096 10000098 10000098 10000098 10000098 10000096 10000096 10000096 10000096 10000096 10000096 10000096 10000096 10000099 10000099 10000099 10000099 10000097 10000097 10000097 10000097 10000095 10000095 10000095 10000095 10000097 10000097 10000097 10000097 10000096 10000096 10000096 10000096 10000095 10000095 10000095 10000095
min_time_thread_terminate_total=10000095
max_time_thread_terminate_total=10000099
first_time_thread_start_by_thread=2 2 2 2 2 2 2 2 3 3 3 3 6 6 6 6 4 4 4 4 7 7 7 7 3 3 3 3 4 4 4 4 5 5 5 5 6 6 6 6 8 8 8 8 7 7 7 7 5 5 5 5 5 5 5 5 7 7 7 7 4 4 4 4
min_time_thread_start_total=2
max_time_thread_start_total=8
sum_duration_all_ops_total=
threads_final_keysum=9996262406
threads_final_size=99945
final_keysum=9996262406
final_size=99945
validate_result=success
Validation OK.
Structural validation OK.
total_find=1926045986
total_rq=0
total_inserts=9729868
total_deletes=9727852
total_updates=19457720
total_queries=1926045986
total_ops=1945503706
find_throughput=192604598
rq_throughput=0
update_throughput=1945772
query_throughput=192604598
total_throughput=194550370
total find : 1926045986
total rq : 0
total inserts : 9729868
total deletes : 9727852
total updates : 19457720
total queries : 1926045986
total ops : 1945503706
find throughput : 192604598
rq throughput : 0
update throughput : 1945772
query throughput : 192604598
total throughput : 194550370
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=25571504258167
total_execution_walltime=11.488s
REALTIME_MAIN_END_PERF_FORMAT=209546.560617123
[time_cmd_output] time_elapsed_sec=11.59, faults_major=0, faults_minor=79534, mem_maxresident_kb=319020, user_cputime=759.43, sys_cputime=4.76, percent_cpu=6592%
timeout=false
algorithm=brown_ext_abtree_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1