__step=000704
__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 50.0 50.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000704.txt
__path_data=data/data000704.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6987356.390358405
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=50
DEL_FRAC=50
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=50.0 50.0
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.039s
prefilling_size=3643657 prefilling_elapsed_millis=1.001s
prefilling_size=3929567 prefilling_elapsed_millis=1.102s
prefilling_size=4197841 prefilling_elapsed_millis=1.202s
prefilling_size=4455098 prefilling_elapsed_millis=1.303s
prefilling_size=4704061 prefilling_elapsed_millis=1.404s
prefilling_size=4936750 prefilling_elapsed_millis=1.504s
prefilling_size=5158795 prefilling_elapsed_millis=1.605s
prefilling_size=5376733 prefilling_elapsed_millis=1.706s
prefilling_size=5579640 prefilling_elapsed_millis=1.807s
prefilling_size=5773459 prefilling_elapsed_millis=1.907s
prefilling_size=5960799 prefilling_elapsed_millis=2.008s
prefilling_size=6136667 prefilling_elapsed_millis=2.109s
prefilling_size=6305740 prefilling_elapsed_millis=2.209s
prefilling_size=6470167 prefilling_elapsed_millis=2.31s
prefilling_size=6624012 prefilling_elapsed_millis=2.41s
prefilling_size=6769964 prefilling_elapsed_millis=2.511s
prefilling_size=6913280 prefilling_elapsed_millis=2.612s
prefilling_size=7045706 prefilling_elapsed_millis=2.712s
prefilling_size=7175916 prefilling_elapsed_millis=2.813s
prefilling_size=7299141 prefilling_elapsed_millis=2.914s
prefilling_size=7414703 prefilling_elapsed_millis=3.014s
prefilling_size=7526340 prefilling_elapsed_millis=3.115s
prefilling_size=7634947 prefilling_elapsed_millis=3.215s
prefilling_size=7736855 prefilling_elapsed_millis=3.316s
prefilling_size=7834258 prefilling_elapsed_millis=3.417s
prefilling_size=7928652 prefilling_elapsed_millis=3.517s
prefilling_size=8017306 prefilling_elapsed_millis=3.618s
prefilling_size=8102989 prefilling_elapsed_millis=3.719s
prefilling_size=8185021 prefilling_elapsed_millis=3.819s
prefilling_size=8261772 prefilling_elapsed_millis=3.92s
prefilling_size=8336893 prefilling_elapsed_millis=4.021s
prefilling_size=8408839 prefilling_elapsed_millis=4.121s
prefilling_size=8475728 prefilling_elapsed_millis=4.222s
prefilling_size=8540827 prefilling_elapsed_millis=4.322s
prefilling_size=8604856 prefilling_elapsed_millis=4.423s
prefilling_size=8664915 prefilling_elapsed_millis=4.524s
prefilling_size=8722514 prefilling_elapsed_millis=4.626s
prefilling_size=8776576 prefilling_elapsed_millis=4.726s
prefilling_size=8827964 prefilling_elapsed_millis=4.827s
prefilling_size=8879113 prefilling_elapsed_millis=4.927s
prefilling_size=8928770 prefilling_elapsed_millis=5.028s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 1071075 keys with 190 threads...
tid=0 thread_prefill_amount=41028 percent_done_estimate=727.8 elapsed_s=5 est_remaining_s=-10 / -5
tid=0 thread_prefill_amount=42080 percent_done_estimate=746.5 elapsed_s=5 est_remaining_s=-10 / -5
tid=0 thread_prefill_amount=43132 percent_done_estimate=765.1 elapsed_s=5 est_remaining_s=-10 / -5
tid=0 thread_prefill_amount=44184 percent_done_estimate=783.8 elapsed_s=5 est_remaining_s=-10 / -5
tid=0 thread_prefill_amount=45236 percent_done_estimate=802.4 elapsed_s=5 est_remaining_s=-10 / -5
timing_elapsed 0.126434s
prefilling_size=10000000 prefilling_elapsed_millis=0.126s
finished prefilling to size 10000000 for expected size 10000000 keysum=100015756849478, performing 47950812 updates; total_prefilling_elapsed_ms=126 ms)
pref_size=10000000
pref_millis=126
prefill_elapsed_ms=127
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6987361.904166283
REALTIME_END_PERF_FORMAT=6987371.904349043

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

tree_stats_numInternalsAtDepth=0
tree_stats_numLeavesAtDepth=1
tree_stats_numNodesAtDepth=1
tree_stats_numKeysAtDepth=9998663
tree_stats_avgDegreeAtDepth=9.99866e+06

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

tree_stats_avgDegreeInternal=0
tree_stats_avgDegreeLeaves=9.99866e+06
tree_stats_avgDegree=9.99866e+06
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=230588 231655 232085 230121 231482 231351 231918 231094 232853 231718 231482 232617 231288 230277 234129 230484 231784 231289 231732 230304 230786 230436 230811 231220 230519 231184 231868 229014 231375 230628 231548 230533 233906 231200 230521 232129 231510 230275 233510 231101 231452 231622 230131 230066 230729 231292 231515 230661 244578 245185 245972 244408 244200 245528 245001 244859 247337 246664 245270 246403 246331 245327 247164 243883 243876 244726 243708 244015 245143 243763 244498 244665 245154 245417 246773 245124 244756 244154 245309 245362 246584 246497 245368 246448 246104 246038 246028 244464 243449 245178 243616 243754 246390 244823 244611 244605 230700 230174 231218 230134 229463 230581 231479 231319 232667 231725 231436 231608 231915 232215 233066 230981 230244 230834 230579 231075 229814 230945 231606 230816 231100 230528 230813 229292 229670 230013 230480 231311 232702 231285 231968 231501 230764 231426 232093 230276 229148 230490 230236 230155 229962 231054 230835 230443 248826 249790 250436 249394 246868 249872 248503 250586 252134 249512 248038 248873 249856 250180 252251 248637 247863 248460 249529 248667 247731 249508 307748 303823 249304 249672 250902 248547 248178 249513 248258 249333 251469 249325 247161 249438 249678 249972 251794 247508 248890 248657 248648 248099 248548 248484
sum_num_inserts_total=45532905
sum_num_deletes_by_thread=230918 230613 232870 231036 231064 231944 232674 231520 233942 230775 231019 232321 232318 231082 233661 230951 231815 231587 230640 230731 230750 231557 232186 231373 230954 231727 232239 228940 230554 231720 232256 232192 232862 230895 231062 231460 231525 230849 233817 229948 232062 231485 230679 231165 230747 231137 231756 231475 245718 245430 245938 244155 245354 244499 245445 244752 247459 246136 246398 245626 246845 246639 246608 244617 244129 244390 243668 244078 245300 244642 245072 245441 244715 245228 245587 243755 244877 244026 245883 244830 246875 246065 246307 246102 246020 245900 246334 244075 243738 244611 243641 244072 244588 244551 245496 245115 231214 231526 232139 229792 230303 231711 231280 231681 232815 231191 230687 230322 231125 231602 231909 230135 230758 230995 230820 230075 229067 230930 232232 230927 230321 231713 231464 230246 229844 230224 230705 231745 232140 231139 230734 230483 232025 231744 231968 230195 229931 230965 230091 230455 229206 230893 231766 231430 248374 250491 251411 247924 245830 249624 249147 249424 252154 248869 248522 249553 250325 249640 251875 248306 248744 248088 250050 248036 248734 249260 308087 304806 249447 249000 251307 248611 248264 249448 248292 248365 251396 249209 247794 248436 250043 248810 252110 248839 248426 248583 248919 247965 247980 248772
sum_num_deletes_total=45547536
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=461506 462268 464955 461157 462546 463295 464592 462614 466795 462493 462501 464938 463606 461359 467790 461435 463599 462876 462372 461035 461536 461993 462997 462593 461473 462911 464107 457954 461929 462348 463804 462725 466768 462095 461583 463589 463035 461124 467327 461049 463514 463107 460810 461231 461476 462429 463271 462136 490296 490615 491910 488563 489554 490027 490446 489611 494796 492800 491668 492029 493176 491966 493772 488500 488005 489116 487376 488093 490443 488405 489570 490106 489869 490645 492360 488879 489633 488180 491192 490192 493459 492562 491675 492550 492124 491938 492362 488539 487187 489789 487257 487826 490978 489374 490107 489720 461914 461700 463357 459926 459766 462292 462759 463000 465482 462916 462123 461930 463040 463817 464975 461116 461002 461829 461399 461150 458881 461875 463838 461743 461421 462241 462277 459538 459514 460237 461185 463056 464842 462424 462702 461984 462789 463170 464061 460471 459079 461455 460327 460610 459168 461947 462601 461873 497200 500281 501847 497318 492698 499496 497650 500010 504288 498381 496560 498426 500181 499820 504126 496943 496607 496548 499579 496703 496465 498768 615835 608629 498751 498672 502209 497158 496442 498961 496550 497698 502865 498534 494955 497874 499721 498782 503904 496347 497316 497240 497567 496064 496528 497256
average_num_operations_total=479370
stdev_num_operations_total=1548
sum_num_operations_total=91080441
min_num_operations_total=457954
max_num_operations_total=615835
first_time_thread_terminate_by_thread=10000318 10000190 10000190 10000186 10000182 10000192 10000182 10000188 10000190 10000189 10000189 10000185 10000192 10000189 10000188 10000186 10000187 10000190 10000192 10000189 10000192 10000205 10000190 10000189 10000192 10000190 10000190 10000192 10000182 10000192 10000182 10000182 10000190 10000190 10000190 10000182 10000188 10000189 10000205 10000186 10000187 10000190 10000185 10000189 10000192 10000186 10000190 10000190 10000191 10000184 10000185 10000193 10000187 10000193 10000189 10000193 10000191 10000193 10000191 10000190 10000192 10000191 10000194 10000183 10000190 10000190 10000191 10000193 10000194 10000193 10000194 10000188 10000191 10000184 10000185 10000188 10000184 10000191 10000188 10000192 10000187 10000193 10000191 10000184 10045879 10000191 10000194 10000186 10000193 10000190 10000191 10000188 10000185 10000193 10000194 10000186 10000191 10000189 10000183 10000182 10000189 10000189 10000182 10000191 10000194 10000189 10000192 10000193 10000191 10000194 10000193 10000189 10000183 10000193 10000182 10000194 10000182 10000193 10000189 10000182 10000191 10000189 10000183 10000182 10000190 10000189 10000182 10000191 10000194 10000183 10000182 10000193 10000191 10000194 10000193 10000189 10000183 10000193 10000194 10000194 10000187 10000194 10000191 10000182 10000190 10000187 10000352 10000185 10000184 10000184 10000187 10000185 10000184 10001677 10000184 10000186 10000184 10000193 10000187 10000186 10000187 10000185 10000187 10000187 10000184 10000192 10000184 10000193 10000188 10000187 10000187 10000184 10000187 10000186 10000187 10000185 10000184 10000186 10000184 10000189 10039242 10000192 10000187 10000184 10000187 10017731 10000186 10000319 10000184 10000188
min_time_thread_terminate_total=10000182
max_time_thread_terminate_total=10045879
first_time_thread_start_by_thread=9 5 5 5 6 5 5 5 5 5 5 5 6 5 5 5 5 5 5 5 5 5 6 6 4 5 5 5 6 5 5 5 5 5 5 5 6 5 5 5 5 5 5 5 5 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 6 6 6 6 5 6 5 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 5 6 5 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 5 6 6 5 6 6 6 6 6 6 6 5 6 6 6 6 6 6 6 6 6 5 6 6 5 6 6 5 6 6 6 6 6 6 6 5 6 6 6 6 6 6 6 6 6
min_time_thread_start_total=4
max_time_thread_start_total=9
sum_duration_all_ops_total=

threads_final_keysum=99982317373690
threads_final_size=9998663
final_keysum=99982317373690
final_size=9998663
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=45532905
total_deletes=45547536
total_updates=91080441
total_queries=0
total_ops=91080441
find_throughput=0
rq_throughput=0
update_throughput=9108044
query_throughput=0
total_throughput=9108044


total find                    : 0
total rq                      : 0
total inserts                 : 45532905
total deletes                 : 45547536
total updates                 : 91080441
total queries                 : 0
total ops                     : 91080441
find throughput               : 0
rq throughput                 : 0
update throughput             : 9108044
query throughput              : 0
total throughput              : 9108044

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=57.572
PAPI_L3_TCM=32.6962
PAPI_TOT_CYC=57714.6
PAPI_TOT_INS=1288.9
garbage=0
total_execution_walltime=15.833s
REALTIME_MAIN_END_PERF_FORMAT=6987372.224249295
[time_cmd_output] time_elapsed_sec=16.04, faults_major=0, faults_minor=428185, mem_maxresident_kb=1656296, user_cputime=2893.23, sys_cputime=13.09, percent_cpu=18115%
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