__step=000650
__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" ./bronson_pext_bst_occ.debra -nwork 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000650.txt
__path_data=data/data000650.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=214630.728601806
binary=./bronson_pext_bst_occ.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=bronson_pext_bst_occ
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=200000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
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
sizes: node=56
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.017s
prefilling_size=99915 prefilling_elapsed_millis=1s
finished prefilling to size 99873 for expected size 100000 keysum=9965446199, performing 42984124 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=99873
pref_millis=1101
prefill_elapsed_ms=1114
6node_tIxPvE_object_size=56
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=1172
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=214631.875656445
REALTIME_END_PERF_FORMAT=214641.875761790
###############################################################################
################################## 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 1024 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.078s
tree_stats_numInternalsAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8149 14913 20295 13952 2949 103 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 41 1216 8019 20850 18014 3842 128
tree_stats_numNodesAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8190 16129 28314 34802 20963 3945 128
tree_stats_numKeysAtDepth=0 1 1 3 5 5 18 27 66 120 260 491 988 2133 4622 10766 23142 32654 20692 3938 128
tree_stats_avgDegreeAtDepth=1 2 2 2 2 2 2 2 2 2 2 2 2 1.99951 1.97436 1.83086 1.51236 1.20137 1.04746 1.00634 1
tree_stats_height=21
tree_stats_numInternals=68553
tree_stats_numLeaves=52110
tree_stats_numNodes=120663
tree_stats_numKeys=100060
tree_stats_avgDegreeInternal=1.76014
tree_stats_avgDegreeLeaves=0.999923
tree_stats_avgDegree=1.43183
tree_stats_avgKeyDepth=16.4998
tree_stats_bytesAtDepth=56 56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458640 903224 1585584 1948912 1173928 220920 7168
tree_stats_sizeInBytes=6757128
6node_tIxPvE_object_size=56
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=26245
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:570 2:8445 4:125510 8:442935 16:62129 32:14 64:173 128:9
[2^00, 2^01]: 570
(2^01, 2^02]: 8445
(2^02, 2^03]: 125510
(2^03, 2^04]: 442935
(2^04, 2^05]: 62129
(2^05, 2^06]: 14
(2^06, 2^07]: 173
(2^07, 2^08]: 9
sum_limbo_reclamation_event_size_total=6769731
count_limbo_reclamation_event_size_by_thread=9996 9998 9997 9996 9998 9997 9994 9997 9997 9998 9997 9998 9998 9997 9998 9998 9998 9997 9998 9997 9997 9997 9998 9995 9997 9996 9996 9995 9996 9997 9998 9995 9997 9997 9995 9997 9997 9993 9997 9997 9994 9997 9996 9995 9996 9998 9997 9998 9998 9997 9997 9996 9996 9996 9996 9995 9997 9995 9996 9996 9996 9998 9997 9997
count_limbo_reclamation_event_size_total=639785
sum_limbo_reclamation_event_count_total=1604672
first_thread_announced_epoch_by_thread=52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490 52490
sum_num_inserts_by_thread=674487 676754 657378 673658 657594 668650 668530 665284 720227 716447 663010 703702 719805 712667 702340 708380 697921 692743 744255 736873 731112 736070 727740 733440 640176 623020 625000 621796 650328 697420 693623 649578 736062 737526 731252 732679 637646 636889 624712 613773 605731 599141 597386 595117 595418 599863 644552 654021 650342 651190 647954 645199 643130 623480 629872 629081 640858 641278 645733 647422 718793 788536 793894 718497
sum_num_inserts_total=43047035
sum_num_deletes_by_thread=677081 679778 657339 674232 656322 669788 668316 664918 720404 715736 662893 704364 720440 713461 703789 707318 699335 693595 743500 737262 730169 736672 727896 733727 640865 622762 626886 622548 653151 696546 693645 650563 736311 738805 731473 733875 638155 636120 624062 614406 605611 599290 597059 596898 595032 600829 645661 654945 651659 651008 646875 643555 642269 622992 628657 631041 638824 642038 645377 646331 719053 786060 794461 719919
sum_num_deletes_total=43063952
sum_num_searches_by_thread=12160763 12198536 11835281 12136580 11845385 12036716 12025717 11967455 12962703 12893543 11928265 12653483 12961787 12854507 12653071 12731841 12558121 12481983 13377850 13282439 13147979 13264528 13086432 13202844 11525003 11201170 11275136 11199441 11718470 12549501 12500455 11682949 13257037 13286969 13172583 13204928 11464392 11454741 11236942 11051395 10903536 10809515 10760152 10728749 10724030 10813522 11609940 11777729 11730512 11723592 11682309 11602190 11568154 11231948 11323101 11330707 11510322 11556246 11608876 11649587 12937962 14175054 14291777 12945601
sum_num_searches_total=775024032
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=13512331 13555068 13149998 13484470 13159301 13375154 13362563 13297657 14403334 14325726 13254168 14061549 14402032 14280635 14059200 14147539 13955377 13868321 14865605 14756574 14609260 14737270 14542068 14670011 12806044 12446952 12527022 12443785 13021949 13943467 13887723 12983090 14729410 14763300 14635308 14671482 12740193 12727750 12485716 12279574 12114878 12007946 11954597 11920764 11914480 12014214 12900153 13086695 13032513 13025790 12977138 12890944 12853553 12478420 12581630 12590829 12790004 12839562 12899986 12943340 14375808 15749650 15880132 14384017
average_num_operations_total=13455234
stdev_num_operations_total=122500
sum_num_operations_total=861135019
min_num_operations_total=11914480
max_num_operations_total=15880132
first_time_thread_terminate_by_thread=10000105 10000105 10000106 10000105 10000105 10000105 10000105 10000105 10000105 10000105 10000105 10000105 10000106 10000106 10000106 10000106 10000107 10000106 10000107 10000107 10000106 10000105 10000106 10000106 10000105 10000105 10000105 10000105 10000104 10000103 10000104 10000103 10000106 10000106 10000106 10000106 10000104 10000104 10000104 10000104 10000107 10000107 10000107 10000107 10000106 10000103 10000103 10000103 10000103 10000103 10000103 10000103 10000106 10000106 10000106 10000106 10000106 10000106 10000106 10000106 10000107 10000107 10000107 10000107
min_time_thread_terminate_total=10000103
max_time_thread_terminate_total=10000107
first_time_thread_start_by_thread=5 5 3 5 3 3 3 3 3 3 3 3 4 4 4 4 5 5 5 5 5 5 5 5 6 6 6 6 5 6 5 5 7 6 7 6 3 3 3 3 5 5 6 6 6 6 6 6 4 4 4 4 5 4 4 4 6 6 6 6 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=7
sum_duration_all_ops_total=
threads_final_keysum=10013491812
threads_final_size=100060
final_keysum=10013491812
final_size=100060
validate_result=success
Validation OK.
Structural validation OK.
total_find=775024032
total_rq=0
total_inserts=43047035
total_deletes=43063952
total_updates=86110987
total_queries=775024032
total_ops=861135019
find_throughput=77502403
rq_throughput=0
update_throughput=8611098
query_throughput=77502403
total_throughput=86113501
total find : 775024032
total rq : 0
total inserts : 43047035
total deletes : 43063952
total updates : 86110987
total queries : 775024032
total ops : 861135019
find throughput : 77502403
rq throughput : 0
update throughput : 8611098
query throughput : 77502403
total throughput : 86113501
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=12456583161195
total_execution_walltime=11.319s
REALTIME_MAIN_END_PERF_FORMAT=214642.48888002
[time_cmd_output] time_elapsed_sec=11.42, faults_major=0, faults_minor=77570, mem_maxresident_kb=310924, user_cputime=733.25, sys_cputime=4.80, percent_cpu=6460%
timeout=false
algorithm=bronson_pext_bst_occ.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2