__step=000365
__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 5.0 5.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000365.txt
__path_data=data/data000365.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6983181.244071576
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=5
DEL_FRAC=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=5.0 5.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


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.03s
prefilling_size=3734557 prefilling_elapsed_millis=1.001s
prefilling_size=4019861 prefilling_elapsed_millis=1.101s
prefilling_size=4297112 prefilling_elapsed_millis=1.201s
prefilling_size=4555014 prefilling_elapsed_millis=1.302s
prefilling_size=4806406 prefilling_elapsed_millis=1.402s
prefilling_size=5041428 prefilling_elapsed_millis=1.503s
prefilling_size=5270295 prefilling_elapsed_millis=1.603s
prefilling_size=5484219 prefilling_elapsed_millis=1.704s
prefilling_size=5694193 prefilling_elapsed_millis=1.804s
prefilling_size=5888782 prefilling_elapsed_millis=1.904s
prefilling_size=6078068 prefilling_elapsed_millis=2.005s
prefilling_size=6255806 prefilling_elapsed_millis=2.105s
prefilling_size=6429394 prefilling_elapsed_millis=2.206s
prefilling_size=6592234 prefilling_elapsed_millis=2.306s
prefilling_size=6749958 prefilling_elapsed_millis=2.407s
prefilling_size=6896300 prefilling_elapsed_millis=2.507s
prefilling_size=7038267 prefilling_elapsed_millis=2.608s
prefilling_size=7173389 prefilling_elapsed_millis=2.708s
prefilling_size=7303937 prefilling_elapsed_millis=2.808s
prefilling_size=7424797 prefilling_elapsed_millis=2.909s
prefilling_size=7543023 prefilling_elapsed_millis=3.009s
prefilling_size=7653040 prefilling_elapsed_millis=3.11s
prefilling_size=7761890 prefilling_elapsed_millis=3.21s
prefilling_size=7862309 prefilling_elapsed_millis=3.311s
prefilling_size=7958442 prefilling_elapsed_millis=3.411s
prefilling_size=8049504 prefilling_elapsed_millis=3.512s
prefilling_size=8138543 prefilling_elapsed_millis=3.612s
prefilling_size=8222457 prefilling_elapsed_millis=3.712s
prefilling_size=8303711 prefilling_elapsed_millis=3.813s
prefilling_size=8379065 prefilling_elapsed_millis=3.913s
prefilling_size=8452448 prefilling_elapsed_millis=4.014s
prefilling_size=8522591 prefilling_elapsed_millis=4.114s
prefilling_size=8589709 prefilling_elapsed_millis=4.215s
prefilling_size=8652718 prefilling_elapsed_millis=4.315s
prefilling_size=8714905 prefilling_elapsed_millis=4.415s
prefilling_size=8772847 prefilling_elapsed_millis=4.516s
prefilling_size=8828938 prefilling_elapsed_millis=4.616s
prefilling_size=8879687 prefilling_elapsed_millis=4.717s
prefilling_size=8930848 prefilling_elapsed_millis=4.817s
prefilling_size=8978416 prefilling_elapsed_millis=4.917s
prefilling_size=9026027 prefilling_elapsed_millis=5.018s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 973902 keys with 144 threads...
tid=0 thread_prefill_amount=63848 percent_done_estimate=944.0 elapsed_s=5 est_remaining_s=-10 / -5
tid=0 thread_prefill_amount=65236 percent_done_estimate=964.6 elapsed_s=5 est_remaining_s=-10 / -5
tid=0 thread_prefill_amount=66624 percent_done_estimate=985.1 elapsed_s=5 est_remaining_s=-11 / -5
tid=0 thread_prefill_amount=68012 percent_done_estimate=1005.6 elapsed_s=5 est_remaining_s=-11 / -5
tid=0 thread_prefill_amount=69400 percent_done_estimate=1026.1 elapsed_s=5 est_remaining_s=-11 / -5
timing_elapsed 0.110817s
prefilling_size=10000000 prefilling_elapsed_millis=0.111s
finished prefilling to size 10000000 for expected size 10000000 keysum=100004687195625, performing 48918944 updates; total_prefilling_elapsed_ms=111 ms)
pref_size=10000000
pref_millis=111
prefill_elapsed_ms=111
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6983186.764164699
REALTIME_END_PERF_FORMAT=6983196.764264445

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

tree_stats_numInternalsAtDepth=0
tree_stats_numLeavesAtDepth=1
tree_stats_numNodesAtDepth=1
tree_stats_numKeysAtDepth=9991593
tree_stats_avgDegreeAtDepth=9.99159e+06

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

tree_stats_avgDegreeInternal=0
tree_stats_avgDegreeLeaves=9.99159e+06
tree_stats_avgDegree=9.99159e+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=125635 125502 125907 123412 123735 124018 125594 125904 126063 124122 124906 124154 125869 125489 125356 124006 124992 124159 125759 125495 126221 124449 124151 123671 125322 125780 125803 123693 123622 123544 125255 126566 125874 124929 124734 124126 126255 125291 125864 123831 124467 123982 125272 125427 126381 124683 123919 123276 160310 161187 161591 159108 158640 158841 161593 161200 162004 161234 160659 159732 161323 161801 160125 159337 159179 158430 160040 160055 162471 161317 159631 158747 160323 160360 161257 159394 158575 158737 160674 162569 162865 160959 159759 159680 162164 161581 160736 159165 158561 158249 159848 159790 161376 160481 159377 159110 154659 155361 155610 154583 154131 153741 155442 156146 156168 154206 154667 154451 156480 156510 155189 154054 152592 152094 156281 156192 155810 154828 154443 153929 154872 154112 155551 153943 154398 154105 155087 155945 157417 155342 155102 154436 156646 156851 156219 154274 153881 152731 155692 156226 156382 155317 154422 153701
sum_num_inserts_total=21130829
sum_num_deletes_by_thread=125350 126169 126080 123869 124287 123391 125143 125519 125883 125301 124570 123644 125541 125571 125587 125004 124521 124022 125721 125455 126767 125135 124112 123204 125190 125489 125932 123911 123428 123569 125319 126216 126325 124905 124334 124114 125593 126078 126066 124842 124394 124437 125922 124992 125884 124907 124138 123381 160954 161110 161862 159428 158777 158377 161692 161269 162702 160544 161086 159971 161317 161984 160528 159632 158850 159154 159988 159117 161979 160067 159664 159182 160736 161057 161203 159596 158745 158391 160534 160462 161828 161364 160689 160742 161674 161548 160929 158826 158937 157733 159471 159523 161959 160899 159652 158963 154547 154424 155300 154209 154230 153892 155642 156085 156586 154484 154462 154175 155441 156646 155975 153900 154039 152831 155123 155978 156306 155307 154738 154026 153546 154568 155308 154104 153656 153073 154854 155931 156689 155984 154982 155006 157308 157589 156274 153974 153653 153447 156661 156863 156806 155260 153526 153580
sum_num_deletes_total=21134895
sum_num_searches_by_thread=2253904 2258702 2266544 2230459 2228006 2228266 2254786 2268297 2274149 2251899 2239535 2241533 2262062 2257811 2264750 2234894 2242984 2234673 2266249 2254957 2275823 2245161 2241414 2226700 2258531 2260480 2270021 2231862 2229821 2230396 2256138 2266862 2269536 2252848 2240360 2242364 2263507 2256583 2267279 2236325 2242510 2235949 2266817 2252980 2273833 2240643 2243983 2225821 2891205 2902354 2911162 2871094 2856926 2851596 2902683 2914228 2928751 2893316 2882876 2876593 2904336 2917152 2888839 2870927 2857237 2851296 2875794 2874943 2915508 2890120 2872535 2863479 2894802 2894810 2910457 2870605 2855988 2854930 2902066 2908183 2928878 2900413 2888051 2879887 2911889 2920720 2891967 2865467 2859148 2846911 2872522 2871966 2918048 2887010 2865265 2858277 2783578 2797697 2803572 2772098 2775454 2768848 2801188 2811340 2820207 2782074 2784561 2770367 2804465 2817127 2806427 2775687 2757362 2751063 2805788 2808803 2808528 2789516 2780643 2764023 2783410 2784053 2799894 2769176 2769807 2770036 2795363 2809689 2827757 2797672 2790752 2779377 2817332 2824565 2815168 2785280 2766960 2752571 2813207 2821151 2819832 2790798 2781293 2773552
sum_num_searches_total=380521328
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2504889 2510373 2518531 2477740 2476028 2475675 2505523 2519720 2526095 2501322 2489011 2489331 2513472 2508871 2515693 2483904 2492497 2482854 2517729 2505907 2528811 2494745 2489677 2473575 2509043 2511749 2521756 2479466 2476871 2477509 2506712 2519644 2521735 2502682 2489428 2490604 2515355 2507952 2519209 2484998 2491371 2484368 2518011 2503399 2526098 2490233 2492040 2472478 3212469 3224651 3234615 3189630 3174343 3168814 3225968 3236697 3253457 3215094 3204621 3196296 3226976 3240937 3209492 3189896 3175266 3168880 3195822 3194115 3239958 3211504 3191830 3181408 3215861 3216227 3232917 3189595 3173308 3172058 3223274 3231214 3253571 3222736 3208499 3200309 3235727 3243849 3213632 3183458 3176646 3162893 3191841 3191279 3241383 3208390 3184294 3176350 3092784 3107482 3114482 3080890 3083815 3076481 3112272 3123571 3132961 3090764 3093690 3078993 3116386 3130283 3117591 3083641 3063993 3055988 3117192 3120973 3120644 3099651 3089824 3071978 3091828 3092733 3110753 3077223 3077861 3077214 3105304 3121565 3141863 3108998 3100836 3088819 3131286 3139005 3127661 3093528 3074494 3058749 3125560 3134240 3133020 3101375 3089241 3080833
average_num_operations_total=2936021
stdev_num_operations_total=26166
sum_num_operations_total=422787052
min_num_operations_total=2472478
max_num_operations_total=3253571
first_time_thread_terminate_by_thread=10000188 10000103 10000104 10000102 10000099 10000105 10000104 10000105 10000099 10000104 10000102 10000104 10000104 10000104 10000105 10000105 10000104 10000103 10000105 10000103 10000104 10000099 10000102 10000100 10000104 10000103 10000099 10000102 10000103 10000099 10000105 10000105 10000099 10000102 10000102 10000104 10000104 10000104 10000105 10000105 10000104 10000103 10000105 10000103 10000104 10000099 10000104 10000100 10000105 10000104 10000103 10000103 10000101 10000102 10000105 10000102 10000100 10000100 10000100 10000102 10000101 10000104 10000101 10000101 10000100 10000100 10000103 10000104 10000100 10000105 10000101 10000100 10000105 10000104 10000103 10000103 10000101 10000100 10000105 10000102 10000100 10000100 10000100 10000102 10000101 10000104 10000101 10000101 10000100 10000104 10000103 10000104 10000100 10000105 10000101 10000100 10000101 10000101 10000102 10000100 10000103 10000102 10000103 10000100 10000100 10000100 10000102 10000101 10000102 10000102 10000100 10000101 10000100 10000103 10000101 10000100 10000100 10000102 10000103 10000100 10000101 10000101 10000100 10000101 10000103 10000103 10000103 10000100 10000101 10000100 10000100 10000102 10000102 10000100 10000100 10000101 10000100 10000102 10000101 10000101 10000100 10000102 10000101 10000100
min_time_thread_terminate_total=10000099
max_time_thread_terminate_total=10000188
first_time_thread_start_by_thread=9 5 6 5 5 6 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 6 5 5 6 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 6 6 6 6 6 6 6 5 6 6 5 6 6 6 6 6 6 6 6 5 5 6 5 6 6 6 6 6 6 6 6 5 6 6 5 6 6 6 6 6 6 6 6 5 5 6 5 6 6 6 6 6 6 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 5 6 6 6 6 6 6 6 6 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=99915088133007
threads_final_size=9991593
final_keysum=99915088133007
final_size=9991593
validate_result=success
Validation OK.
Structural validation OK.

total_find=380521328
total_rq=0
total_inserts=21130829
total_deletes=21134895
total_updates=42265724
total_queries=380521328
total_ops=422787052
find_throughput=38052132
rq_throughput=0
update_throughput=4226572
query_throughput=38052132
total_throughput=42278705


total find                    : 380521328
total rq                      : 0
total inserts                 : 21130829
total deletes                 : 21134895
total updates                 : 42265724
total queries                 : 380521328
total ops                     : 422787052
find throughput               : 38052132
rq throughput                 : 0
update throughput             : 4226572
query throughput              : 38052132
total throughput              : 42278705

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=37.508
PAPI_L3_TCM=16.7776
PAPI_TOT_CYC=9468.91
PAPI_TOT_INS=837.276
garbage=1835381862548195
total_execution_walltime=15.803s
REALTIME_MAIN_END_PERF_FORMAT=6983197.63907722
[time_cmd_output] time_elapsed_sec=16.03, faults_major=0, faults_minor=376880, mem_maxresident_kb=1460792, user_cputime=2197.92, sys_cputime=8.68, percent_cpu=13764%
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=1