__step=000032
__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 190 -nprefill 190 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000032.txt
__path_data=data/data000032.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6979105.344557605
binary=./wang_openbwtree
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
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=20000000
PREFILL_THREADS=190
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=190
WORK_THREADS=190
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,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,64,65,66,67,68,69,70,71,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,72,73,74,75,76,77,78,79,80,81,82,83,84,85,86,87,88,89,90,91,92,93,94,95,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.047s
prefilling_size=3600837 prefilling_elapsed_millis=1.001s
prefilling_size=3885578 prefilling_elapsed_millis=1.102s
prefilling_size=4154705 prefilling_elapsed_millis=1.203s
prefilling_size=4413242 prefilling_elapsed_millis=1.304s
prefilling_size=4661933 prefilling_elapsed_millis=1.404s
prefilling_size=4895467 prefilling_elapsed_millis=1.505s
prefilling_size=5119226 prefilling_elapsed_millis=1.606s
prefilling_size=5336051 prefilling_elapsed_millis=1.706s
prefilling_size=5540540 prefilling_elapsed_millis=1.807s
prefilling_size=5736224 prefilling_elapsed_millis=1.908s
prefilling_size=5925672 prefilling_elapsed_millis=2.008s
prefilling_size=6104126 prefilling_elapsed_millis=2.109s
prefilling_size=6274508 prefilling_elapsed_millis=2.21s
prefilling_size=6439517 prefilling_elapsed_millis=2.31s
prefilling_size=6596241 prefilling_elapsed_millis=2.411s
prefilling_size=6744609 prefilling_elapsed_millis=2.512s
prefilling_size=6888230 prefilling_elapsed_millis=2.612s
prefilling_size=7034267 prefilling_elapsed_millis=2.721s
prefilling_size=7164207 prefilling_elapsed_millis=2.821s
prefilling_size=7289755 prefilling_elapsed_millis=2.922s
prefilling_size=7407403 prefilling_elapsed_millis=3.022s
prefilling_size=7519305 prefilling_elapsed_millis=3.123s
prefilling_size=7627065 prefilling_elapsed_millis=3.224s
prefilling_size=7729268 prefilling_elapsed_millis=3.324s
prefilling_size=7827800 prefilling_elapsed_millis=3.425s
prefilling_size=7922840 prefilling_elapsed_millis=3.526s
prefilling_size=8013538 prefilling_elapsed_millis=3.626s
prefilling_size=8100399 prefilling_elapsed_millis=3.727s
prefilling_size=8183047 prefilling_elapsed_millis=3.828s
prefilling_size=8261410 prefilling_elapsed_millis=3.928s
prefilling_size=8337619 prefilling_elapsed_millis=4.029s
prefilling_size=8410390 prefilling_elapsed_millis=4.13s
prefilling_size=8479929 prefilling_elapsed_millis=4.23s
prefilling_size=8544221 prefilling_elapsed_millis=4.331s
prefilling_size=8607288 prefilling_elapsed_millis=4.432s
prefilling_size=8667262 prefilling_elapsed_millis=4.533s
prefilling_size=8724636 prefilling_elapsed_millis=4.633s
prefilling_size=8780168 prefilling_elapsed_millis=4.734s
prefilling_size=8832375 prefilling_elapsed_millis=4.835s
prefilling_size=8881026 prefilling_elapsed_millis=4.935s
prefilling_size=8930629 prefilling_elapsed_millis=5.036s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 1069196 keys with 190 threads...
tid=0 thread_prefill_amount=42080 percent_done_estimate=747.8 elapsed_s=5 est_remaining_s=-10 / -5
tid=0 thread_prefill_amount=43132 percent_done_estimate=766.5 elapsed_s=5 est_remaining_s=-10 / -5
tid=0 thread_prefill_amount=44184 percent_done_estimate=785.2 elapsed_s=5 est_remaining_s=-10 / -5
tid=0 thread_prefill_amount=45236 percent_done_estimate=803.9 elapsed_s=5 est_remaining_s=-10 / -5
tid=0 thread_prefill_amount=46288 percent_done_estimate=822.6 elapsed_s=5 est_remaining_s=-11 / -5
timing_elapsed 0.173103s
prefilling_size=10000000 prefilling_elapsed_millis=0.173s
finished prefilling to size 10000000 for expected size 10000000 keysum=99991282613097, performing 47482738 updates; total_prefilling_elapsed_ms=173 ms)
pref_size=10000000
pref_millis=173
prefill_elapsed_ms=173
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6979110.920170266
REALTIME_END_PERF_FORMAT=6979120.920263245

###############################################################################
################################## 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.167s

tree_stats_numInternalsAtDepth=0
tree_stats_numLeavesAtDepth=1
tree_stats_numNodesAtDepth=1
tree_stats_numKeysAtDepth=10003170
tree_stats_avgDegreeAtDepth=1.00032e+07

tree_stats_height=1
tree_stats_numInternals=0
tree_stats_numLeaves=1
tree_stats_numNodes=1
tree_stats_numKeys=10003170

tree_stats_avgDegreeInternal=0
tree_stats_avgDegreeLeaves=1.00032e+07
tree_stats_avgDegree=1.00032e+07
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=31536 31188 31830 31404 31801 31621 31666 32079 32378 31811 31780 31673 32172 31818 32232 32355 32243 31890 31724 31708 31874 32263 31565 31728 31050 31794 31793 31799 31894 31745 31798 31631 32113 32146 31557 31752 31685 31922 32083 32336 31767 31820 31425 31757 31807 31727 31776 31355 32524 32623 32470 32856 32653 32817 32559 32525 33255 33088 32759 32644 32747 32664 33355 32935 32703 32683 32495 32137 32663 33112 32591 32551 32329 32675 32671 32623 32843 32304 32351 32385 32534 32835 32665 33159 32641 32642 32887 33336 32812 32315 32189 32544 32722 33000 32609 32508 32101 32023 32362 32731 32612 32276 32238 32400 32848 32466 32363 31947 32237 32580 32674 32984 32450 32073 31857 32116 32501 32628 32088 32046 31973 32431 32484 32859 32211 32144 32415 32710 32760 32620 32675 31915 32134 32801 32704 32493 32207 31941 31715 32157 32154 32678 32175 31905 33221 33818 33755 33602 33191 33541 33368 33683 33633 33875 33698 33384 33487 33657 33729 33758 33400 33244 33530 33142 33542 33440 36871 36295 33455 33736 33736 33886 33629 33689 33536 33419 33603 34064 33832 33451 33484 33766 34337 33763 33206 33135 33461 33359 33636 33662
sum_num_inserts_total=6199430
sum_num_deletes_by_thread=31121 31522 31783 31781 31789 31663 31726 31373 32159 32084 31901 31732 31645 31869 32207 32182 32254 31761 31271 31719 31926 32051 31546 31405 31430 31949 32244 31721 31900 31766 31649 31475 32138 32245 31942 31501 31572 31564 31983 31966 31752 31741 31373 31367 31895 31909 31811 31585 32360 32846 32532 32885 32881 32407 32375 32684 33363 33032 33169 32517 32611 33064 33012 33165 32899 32617 32310 32736 32906 33153 32549 32392 32486 32601 32777 32846 32466 32224 32534 32403 32806 32987 33054 32820 32721 32511 33046 32989 33065 32254 32403 32448 32453 32454 32815 32675 31807 32224 32518 32340 32413 31652 32098 31993 32540 32852 32348 32325 32656 32290 32875 33062 32219 31803 31880 32217 32456 32611 32056 31946 31959 32447 32417 32626 32270 32103 32316 32243 32445 32645 32437 32005 32553 32474 32308 33203 32286 32191 31805 32062 32512 32526 32268 31909 33274 33220 33987 33857 33769 33926 33165 33816 33468 34142 33507 33557 33280 33515 34060 33898 33045 33354 33413 33155 33424 33464 36648 35977 33539 33952 33827 33903 33838 33448 33118 33481 33394 33910 33490 33373 33162 34011 33889 34226 33297 33206 33680 33324 33606 33608
sum_num_deletes_total=6196645
sum_num_searches_by_thread=6226252 6274648 6305816 6295822 6320064 6262961 6256012 6282861 6354709 6375031 6291016 6268388 6289770 6324780 6346693 6359039 6321750 6296363 6223017 6259131 6289863 6345640 6279342 6235324 6237297 6274828 6298570 6305122 6313170 6263502 6250925 6274846 6342370 6370033 6281292 6264028 6282765 6320388 6340241 6356620 6321566 6292223 6224106 6259290 6282980 6342478 6270054 6233662 6423731 6457194 6494776 6505035 6447371 6427352 6432569 6454995 6540007 6551989 6508204 6475319 6468384 6496696 6540968 6549322 6504372 6429448 6388454 6410502 6492619 6496639 6466773 6432997 6424454 6456470 6494011 6498237 6451931 6431809 6433015 6455116 6537723 6557945 6505568 6477314 6479017 6497023 6545290 6550006 6508197 6431680 6385904 6407486 6488854 6493319 6463479 6425728 6331316 6371919 6415393 6431224 6413168 6355949 6375895 6389233 6466992 6476548 6427380 6360371 6414050 6430634 6479428 6479208 6421669 6333826 6324533 6362309 6411711 6441866 6407088 6332929 6339936 6370770 6412469 6433159 6417768 6362091 6381313 6393349 6464214 6477804 6423949 6359117 6411131 6435767 6480294 6478882 6425935 6337034 6332478 6369327 6408569 6437757 6399833 6329055 6594584 6683422 6679517 6695496 6653623 6637875 6570852 6645920 6680177 6720389 6656795 6632033 6614849 6685122 6727903 6724231 6619795 6590972 6605362 6598896 6642029 6694316 7290561 7205077 6592965 6675384 6675579 6686911 6648501 6636749 6567430 6641750 6674050 6710324 6641393 6619867 6608306 6675019 6720009 6715787 6618626 6582884 6608742 6593009 6631440 6687566
sum_num_searches_total=1227280667
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=6288909 6337358 6369429 6359007 6383654 6326245 6319404 6346313 6419246 6438926 6354697 6331793 6353587 6388467 6411132 6423576 6386247 6360014 6286012 6322558 6353663 6409954 6342453 6298457 6299777 6338571 6362607 6368642 6376964 6327013 6314372 6337952 6406621 6434424 6344791 6327281 6346022 6383874 6404307 6420922 6385085 6355784 6286904 6322414 6346682 6406114 6333641 6296602 6488615 6522663 6559778 6570776 6512905 6492576 6497503 6520204 6606625 6618109 6574132 6540480 6533742 6562424 6607335 6615422 6569974 6494748 6453259 6475375 6558188 6562904 6531913 6497940 6489269 6521746 6559459 6563706 6517240 6496337 6497900 6519904 6603063 6623767 6571287 6543293 6544379 6562176 6611223 6616331 6574074 6496249 6450496 6472478 6554029 6558773 6528903 6490911 6395224 6436166 6480273 6496295 6478193 6419877 6440231 6453626 6532380 6541866 6492091 6424643 6478943 6495504 6544977 6545254 6486338 6397702 6388270 6426642 6476668 6507105 6471232 6396921 6403868 6435648 6477370 6498644 6482249 6426338 6446044 6458302 6529419 6543069 6489061 6423037 6475818 6501042 6545306 6544578 6490428 6401166 6395998 6433546 6473235 6502961 6464276 6392869 6661079 6750460 6747259 6762955 6720583 6705342 6637385 6713419 6747278 6788406 6724000 6698974 6681616 6752294 6795692 6791887 6686240 6657570 6672305 6665193 6708995 6761220 7364080 7277349 6659959 6743072 6743142 6754700 6715968 6703886 6634084 6708650 6741047 6778298 6708715 6686691 6674952 6742796 6788235 6783776 6685129 6649225 6675883 6659692 6698682 6754836
average_num_operations_total=6524614
stdev_num_operations_total=11568
sum_num_operations_total=1239676742
min_num_operations_total=6286012
max_num_operations_total=7364080
first_time_thread_terminate_by_thread=10000213 10000092 10000093 10000098 10000093 10000095 10000093 10000093 10000092 10000098 10000095 10000093 10000093 10000093 10000092 10000095 10000092 10000093 10000095 10000095 10000093 10000093 10000098 10000093 10000093 10000094 10000093 10000098 10000093 10000095 10000093 10000093 10000092 10000098 10000095 10000093 10000093 10000093 10000092 10000095 10000092 10000093 10000095 10000095 10000093 10000093 10000098 10000096 10000095 10000098 10000094 10000097 10000096 10000094 10000093 10000094 10000097 10000099 10000095 10000095 10000096 10000094 10000094 10000098 10000095 10000095 10000095 10000097 10000098 10000097 10000095 10000094 10000095 10000098 10000094 10000097 10000098 10000094 10000093 10000094 10000097 10000099 10000095 10000095 10000096 10000094 10000094 10000098 10000095 10000095 10000095 10000097 10000098 10000097 10000095 10000094 10000092 10000097 10000092 10000093 10000092 10000099 10000092 10000093 10000092 10000092 10000097 10000092 10000094 10000098 10000097 10000092 10000092 10000093 10000092 10000098 10000092 10000092 10000092 10000092 10000092 10000097 10000092 10000093 10000092 10000099 10000092 10000093 10000097 10000092 10000097 10000092 10000094 10000098 10000097 10000092 10000092 10000093 10000092 10000098 10000092 10000092 10000092 10000092 10000098 10000095 10000096 10000098 10000099 10000095 10000099 10000095 10000096 10000094 10000099 10000096 10000094 10000095 10000095 10000096 10000095 10000099 10000095 10000096 10000095 10000095 10000096 10000096 10000098 10000095 10000096 10000098 10000099 10000095 10000099 10000096 10000096 10000099 10000099 10000096 10000094 10000095 10000095 10000096 10007441 10000099 10000095 10000096 10000095 10000095
min_time_thread_terminate_total=10000092
max_time_thread_terminate_total=10007441
first_time_thread_start_by_thread=9 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 6 5 6 6 6 6 5 5 6 6 6 6 6 5 6 6 6 6 6 5 5 6 5 6 6 5 6 6 6 6 5 5 6 6 6 6 6 5 6 6 6 6 6 5 5 6 5 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 5 5 6 6 6 5 6 5 6 6 6 6 5 5 6 6 5 5 6 6 6 6 6 6 5 5 6 6 6 5 6 5 6 6 6 6 5 5 6 6 5 5 6 6 5
min_time_thread_start_total=4
max_time_thread_start_total=9
sum_duration_all_ops_total=

threads_final_keysum=100035740617895
threads_final_size=10003170
final_keysum=100035740617895
final_size=10003170
validate_result=success
Validation OK.
Structural validation OK.

total_find=1227280667
total_rq=0
total_inserts=6199430
total_deletes=6196645
total_updates=12396075
total_queries=1227280667
total_ops=1239676742
find_throughput=122728066
rq_throughput=0
update_throughput=1239607
query_throughput=122728066
total_throughput=123967674


total find                    : 1227280667
total rq                      : 0
total inserts                 : 6199430
total deletes                 : 6196645
total updates                 : 12396075
total queries                 : 1227280667
total ops                     : 1239676742
find throughput               : 122728066
rq throughput                 : 0
update throughput             : 1239607
query throughput              : 122728066
total throughput              : 123967674

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=35.3215
PAPI_L3_TCM=15.3306
PAPI_TOT_CYC=4223.34
PAPI_TOT_INS=786.784
garbage=4777989054958710
total_execution_walltime=15.849s
REALTIME_MAIN_END_PERF_FORMAT=6979121.210470326
[time_cmd_output] time_elapsed_sec=16.08, faults_major=0, faults_minor=400605, mem_maxresident_kb=1584892, user_cputime=2907.39, sys_cputime=11.06, percent_cpu=18144%
timeout=false
algorithm=wang_openbwtree
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2