__step=000030
__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 144 -nprefill 144 -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=data000030.txt
__path_data=data/data000030.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6979073.240596984
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=144
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=144
WORK_THREADS=144
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


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.028s
prefilling_size=3842899 prefilling_elapsed_millis=1.001s
prefilling_size=4133835 prefilling_elapsed_millis=1.101s
prefilling_size=4415407 prefilling_elapsed_millis=1.202s
prefilling_size=4679328 prefilling_elapsed_millis=1.302s
prefilling_size=4935148 prefilling_elapsed_millis=1.403s
prefilling_size=5172933 prefilling_elapsed_millis=1.503s
prefilling_size=5403459 prefilling_elapsed_millis=1.604s
prefilling_size=5620665 prefilling_elapsed_millis=1.704s
prefilling_size=5829832 prefilling_elapsed_millis=1.805s
prefilling_size=6025921 prefilling_elapsed_millis=1.905s
prefilling_size=6216130 prefilling_elapsed_millis=2.006s
prefilling_size=6394858 prefilling_elapsed_millis=2.106s
prefilling_size=6568491 prefilling_elapsed_millis=2.207s
prefilling_size=6728824 prefilling_elapsed_millis=2.307s
prefilling_size=6886412 prefilling_elapsed_millis=2.408s
prefilling_size=7032833 prefilling_elapsed_millis=2.509s
prefilling_size=7175185 prefilling_elapsed_millis=2.609s
prefilling_size=7308958 prefilling_elapsed_millis=2.71s
prefilling_size=7439065 prefilling_elapsed_millis=2.81s
prefilling_size=7560763 prefilling_elapsed_millis=2.911s
prefilling_size=7676265 prefilling_elapsed_millis=3.011s
prefilling_size=7786804 prefilling_elapsed_millis=3.112s
prefilling_size=7892340 prefilling_elapsed_millis=3.212s
prefilling_size=7992765 prefilling_elapsed_millis=3.313s
prefilling_size=8089541 prefilling_elapsed_millis=3.413s
prefilling_size=8180451 prefilling_elapsed_millis=3.514s
prefilling_size=8267103 prefilling_elapsed_millis=3.614s
prefilling_size=8349814 prefilling_elapsed_millis=3.715s
prefilling_size=8428956 prefilling_elapsed_millis=3.815s
prefilling_size=8504351 prefilling_elapsed_millis=3.916s
prefilling_size=8575322 prefilling_elapsed_millis=4.016s
prefilling_size=8642463 prefilling_elapsed_millis=4.117s
prefilling_size=8707927 prefilling_elapsed_millis=4.217s
prefilling_size=8770231 prefilling_elapsed_millis=4.318s
prefilling_size=8828580 prefilling_elapsed_millis=4.418s
prefilling_size=8884779 prefilling_elapsed_millis=4.518s
prefilling_size=8938396 prefilling_elapsed_millis=4.619s
prefilling_size=8988779 prefilling_elapsed_millis=4.719s
prefilling_size=9037173 prefilling_elapsed_millis=4.82s
prefilling_size=9083562 prefilling_elapsed_millis=4.92s
prefilling_size=9127271 prefilling_elapsed_millis=5.021s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 872564 keys with 144 threads...
tid=0 thread_prefill_amount=68012 percent_done_estimate=1122.4 elapsed_s=5 est_remaining_s=-11 / -5
tid=0 thread_prefill_amount=69400 percent_done_estimate=1145.3 elapsed_s=5 est_remaining_s=-11 / -5
tid=0 thread_prefill_amount=70788 percent_done_estimate=1168.2 elapsed_s=5 est_remaining_s=-11 / -6
tid=0 thread_prefill_amount=72176 percent_done_estimate=1191.1 elapsed_s=5 est_remaining_s=-11 / -6
tid=0 thread_prefill_amount=73564 percent_done_estimate=1214.0 elapsed_s=5 est_remaining_s=-11 / -6
timing_elapsed 0.102052s
prefilling_size=10000000 prefilling_elapsed_millis=0.102s
finished prefilling to size 10000000 for expected size 10000000 keysum=99992394627584, performing 50385255 updates; total_prefilling_elapsed_ms=102 ms)
pref_size=10000000
pref_millis=102
prefill_elapsed_ms=102
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6979078.692168820
REALTIME_END_PERF_FORMAT=6979088.692258896

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

tree_stats_numInternalsAtDepth=0
tree_stats_numLeavesAtDepth=1
tree_stats_numNodesAtDepth=1
tree_stats_numKeysAtDepth=9997961
tree_stats_avgDegreeAtDepth=9.99796e+06

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

tree_stats_avgDegreeInternal=0
tree_stats_avgDegreeLeaves=9.99796e+06
tree_stats_avgDegree=9.99796e+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=35675 35361 36159 35855 36235 35652 35793 35646 36284 35903 35396 35211 35670 35838 36025 36175 35906 35240 35306 35437 36079 35866 35713 35081 35426 36004 35643 35675 35444 35742 35506 35799 36109 36013 35477 35425 35908 36043 35889 35717 35379 35475 35290 35743 35904 35814 35783 35504 35665 35753 36157 36290 35870 35736 35663 35825 36245 36299 36121 35894 35546 35646 36323 36266 36128 36313 35316 35357 35798 36175 36172 35375 35487 35713 36274 35953 35760 35620 35510 35517 36482 36191 35808 36015 35751 35782 36163 36439 36113 35860 35410 35573 35842 36211 35376 35977 35359 35647 36066 35865 35493 35512 35302 35399 35699 36032 35633 35598 35571 35916 36087 35986 35480 35266 35325 35351 35471 36146 35670 35118 35051 35412 36060 35718 35614 35285 35349 35426 35914 36010 35457 35471 35399 36105 36038 35721 35764 35291 35342 35486 35640 35925 35166 34900
sum_num_inserts_total=5145514
sum_num_deletes_by_thread=35777 35919 35953 35767 35829 35671 35505 35531 36272 36190 36039 35450 35518 35975 36105 36401 35857 35626 35483 35306 36365 35941 35496 35744 35389 35476 36383 36109 35577 35591 35435 35479 36006 36116 35892 35750 35560 36070 36141 36040 35811 35395 35419 35627 35928 36171 35803 34968 35618 36196 36119 36479 36108 35779 35724 35719 36001 36119 36246 36049 35807 35915 36119 36391 35999 35800 35299 35767 36032 36241 35818 35358 35614 35626 36055 36130 36039 35827 35937 35602 35925 36090 35774 35818 35617 36108 36162 36013 35789 35576 35321 35591 35808 35918 35789 35314 35363 35485 35609 36057 35783 35512 35126 35612 35979 36138 35886 35363 35833 35770 35851 36121 35758 35278 35372 35019 35985 36023 35404 35181 35049 35506 36068 35809 35382 35394 35558 35613 35609 36268 35818 35239 35280 35649 36347 35810 35702 35565 35326 35370 35666 35815 35366 34903
sum_num_deletes_total=5149622
sum_num_searches_by_thread=7043106 7080011 7119276 7117359 7109587 7045354 7039622 7066057 7151518 7158794 7060405 7023774 7056871 7110329 7160338 7155093 7101895 7060623 7015512 7031410 7084449 7117912 7048707 7001845 7054148 7082213 7123443 7114789 7111568 7043767 7040548 7052275 7147045 7154565 7061188 7026982 7054196 7106185 7150812 7148219 7095255 7056277 7009055 7027975 7078192 7105680 7037268 6993057 7044030 7107254 7143752 7153892 7103208 7060299 7050729 7080849 7152876 7177097 7129498 7078732 7079808 7115899 7153424 7177559 7142030 7068522 7008992 7045392 7114271 7139507 7084214 7056895 7057098 7100060 7152078 7160370 7107041 7070560 7046805 7085139 7157325 7177015 7134914 7087058 7086202 7119989 7156615 7176325 7139158 7070343 7000720 7039803 7104755 7137393 7076941 7052873 6991707 7031124 7083875 7083367 7039155 6987491 7002116 7025659 7099941 7125387 7067992 6989562 7033067 7074899 7111686 7125780 7063950 6996217 6983964 7008833 7043776 7084481 7021409 6951421 6994249 7039785 7087570 7088700 7044214 6993403 6999550 7030238 7097240 7118812 7065884 6987270 7031879 7073161 7111325 7128991 7063916 6996660 6985435 7015205 7042666 7087903 7018492 6951152
sum_num_searches_total=1018880417
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=7114558 7151291 7191388 7188981 7181651 7116677 7110920 7137234 7224074 7230887 7131840 7094435 7128059 7182142 7232468 7227669 7173658 7131489 7086301 7102153 7156893 7189719 7119916 7072670 7124963 7153693 7195469 7186573 7182589 7115100 7111489 7123553 7219160 7226694 7132557 7098157 7125664 7178298 7222842 7219976 7166445 7127147 7079764 7099345 7150024 7177665 7108854 7063529 7115313 7179203 7216028 7226661 7175186 7131814 7122116 7152393 7225122 7249515 7201865 7150675 7151161 7187460 7225866 7250216 7214157 7140635 7079607 7116516 7186101 7211923 7156204 7127628 7128199 7171399 7224407 7232453 7178840 7142007 7118252 7156258 7229732 7249296 7206496 7158891 7157570 7191879 7228940 7248777 7211060 7141779 7071451 7110967 7176405 7209522 7148106 7124164 7062429 7102256 7155550 7155289 7110431 7058515 7072544 7096670 7171619 7197557 7139511 7060523 7104471 7146585 7183624 7197887 7135188 7066761 7054661 7079203 7115232 7156650 7092483 7021720 7064349 7110703 7159698 7160227 7115210 7064082 7070457 7101277 7168763 7191090 7137159 7057980 7102558 7144915 7183710 7200522 7135382 7067516 7056103 7086061 7113972 7159643 7089024 7020955
average_num_operations_total=7147052
stdev_num_operations_total=4483
sum_num_operations_total=1029175553
min_num_operations_total=7020955
max_num_operations_total=7250216
first_time_thread_terminate_by_thread=10000180 10000089 10000090 10000089 10000091 10000090 10000090 10000090 10000090 10000093 10000090 10000089 10000093 10000089 10000089 10000090 10000089 10000089 10000090 10000093 10000092 10000090 10000090 10000093 10000089 10000089 10000090 10000089 10000089 10000090 10000093 10000090 10000090 10000094 10000090 10000089 10000093 10000089 10000089 10000090 10000089 10000089 10000090 10000093 10000092 10000090 10000090 10000094 10000093 10000094 10000093 10000091 10000094 10000091 10000091 10000091 10000093 10000094 10000091 10000091 10000093 10000093 10000091 10000091 10000094 10000092 10000092 10000093 10000093 10000093 10000092 10000093 10000093 10000094 10000093 10000091 10000094 10000091 10000091 10000091 10000093 10000094 10000091 10000091 10000093 10000093 10000091 10000091 10000094 10000091 10000092 10000093 10000093 10000093 10000092 10000093 10000092 10000092 10000090 10000091 10000092 10000091 10000091 10000091 10000092 10000093 10000096 10000091 10000092 10000092 10000091 10000091 10000091 10000090 10000090 10000092 10000091 10000093 10000091 10000091 10000092 10000092 10000090 10000091 10000092 10000091 10000091 10000091 10000092 10000093 10000091 10000091 10000092 10000091 10000091 10000091 10000091 10000090 10000091 10000092 10000091 10000093 10000091 10000091
min_time_thread_terminate_total=10000089
max_time_thread_terminate_total=10000180
first_time_thread_start_by_thread=9 4 5 5 5 5 5 5 4 5 5 4 4 5 4 4 5 5 5 5 5 4 5 5 4 4 5 5 5 5 5 5 4 5 5 4 4 5 4 4 5 5 5 5 5 4 5 5 5 6 5 5 5 5 5 5 5 5 6 5 5 5 5 5 5 5 6 5 5 5 5 5 5 6 5 5 5 5 5 5 5 5 6 5 5 5 5 5 5 5 6 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5
min_time_thread_start_total=4
max_time_thread_start_total=9
sum_duration_all_ops_total=

threads_final_keysum=99968866752351
threads_final_size=9997961
final_keysum=99968866752351
final_size=9997961
validate_result=success
Validation OK.
Structural validation OK.

total_find=1018880417
total_rq=0
total_inserts=5145514
total_deletes=5149622
total_updates=10295136
total_queries=1018880417
total_ops=1029175553
find_throughput=101888041
rq_throughput=0
update_throughput=1029513
query_throughput=101888041
total_throughput=102917555


total find                    : 1018880417
total rq                      : 0
total inserts                 : 5145514
total deletes                 : 5149622
total updates                 : 10295136
total queries                 : 1018880417
total ops                     : 1029175553
find throughput               : 101888041
rq throughput                 : 0
update throughput             : 1029513
query throughput              : 101888041
total throughput              : 102917555

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=35.1136
PAPI_L3_TCM=15.2683
PAPI_TOT_CYC=3824.5
PAPI_TOT_INS=781.465
garbage=4916907912161886
total_execution_walltime=15.74s
REALTIME_MAIN_END_PERF_FORMAT=6979088.981517209
[time_cmd_output] time_elapsed_sec=15.96, faults_major=0, faults_minor=371436, mem_maxresident_kb=1468836, user_cputime=2195.55, sys_cputime=7.75, percent_cpu=13803%
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