__step=000698
__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 50.0 50.0 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000698.txt
__path_data=data/data000698.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=215202.63824362
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=50
DEL_FRAC=50
RQ=0
RQSIZE=0
MAXKEY=20000000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
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,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=4622333 prefilling_elapsed_millis=1s
prefilling_size=4943347 prefilling_elapsed_millis=1.1s
prefilling_size=5245294 prefilling_elapsed_millis=1.201s
prefilling_size=5530640 prefilling_elapsed_millis=1.301s
prefilling_size=5791835 prefilling_elapsed_millis=1.401s
prefilling_size=6046044 prefilling_elapsed_millis=1.501s
prefilling_size=6283899 prefilling_elapsed_millis=1.601s
prefilling_size=6507521 prefilling_elapsed_millis=1.701s
prefilling_size=6718121 prefilling_elapsed_millis=1.801s
prefilling_size=6914025 prefilling_elapsed_millis=1.901s
prefilling_size=7097779 prefilling_elapsed_millis=2.002s
prefilling_size=7269495 prefilling_elapsed_millis=2.102s
prefilling_size=7427071 prefilling_elapsed_millis=2.202s
prefilling_size=7578343 prefilling_elapsed_millis=2.302s
prefilling_size=7721729 prefilling_elapsed_millis=2.402s
prefilling_size=7853803 prefilling_elapsed_millis=2.502s
prefilling_size=7980599 prefilling_elapsed_millis=2.602s
prefilling_size=8099899 prefilling_elapsed_millis=2.702s
prefilling_size=8213223 prefilling_elapsed_millis=2.802s
prefilling_size=8314728 prefilling_elapsed_millis=2.903s
prefilling_size=8413371 prefilling_elapsed_millis=3.003s
prefilling_size=8507071 prefilling_elapsed_millis=3.103s
prefilling_size=8593366 prefilling_elapsed_millis=3.203s
prefilling_size=8674822 prefilling_elapsed_millis=3.304s
prefilling_size=8753059 prefilling_elapsed_millis=3.404s
prefilling_size=8825088 prefilling_elapsed_millis=3.504s
prefilling_size=8893238 prefilling_elapsed_millis=3.604s
prefilling_size=8958229 prefilling_elapsed_millis=3.704s
prefilling_size=9018057 prefilling_elapsed_millis=3.804s
prefilling_size=9075227 prefilling_elapsed_millis=3.904s
prefilling_size=9129029 prefilling_elapsed_millis=4.004s
prefilling_size=9179442 prefilling_elapsed_millis=4.105s
prefilling_size=9227557 prefilling_elapsed_millis=4.205s
prefilling_size=9273049 prefilling_elapsed_millis=4.305s
prefilling_size=9314378 prefilling_elapsed_millis=4.405s
prefilling_size=9353376 prefilling_elapsed_millis=4.505s
prefilling_size=9391661 prefilling_elapsed_millis=4.605s
prefilling_size=9425797 prefilling_elapsed_millis=4.705s
prefilling_size=9459420 prefilling_elapsed_millis=4.805s
prefilling_size=9490530 prefilling_elapsed_millis=4.906s
prefilling_size=9518658 prefilling_elapsed_millis=5.006s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 481318 keys with 64 threads...
tid=0 thread_prefill_amount=140625 percent_done_estimate=1869.9 elapsed_s=5 est_remaining_s=-11 / -6
tid=0 thread_prefill_amount=143750 percent_done_estimate=1911.4 elapsed_s=5 est_remaining_s=-11 / -6
tid=0 thread_prefill_amount=146875 percent_done_estimate=1953.0 elapsed_s=5 est_remaining_s=-11 / -6
timing_elapsed 0.0587685s
prefilling_size=10000000 prefilling_elapsed_millis=0.061s
finished prefilling to size 10000000 for expected size 10000000 keysum=100011169468053, performing 62441321 updates; total_prefilling_elapsed_ms=61 ms)
pref_size=10000000
pref_millis=61
prefill_elapsed_ms=61
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=215207.274875061
REALTIME_END_PERF_FORMAT=215217.274946880

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

tree_stats_numInternalsAtDepth=0
tree_stats_numLeavesAtDepth=1
tree_stats_numNodesAtDepth=1
tree_stats_numKeysAtDepth=9997649
tree_stats_avgDegreeAtDepth=9.99765e+06

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

tree_stats_avgDegreeInternal=0
tree_stats_avgDegreeLeaves=9.99765e+06
tree_stats_avgDegree=9.99765e+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=948260 947756 947110 941729 948566 947744 947270 945597 949054 947213 946056 946359 949433 947228 946355 944542 943329 943070 941765 938280 943122 942049 941163 938404 944968 942591 941141 940093 944703 943679 942129 939660 933069 933368 929142 927039 932074 933727 929760 927594 934912 932340 932559 928624 934191 934320 931716 929615 929794 930483 927820 926855 930974 931245 927265 926115 928150 930905 928005 927236 930722 929496 927913 926705
sum_num_inserts_total=59984151
sum_num_deletes_by_thread=949549 947786 947186 941907 949450 948076 947923 945040 947148 947017 947489 942829 947195 946720 947309 944680 944683 942292 941020 939413 944549 942841 942556 940094 944667 943575 943033 938800 943815 943891 942408 939729 930840 930201 930099 928502 933108 929673 930825 929004 933061 935333 930670 930923 935102 931932 932494 928560 930258 928937 929943 926077 929461 929875 930439 926597 932565 929782 927206 925777 929197 931477 929920 926683
sum_num_deletes_total=59989191
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=1897809 1895542 1894296 1883636 1898016 1895820 1895193 1890637 1896202 1894230 1893545 1889188 1896628 1893948 1893664 1889222 1888012 1885362 1882785 1877693 1887671 1884890 1883719 1878498 1889635 1886166 1884174 1878893 1888518 1887570 1884537 1879389 1863909 1863569 1859241 1855541 1865182 1863400 1860585 1856598 1867973 1867673 1863229 1859547 1869293 1866252 1864210 1858175 1860052 1859420 1857763 1852932 1860435 1861120 1857704 1852712 1860715 1860687 1855211 1853013 1859919 1860973 1857833 1853388
average_num_operations_total=1874583
stdev_num_operations_total=1936
sum_num_operations_total=119973342
min_num_operations_total=1852712
max_num_operations_total=1898016
first_time_thread_terminate_by_thread=10000112 10000075 10000072 10000074 10000075 10000072 10000072 10000072 10000845 10000074 10000074 10000074 10000072 10000071 10000071 10000071 10000072 10000072 10000072 10000073 10000075 10000075 10000075 10000074 10000073 10000073 10000073 10000074 10000561 10000072 10000075 10000072 10000073 10000074 10000073 10000073 10000073 10000072 10000073 10000073 10000072 10000073 10000072 10000072 10000073 10000073 10000073 10000076 10000075 10000075 10000075 10000075 10000075 10000075 10000075 10000075 10000074 10000074 10000074 10000074 10000075 10000075 10000075 10000074
min_time_thread_terminate_total=10000071
max_time_thread_terminate_total=10000845
first_time_thread_start_by_thread=7 2 2 2 3 3 3 3 6 6 6 6 3 3 3 3 4 4 4 4 3 4 3 4 3 3 3 3 5 5 5 5 4 4 4 4 4 4 4 4 5 5 5 5 5 5 5 5 4 4 4 4 6 6 6 6 5 5 5 5 4 4 4 4
min_time_thread_start_total=2
max_time_thread_start_total=7
sum_duration_all_ops_total=

threads_final_keysum=99960000805548
threads_final_size=9997649
final_keysum=99960000805548
final_size=9997649
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=59984151
total_deletes=59989191
total_updates=119973342
total_queries=0
total_ops=119973342
find_throughput=0
rq_throughput=0
update_throughput=11997334
query_throughput=0
total_throughput=11997334


total find                    : 0
total rq                      : 0
total inserts                 : 59984151
total deletes                 : 59989191
total updates                 : 119973342
total queries                 : 0
total ops                     : 119973342
find throughput               : 0
rq throughput                 : 0
update throughput             : 11997334
query throughput              : 0
total throughput              : 11997334

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

garbage=0
total_execution_walltime=15.587s
REALTIME_MAIN_END_PERF_FORMAT=215217.651454685
[time_cmd_output] time_elapsed_sec=15.75, faults_major=0, faults_minor=308768, mem_maxresident_kb=1215136, user_cputime=970.26, sys_cputime=4.89, percent_cpu=6188%
timeout=false
algorithm=wang_openbwtree
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2