__step=000156
__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" ./guerraoui_ext_bst_ticket.debra -nwork 128 -nprefill 128 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000156.txt
__path_data=data/data000156.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=208736.490558154
binary=./guerraoui_ext_bst_ticket.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=guerraoui_ext_bst_ticket
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=2000000
PREFILL_THREADS=128
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=128
WORK_THREADS=128
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
sizes: node=40
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
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.027s
prefilling_size=1000286 prefilling_elapsed_millis=1s
finished prefilling to size 1000262 for expected size 1000000 keysum=1000028735729, performing 50386192 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=1000262
pref_millis=1101
prefill_elapsed_ms=1112
6node_tIxPvE_object_size=40
6node_tIxPvE_allocated_count=0
6node_tIxPvE_allocated_size=0MB
6node_tIxPvE_get_from_pool=0
6node_tIxPvE_deallocated=0
6node_tIxPvE_limbo_count=0
6node_tIxPvE_limbo_details=0 0 0
global_epoch_counter=380
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=208737.655997622
REALTIME_END_PERF_FORMAT=208747.656071248
###############################################################################
################################## TIME IS UP #################################
###############################################################################
joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################
10s
PRODUCING OUTPUT
computing tree_stats in PARALLEL...
bounded depth BFS to partition into subtrees for parallel computation (256 threads)...
partitioned into 1956 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.132s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 254 506 978 1773 3122 5274 8528 13235 19393 27023 35452 44329 52896 60809 67206 72333 75098 75694 73075 68126 61611 53988 46206 37484 29412 22097 15973 10833 7106 4424 2665 1594 876 452 214 83 24 7 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 2 2 34 183 424 970 2020 3821 7077 11763 18594 26575 35762 44983 54412 62079 69568 74502 78313 78024 74641 69234 61770 54928 45556 36727 28221 21113 14560 9788 6183 3736 2312 1300 690 345 142 41 13 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 508 1012 1956 3546 6244 10548 17056 26470 38786 54046 70904 88658 105792 121618 134412 144666 150196 151388 146150 136252 123222 107976 92412 74968 58824 44194 31946 21666 14212 8848 5330 3188 1752 904 428 166 48 14 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 2 2 34 183 424 970 2020 3821 7077 11763 18594 26575 35761 44983 54412 62079 69568 74502 78313 78024 74641 69234 61770 54928 45556 36727 28221 21113 14560 9788 6183 3736 2312 1300 690 345 142 41 13 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99219 1.99606 1.9664 1.90644 1.88043 1.84465 1.80849 1.77597 1.73264 1.69672 1.65596 1.6252 1.59662 1.5748 1.5526 1.53814 1.51911 1.50397 1.4827 1.46614 1.45218 1.43814 1.42793 1.40562 1.39233 1.37565 1.36143 1.3391 1.32798 1.31129 1.3012 1.29906 1.27478 1.25799 1.23673 1.19393 1.14458 1.14583 1.07143 1
tree_stats_height=48
tree_stats_numInternals=1000409
tree_stats_numLeaves=1000410
tree_stats_numNodes=2000819
tree_stats_numKeys=1000409
tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=0.999999
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=26.6945
tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10240 20320 40480 78240 141840 249760 421920 682240 1058800 1551440 2161840 2836160 3546320 4231680 4864720 5376480 5786640 6007840 6055520 5846000 5450080 4928880 4319040 3696480 2998720 2352960 1767760 1277840 866640 568480 353920 213200 127520 70080 36160 17120 6640 1920 560 80
tree_stats_sizeInBytes=80032760
6node_tIxPvE_object_size=40
6node_tIxPvE_allocated_count=0
6node_tIxPvE_allocated_size=0MB
6node_tIxPvE_get_from_pool=0
6node_tIxPvE_deallocated=0
6node_tIxPvE_limbo_count=0
6node_tIxPvE_limbo_details=0 0 0
global_epoch_counter=4535
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:75530 4:235297 8:188422 16:7724 32:81
(2^01, 2^02]: 75530
(2^02, 2^03]: 235297
(2^03, 2^04]: 188422
(2^04, 2^05]: 7724
(2^05, 2^06]: 81
sum_limbo_reclamation_event_size_total=3276158
count_limbo_reclamation_event_size_by_thread=3954 3975 3979 3945 3958 3969 3935 3965 3974 3971 3960 3958 3966 3963 3947 3963 3984 3958 3972 3970 3959 3957 3939 3971 3957 3967 3955 3956 3955 3961 3972 3972 3955 3965 3947 3970 3981 3992 3948 3952 3955 3953 3960 3971 3992 3976 3958 3960 3933 3976 3962 3984 3972 3964 3978 3963 3947 3986 3969 3966 3971 3969 3954 3945 3972 3953 3931 3941 3955 3954 3953 3976 3928 3971 3968 3957 3971 3944 3994 3945 3962 3971 3960 3961 3958 3965 3959 3939 3952 3939 3958 3942 3972 3960 3938 3959 3978 3982 3981 3982 3972 3961 3963 3944 3961 3941 3924 3979 3969 3932 3962 3966 3980 3974 3938 3958 3950 3951 3972 3939 3982 3967 3948 3966 3951 3969 3958 3985
count_limbo_reclamation_event_size_total=507054
sum_limbo_reclamation_event_count_total=531840
first_thread_announced_epoch_by_thread=9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070 9070
sum_num_inserts_by_thread=25824 26046 25812 25735 25878 26023 25627 25691 25990 25932 25931 26193 26096 25694 25795 25557 25582 25708 25452 25449 25553 25977 25740 25644 25889 25877 25712 25683 25729 25925 25550 25553 25329 25534 25425 25767 25770 26117 25962 25702 25864 25912 25714 25481 25882 25505 25569 25510 25277 26119 25628 25634 25906 25910 25990 25584 25368 25394 24989 25304 25413 25559 25493 25456 25649 25894 25609 25748 25657 25591 25434 25267 25497 25703 25427 25386 25678 25175 26097 25905 25363 25541 25229 25756 25268 25149 25185 25272 25222 25489 25351 25324 25757 25772 25301 25689 25747 25714 25813 25477 25413 25552 25309 25492 25751 25533 25758 25570 25845 25705 25631 25334 25619 25346 25233 25295 25031 25410 25268 24988 25761 25696 25423 25440 25787 25555 25766 25623
sum_num_inserts_total=3278184
sum_num_deletes_by_thread=25740 26053 25876 25836 25979 25650 25502 25713 26001 26259 25881 26256 25990 26059 25983 25991 25247 25450 25481 25557 25460 25628 25469 25461 25813 25713 25702 25736 25264 25815 25138 25613 25737 25605 25352 25718 25880 26119 25747 25858 26025 25914 25950 25795 25819 25789 25291 25512 25364 26066 25640 25803 25745 25955 25768 25845 25563 25656 25470 25640 25389 25520 25169 25345 25633 25829 25490 26081 25606 25360 25470 25581 25271 25875 25174 25582 25360 25517 25872 25775 25612 25178 25464 25454 25452 25478 25041 25180 25249 25370 24931 24930 25609 25533 25377 25616 25749 25741 25663 25696 25588 25683 25165 25260 25442 25351 25547 25805 25956 25743 25647 25651 25525 25572 25124 25193 25352 25171 25311 25099 25530 25886 25414 25697 25659 25734 25812 25874
sum_num_deletes_total=3277955
sum_num_searches_by_thread=5129622 5169388 5124312 5107930 5109352 5136067 5084422 5138747 5157371 5166661 5138907 5152039 5165013 5159372 5122914 5110697 5050549 5050843 5029433 5057298 5036683 5111879 5064894 5082397 5101639 5112753 5097059 5089555 5079427 5070056 5042764 5047628 5070830 5081166 5053177 5127600 5121985 5141759 5108272 5111824 5127071 5136927 5075318 5073573 5065607 5068462 5039344 5060103 5025345 5112373 5092469 5089566 5084733 5116827 5082211 5079345 5047539 5053164 5025811 5023754 5040756 5034328 5012203 5007965 5079604 5121924 5077384 5102925 5067273 5097285 5043088 5043277 5058945 5064107 5039819 5047460 5061212 5049879 5109746 5102833 5035587 5056697 5017218 5053941 5035893 5029909 4972860 4990371 5009886 5017289 4997939 4986915 5085871 5078489 5057495 5062824 5096991 5104435 5077780 5043651 5032698 5050589 5017546 5022036 5033229 5041048 5093770 5098351 5094713 5098163 5072461 5095309 5068149 5039984 5003129 5006746 5000311 5025087 4991958 4989402 5073404 5087463 5071224 5062320 5102150 5105385 5085395 5089911
sum_num_searches_total=649219811
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5181186 5221487 5176000 5159501 5161209 5187740 5135551 5190151 5209362 5218852 5190719 5204488 5217099 5211125 5174692 5162245 5101378 5102001 5080366 5108304 5087696 5163484 5116103 5133502 5153341 5164343 5148473 5140974 5130420 5121796 5093452 5098794 5121896 5132305 5103954 5179085 5173635 5193995 5159981 5163384 5178960 5188753 5126982 5124849 5117308 5119756 5090204 5111125 5075986 5164558 5143737 5141003 5136384 5168692 5133969 5130774 5098470 5104214 5076270 5074698 5091558 5085407 5062865 5058766 5130886 5173647 5128483 5154754 5118536 5148236 5093992 5094125 5109713 5115685 5090420 5098428 5112250 5100571 5161715 5154513 5086562 5107416 5067911 5105151 5086613 5080536 5023086 5040823 5060357 5068148 5048221 5037169 5137237 5129794 5108173 5114129 5148487 5155890 5129256 5094824 5083699 5101824 5068020 5072788 5084422 5091932 5145075 5149726 5146514 5149611 5123739 5146294 5119293 5090902 5053486 5057234 5050694 5075668 5042537 5039489 5124695 5139045 5122061 5113457 5153596 5156674 5136973 5141408
average_num_operations_total=5123249
stdev_num_operations_total=3848
sum_num_operations_total=655775950
min_num_operations_total=5023086
max_num_operations_total=5221487
first_time_thread_terminate_by_thread=10000075 10000075 10000075 10000075 10000075 10000075 10000075 10000075 10000074 10000074 10000074 10000074 10000076 10000076 10000076 10000076 10000074 10000074 10000074 10000074 10000073 10000073 10000074 10000073 10000074 10000074 10000074 10000074 10000077 10000076 10000076 10000076 10000075 10000075 10000075 10000075 10000073 10000073 10000073 10000073 10000077 10000077 10000077 10000077 10000076 10000076 10000076 10000076 10000073 10000073 10000073 10000073 10000076 10000076 10000076 10000076 10000076 10000076 10000076 10000076 10000072 10000072 10000072 10000072 10000075 10000075 10000075 10000075 10000075 10000075 10000075 10000075 10000074 10000074 10000074 10000074 10000076 10000076 10000076 10000076 10000074 10000074 10000074 10000074 10000073 10000073 10000073 10000073 10000074 10000074 10000074 10000074 10000077 10000076 10000076 10000076 10000075 10000075 10000075 10000075 10000073 10000073 10000073 10000073 10000077 10000077 10000077 10000077 10000076 10000076 10000076 10000076 10000073 10000073 10000073 10000073 10000076 10000076 10000076 10000076 10000076 10000076 10000076 10000076 10000072 10000072 10000072 10000072
min_time_thread_terminate_total=10000072
max_time_thread_terminate_total=10000077
first_time_thread_start_by_thread=5 5 5 5 7 7 7 7 8 8 8 8 6 6 6 6 5 5 5 5 9 8 8 8 6 5 5 5 7 7 7 7 6 6 6 6 8 8 8 8 5 5 5 5 7 7 7 7 6 6 6 6 8 8 8 8 7 7 7 6 9 9 9 9 5 5 5 5 7 7 7 7 8 8 8 8 6 6 6 6 5 5 5 5 9 8 8 8 5 5 5 5 7 7 7 7 6 6 6 6 8 8 8 8 5 5 5 5 7 7 7 7 6 6 6 6 8 8 8 8 7 7 7 6 9 9 9 9
min_time_thread_start_total=5
max_time_thread_start_total=9
sum_duration_all_ops_total=
threads_final_keysum=999779570700
threads_final_size=1000409
final_keysum=999779570700
final_size=1000409
validate_result=success
Validation OK.
Structural validation OK.
total_find=649219811
total_rq=0
total_inserts=3278184
total_deletes=3277955
total_updates=6556139
total_queries=649219811
total_ops=655775950
find_throughput=64921981
rq_throughput=0
update_throughput=655613
query_throughput=64921981
total_throughput=65577595
total find : 649219811
total rq : 0
total inserts : 3278184
total deletes : 3277955
total updates : 6556139
total queries : 649219811
total ops : 655775950
find throughput : 64921981
rq throughput : 0
update throughput : 655613
query throughput : 64921981
total throughput : 65577595
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=37970532931985
total_execution_walltime=11.354s
REALTIME_MAIN_END_PERF_FORMAT=208747.845054854
[time_cmd_output] time_elapsed_sec=11.46, faults_major=0, faults_minor=103016, mem_maxresident_kb=410088, user_cputime=1442.02, sys_cputime=7.72, percent_cpu=12649%
timeout=false
algorithm=guerraoui_ext_bst_ticket.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2