__step=000250
__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" ./wang_openbwtree -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=data000250.txt
__path_data=data/data000250.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=209827.472094243
binary=./wang_openbwtree
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=wang_openbwtree
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
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.012s
prefilling_size=99870 prefilling_elapsed_millis=1s
finished prefilling to size 99894 for expected size 100000 keysum=9981708799, performing 12765653 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=99894
pref_millis=1101
prefill_elapsed_ms=1114
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=209828.621231713
REALTIME_END_PERF_FORMAT=209838.621321450
###############################################################################
################################## TIME IS UP #################################
###############################################################################
joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################
10.1s
PRODUCING OUTPUT
Open BwTree: createTreeStats iterating over all kv-pairs...
Open BwTree: createTreeStats finished iterating.
tree_stats_computeWalltime=0.002s
tree_stats_numInternalsAtDepth=0
tree_stats_numLeavesAtDepth=1
tree_stats_numNodesAtDepth=1
tree_stats_numKeysAtDepth=100089
tree_stats_avgDegreeAtDepth=100089
tree_stats_height=1
tree_stats_numInternals=0
tree_stats_numLeaves=1
tree_stats_numNodes=1
tree_stats_numKeys=100089
tree_stats_avgDegreeInternal=0
tree_stats_avgDegreeLeaves=100089
tree_stats_avgDegree=100090
tree_stats_avgKeyDepth=0
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0
[2^00, 2^01]: 0
sum_limbo_reclamation_event_size_total=
count_limbo_reclamation_event_size_by_thread=
count_limbo_reclamation_event_size_total=
sum_limbo_reclamation_event_count_total=
first_thread_announced_epoch_by_thread=
sum_num_inserts_by_thread=141683 141548 140775 141230 141574 141928 141846 141432 140607 140611 140666 141928 141272 141662 141313 141900 136173 135788 135714 137048 136434 136039 135666 136734 136331 135866 136151 135401 137039 136481 136556 136526 130399 130850 130807 131219 131671 131752 131467 131777 131299 131137 131769 131264 131438 131872 131000 131425 126315 126900 127015 126963 126822 126996 127000 126959 126826 127807 127228 127391 127284 126480 127237 127220
sum_num_inserts_total=8575511
sum_num_deletes_by_thread=141949 141368 141250 141947 141202 142075 141504 142002 141360 141132 140582 141395 141754 141455 140933 142155 136364 136263 135066 136300 136869 136226 136381 136917 136599 136246 135264 136273 136820 136083 136944 136158 130405 130606 130696 131240 131446 131611 131506 132002 132009 132077 131780 131162 131217 131417 131577 131544 126223 126227 125516 127361 126623 126570 125947 126469 126492 127941 127354 127552 126383 126880 127193 127704
sum_num_deletes_total=8575566
sum_num_searches_by_thread=28119474 28014026 28035770 28053758 28018368 28064598 28105093 28141838 27913973 27867424 27925752 28098677 28066849 28072822 28001991 28098889 26959178 26965191 26887668 26988912 26952400 26977964 26905696 27023070 26995599 26995642 26919844 26864976 27008564 27004286 27027491 27033591 25898230 25906301 25921339 25982742 26001064 26113367 26057551 26102944 25998602 25994811 26018605 26034713 26025674 26031585 26007010 26041644 25036992 25143541 25005358 25100773 25091868 25098685 25093572 25094877 25096682 25232059 25158944 25218754 25168970 25186498 25167657 25182691
sum_num_searches_total=1698323477
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=28403106 28296942 28317795 28336935 28301144 28348601 28388443 28425272 28195940 28149167 28207000 28382000 28349875 28355939 28284237 28382944 27231715 27237242 27158448 27262260 27225703 27250229 27177743 27296721 27268529 27267754 27191259 27136650 27282423 27276850 27300991 27306275 26159034 26167757 26182842 26245201 26264181 26376730 26320524 26366723 26261910 26258025 26282154 26297139 26288329 26294874 26269587 26304613 25289530 25396668 25257889 25355097 25345313 25352251 25346519 25348305 25350000 25487807 25413526 25473697 25422637 25439858 25422087 25437615
average_num_operations_total=26804289
stdev_num_operations_total=139219
sum_num_operations_total=1715474554
min_num_operations_total=25257889
max_num_operations_total=28425272
first_time_thread_terminate_by_thread=10000091 10000091 10000091 10000091 10000089 10000090 10000089 10000090 10000089 10000089 10000089 10000089 10000090 10000090 10000090 10000090 10000093 10000092 10000091 10000091 10000089 10000089 10000089 10000089 10000090 10000090 10000090 10000090 10000090 10000090 10000091 10000090 10000091 10000091 10000091 10000091 10000093 10000093 10000093 10000093 10000092 10000092 10000093 10000093 10000093 10000093 10000092 10000093 10000093 10000093 10000093 10000093 10000095 10000093 10000093 10000093 10000091 10000091 10000091 10000091 10000789 10000092 10000093 10000093
min_time_thread_terminate_total=10000089
max_time_thread_terminate_total=10000789
first_time_thread_start_by_thread=9 9 9 9 11 12 12 12 7 7 7 7 9 8 9 9 9 9 9 9 9 9 9 9 11 11 11 11 8 8 8 8 14 14 14 14 9 9 9 9 10 10 10 10 15 15 15 15 14 14 14 14 8 8 8 8 12 12 12 12 13 13 13 13
min_time_thread_start_total=7
max_time_thread_start_total=15
sum_duration_all_ops_total=
threads_final_keysum=10019592431
threads_final_size=100089
final_keysum=10019592431
final_size=100089
validate_result=success
Validation OK.
Structural validation OK.
total_find=1698323477
total_rq=0
total_inserts=8575511
total_deletes=8575566
total_updates=17151077
total_queries=1698323477
total_ops=1715474554
find_throughput=169832347
rq_throughput=0
update_throughput=1715107
query_throughput=169832347
total_throughput=171547455
total find : 1698323477
total rq : 0
total inserts : 8575511
total deletes : 8575566
total updates : 17151077
total queries : 1698323477
total ops : 1715474554
find throughput : 169832347
rq throughput : 0
update throughput : 1715107
query throughput : 169832347
total throughput : 171547455
elapsed milliseconds : 10000
napping milliseconds overtime : 100
garbage=12069875200245
total_execution_walltime=11.265s
REALTIME_MAIN_END_PERF_FORMAT=209838.738378389
[time_cmd_output] time_elapsed_sec=11.37, faults_major=0, faults_minor=118663, mem_maxresident_kb=407504, user_cputime=714.58, sys_cputime=5.86, percent_cpu=6336%
timeout=false
algorithm=wang_openbwtree
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2