__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 192 -nprefill 192 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000030.txt
__path_data=data/data000030.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=207144.553765323
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=0.5
DEL_FRAC=0.5
RQ=0
RQSIZE=0
MAXKEY=20000000
PREFILL_THREADS=192
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=192
WORK_THREADS=192
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,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,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189,190,191,64,65,66,67,68,69,70,71,72,73,74,75,76,77,78,79,80,81,82,83,84,85,86,87,88,89,90,91,92,93,94,95,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,120,121,122,123,124,125,126,127


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.064s
prefilling_size=4998969 prefilling_elapsed_millis=1s
prefilling_size=5333164 prefilling_elapsed_millis=1.101s
prefilling_size=5657026 prefilling_elapsed_millis=1.201s
prefilling_size=5948053 prefilling_elapsed_millis=1.301s
prefilling_size=6228022 prefilling_elapsed_millis=1.401s
prefilling_size=6479431 prefilling_elapsed_millis=1.502s
prefilling_size=6725744 prefilling_elapsed_millis=1.602s
prefilling_size=6943465 prefilling_elapsed_millis=1.702s
prefilling_size=7156131 prefilling_elapsed_millis=1.802s
prefilling_size=7347699 prefilling_elapsed_millis=1.902s
prefilling_size=7531620 prefilling_elapsed_millis=2.003s
prefilling_size=7697601 prefilling_elapsed_millis=2.103s
prefilling_size=7857612 prefilling_elapsed_millis=2.203s
prefilling_size=7998710 prefilling_elapsed_millis=2.303s
prefilling_size=8136392 prefilling_elapsed_millis=2.403s
prefilling_size=8259969 prefilling_elapsed_millis=2.504s
prefilling_size=8380823 prefilling_elapsed_millis=2.604s
prefilling_size=8490070 prefilling_elapsed_millis=2.704s
prefilling_size=8596080 prefilling_elapsed_millis=2.804s
prefilling_size=8688335 prefilling_elapsed_millis=2.904s
prefilling_size=8781794 prefilling_elapsed_millis=3.005s
prefilling_size=8861574 prefilling_elapsed_millis=3.105s
prefilling_size=8940572 prefilling_elapsed_millis=3.206s
prefilling_size=9010467 prefilling_elapsed_millis=3.306s
prefilling_size=9079857 prefilling_elapsed_millis=3.406s
prefilling_size=9139725 prefilling_elapsed_millis=3.506s
prefilling_size=9200268 prefilling_elapsed_millis=3.606s
prefilling_size=9253996 prefilling_elapsed_millis=3.707s
prefilling_size=9305901 prefilling_elapsed_millis=3.807s
prefilling_size=9350634 prefilling_elapsed_millis=3.907s
prefilling_size=9395224 prefilling_elapsed_millis=4.007s
prefilling_size=9434925 prefilling_elapsed_millis=4.108s
prefilling_size=9472777 prefilling_elapsed_millis=4.208s
prefilling_size=9507084 prefilling_elapsed_millis=4.308s
prefilling_size=9541366 prefilling_elapsed_millis=4.408s
prefilling_size=9573144 prefilling_elapsed_millis=4.508s
prefilling_size=9603174 prefilling_elapsed_millis=4.609s
prefilling_size=9630722 prefilling_elapsed_millis=4.709s
prefilling_size=9656896 prefilling_elapsed_millis=4.809s
prefilling_size=9678861 prefilling_elapsed_millis=4.909s
prefilling_size=9701595 prefilling_elapsed_millis=5.009s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 298371 keys with 192 threads...
tid=0 thread_prefill_amount=49968 percent_done_estimate=3215.4 elapsed_s=5 est_remaining_s=-11 / -6
timing_elapsed 0.0435149s
prefilling_size=10000000 prefilling_elapsed_millis=0.045s
finished prefilling to size 10000000 for expected size 10000000 keysum=99990615903060, performing 71081765 updates; total_prefilling_elapsed_ms=45 ms)
pref_size=10000000
pref_millis=45
prefill_elapsed_ms=46
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=207149.810894771
REALTIME_END_PERF_FORMAT=207159.810993127

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

tree_stats_numInternalsAtDepth=0
tree_stats_numLeavesAtDepth=1
tree_stats_numNodesAtDepth=1
tree_stats_numKeysAtDepth=9995409
tree_stats_avgDegreeAtDepth=9.99541e+06

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

tree_stats_avgDegreeInternal=0
tree_stats_avgDegreeLeaves=9.99541e+06
tree_stats_avgDegree=9.99541e+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=16336 16344 16302 16077 16444 16237 16440 16176 16101 16271 16245 16282 16229 16270 16191 15993 16800 16919 16680 16504 16711 16712 16771 16630 16688 16575 16695 16620 16713 16601 16568 16389 16453 16580 16763 16428 16580 16572 16398 16363 16624 16469 16387 16439 16343 16423 16465 16592 16764 16583 16709 16376 16707 16447 16657 16525 16565 16814 16510 16383 16653 16462 16848 16717 16316 16181 16253 16305 16218 16242 16461 16210 16238 16147 15845 16254 16306 16192 16346 16203 16814 16603 16807 16769 16966 16603 16817 16589 16530 16697 16604 16631 16614 16612 16590 16441 16617 16297 16777 16448 16409 16277 16666 16422 16513 16626 16588 16405 16479 16634 16380 16901 16810 16638 16511 16540 16463 16776 16567 16524 16859 16521 16759 16362 16804 16534 16579 16473 22706 23213 22965 22975 23116 22965 22949 23119 22938 22890 22994 22881 23072 22948 22914 23000 22927 23083 22849 23289 22673 22963 22958 23044 22841 22840 22917 22869 22829 22849 22907 22492 22903 22782 22709 22972 22536 22834 22608 22737 22703 22628 22675 22766 22699 22756 22563 22698 22303 22397 22634 22639 22777 22690 22633 22481 22378 22683 22764 22896 22517 22789 22682 22702
sum_num_inserts_total=3572185
sum_num_deletes_by_thread=16192 16218 16349 16391 16266 16360 16338 16286 16134 16092 16182 16191 16474 16105 16278 16270 17142 16699 16661 16842 16714 16720 16874 16833 16684 16584 16426 16577 16578 16716 16628 16545 16527 16591 16544 16744 16597 16789 16477 16635 16816 16390 16565 16396 16500 16490 16727 16548 16580 16526 16640 16788 16755 16567 16537 16537 16489 16542 16489 16576 16735 16473 16702 16706 16361 16544 16163 16416 16332 16177 16366 16427 16084 16106 16389 16386 16287 15943 16314 16565 16841 16819 16700 17038 16713 16777 16712 16762 16665 16659 16715 16567 16494 16476 16600 16511 16566 16553 16785 16226 16361 16350 16444 16399 16648 16628 16529 16511 16413 16530 16596 16475 16535 16596 16797 16568 16539 16645 16665 16529 16622 16454 16600 16420 16730 16638 16530 16545 22754 23000 22735 23025 22844 23109 23102 22984 22932 22990 22878 23037 22986 22668 22700 23247 23065 23156 22968 23033 22671 22897 22847 23097 22801 22969 23014 22885 22971 22677 22891 22885 22642 22793 22823 22922 22873 22614 22530 22811 22775 22545 22461 22750 22772 22644 22918 22409 22654 22630 22629 22805 22623 22796 22550 22670 22833 22510 22529 22573 22598 22371 22641 22687
sum_num_deletes_total=3574862
sum_num_searches_by_thread=3222112 3228104 3220912 3204111 3228811 3223075 3223742 3225424 3215352 3217856 3214892 3215435 3211165 3211476 3209480 3209615 3319721 3318737 3317264 3316373 3316092 3314301 3310768 3310444 3288784 3291354 3287906 3284909 3291817 3292626 3289409 3292065 3289226 3285513 3284202 3281271 3278438 3275853 3273097 3268381 3269769 3267404 3263051 3264829 3267946 3266845 3260736 3263611 3297603 3293980 3292134 3294670 3289873 3288542 3288025 3285684 3289727 3290168 3286206 3288983 3292234 3290832 3287136 3287787 3223300 3226232 3221921 3222963 3228509 3224457 3222468 3223203 3216116 3215663 3214189 3214145 3212903 3213474 3205670 3205608 3321693 3318273 3318053 3314882 3317794 3313995 3312416 3309943 3287900 3288057 3286535 3285691 3292447 3293176 3289647 3290670 3287251 3285416 3281527 3283126 3279152 3275146 3272640 3271690 3269331 3265176 3266041 3264271 3265962 3265959 3261696 3260188 3297226 3294520 3295174 3293266 3291268 3289109 3287882 3286947 3290020 3290675 3285099 3286970 3292096 3291995 3286729 3288891 4514090 4532757 4529148 4537220 4543055 4544352 4535778 4548284 4539111 4536124 4540640 4540570 4544671 4540879 4538793 4540536 4548684 4546629 4546725 4549301 4549382 4545932 4542181 4547938 4547914 4541620 4535421 4540743 4541406 4537580 4543908 4544384 4500445 4499322 4497489 4499596 4497401 4498199 4489999 4496002 4495334 4488210 4483860 4494041 4494211 4491434 4485412 4493074 4490175 4492590 4488066 4491371 4487809 4486558 4480617 4486196 4485634 4482333 4482007 4477232 4483103 4480661 4476987 4484527
sum_num_searches_total=707637971
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3254640 3260666 3253563 3236579 3261521 3255672 3256520 3257886 3247587 3250219 3247319 3247908 3243868 3243851 3241949 3241878 3353663 3352355 3350605 3349719 3349517 3347733 3344413 3343907 3322156 3324513 3321027 3318106 3325108 3325943 3322605 3324999 3322206 3318684 3317509 3314443 3311615 3309214 3305972 3301379 3303209 3300263 3296003 3297664 3300789 3299758 3293928 3296751 3330947 3327089 3325483 3327834 3323335 3321556 3321219 3318746 3322781 3323524 3319205 3321942 3325622 3323767 3320686 3321210 3255977 3258957 3254337 3255684 3261059 3256876 3255295 3255840 3248438 3247916 3246423 3246785 3245496 3245609 3238330 3238376 3355348 3351695 3351560 3348689 3351473 3347375 3345945 3343294 3321095 3321413 3319854 3318889 3325555 3326264 3322837 3323622 3320434 3318266 3315089 3315800 3311922 3307773 3305750 3304511 3302492 3298430 3299158 3297187 3298854 3299123 3294672 3293564 3330571 3327754 3328482 3326374 3324270 3322530 3321114 3320000 3323501 3323650 3318458 3319752 3325630 3325167 3319838 3321909 4559550 4578970 4574848 4583220 4589015 4590426 4581829 4594387 4584981 4582004 4586512 4586488 4590729 4586495 4584407 4586783 4594676 4592868 4592542 4595623 4594726 4591792 4587986 4594079 4593556 4587429 4581352 4586497 4587206 4583106 4589706 4589761 4545990 4544897 4543021 4545490 4542810 4543647 4535137 4541550 4540812 4533383 4528996 4539557 4539682 4536834 4530893 4538181 4535132 4537617 4533329 4536815 4533209 4532044 4525800 4531347 4530845 4527526 4527300 4522701 4528218 4525821 4522310 4529916
average_num_operations_total=3722838
stdev_num_operations_total=43050
sum_num_operations_total=714785018
min_num_operations_total=3236579
max_num_operations_total=4595623
first_time_thread_terminate_by_thread=10000163 10000099 10000099 10004181 10000101 10000100 10000099 10000099 10000098 10000098 10000098 10000102 10000098 10000098 10000098 10000101 10000101 10000100 10000100 10000101 10000101 10000101 10000101 10000105 10000102 10000102 10000102 10000102 10000102 10000102 10000102 10000104 10000098 10000098 10000098 10000098 10000104 10000104 10000104 10000104 10000098 10000098 10000098 10000098 10000097 10000097 10000097 10000097 10000096 10000096 10000096 10000096 10000103 10000103 10000103 10000103 10000101 10000101 10000103 10000103 10000096 10000096 10000096 10000099 10000098 10000098 10000099 10000098 10000099 10000100 10000100 10000100 10000102 10000098 10000102 10000098 10000098 10000098 10000098 10000102 10000100 10000101 10000103 10000100 10000101 10000101 10000101 10000102 10000102 10000102 10000102 10000102 10000102 10000102 10000102 10000102 10000101 10000101 10000101 10000101 10000104 10000104 10000105 10000104 10000098 10000098 10000101 10000098 10000097 10000101 10000097 10000097 10000096 10000096 10000096 10000096 10000103 10000103 10000103 10000103 10000101 10000103 10000101 10000101 10000099 10000096 10000099 10000099 10000099 10000099 10000099 10000099 10000103 10000103 10000103 10000103 10000099 10000099 10000099 10000099 10000101 10000101 10000101 10000101 10000104 10000104 10000104 10000104 10000098 10000102 10000097 10000097 10000101 10000101 10000101 10000101 10000098 10000098 10000098 10000097 10000102 10000102 10000102 10000102 10000100 10000100 10000100 10000100 10000099 10000099 10000099 10000099 10000104 10000104 10000104 10000104 10000103 10000103 10000103 10000103 10000104 10000104 10000104 10000104 10000100 10000100 10000100 10000100 10000103 10000103 10000103 10000103
min_time_thread_terminate_total=10000096
max_time_thread_terminate_total=10004181
first_time_thread_start_by_thread=13 5 5 5 13 13 13 13 8 8 8 8 8 8 8 8 10 10 10 10 8 8 8 8 7 7 7 7 8 8 8 8 7 7 7 7 6 6 6 6 10 10 10 10 9 9 9 9 11 11 11 11 6 6 6 6 8 8 8 8 7 7 7 7 5 5 5 5 13 13 13 13 8 8 8 8 8 8 8 8 10 10 10 10 8 8 8 8 7 7 7 7 8 8 8 8 7 7 7 7 6 6 6 6 10 10 10 10 9 9 9 9 12 11 11 11 6 6 6 6 8 8 8 8 7 7 7 7 14 14 14 14 9 9 9 9 10 10 10 10 9 9 9 9 7 7 7 7 9 9 9 9 10 10 10 10 11 11 11 11 11 11 11 11 12 12 12 12 13 14 13 14 13 13 13 13 12 12 12 12 12 12 12 12 13 13 13 13 12 12 13 13
min_time_thread_start_total=5
max_time_thread_start_total=14
sum_duration_all_ops_total=

threads_final_keysum=99947786193019
threads_final_size=9995409
final_keysum=99947786193019
final_size=9995409
validate_result=success
Validation OK.
Structural validation OK.

total_find=707637971
total_rq=0
total_inserts=3572185
total_deletes=3574862
total_updates=7147047
total_queries=707637971
total_ops=714785018
find_throughput=70763797
rq_throughput=0
update_throughput=714704
query_throughput=70763797
total_throughput=71478501


total find                    : 707637971
total rq                      : 0
total inserts                 : 3572185
total deletes                 : 3574862
total updates                 : 7147047
total queries                 : 707637971
total ops                     : 714785018
find throughput               : 70763797
rq throughput                 : 0
update throughput             : 714704
query throughput              : 70763797
total throughput              : 71478501

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

garbage=275555645428457
total_execution_walltime=15.656s
REALTIME_MAIN_END_PERF_FORMAT=207160.210327505
[time_cmd_output] time_elapsed_sec=15.85, faults_major=0, faults_minor=428455, mem_maxresident_kb=1697884, user_cputime=2899.40, sys_cputime=7.81, percent_cpu=18340%
timeout=false
algorithm=wang_openbwtree
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2