__step=000428
__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 96 -nprefill 96 -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=data000428.txt
__path_data=data/data000428.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6984051.57943938
binary=./bronson_pext_bst_occ.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
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=20000000
PREFILL_THREADS=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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,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


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.036s
prefilling_size=9128782 prefilling_elapsed_millis=1s
prefilling_size=9301753 prefilling_elapsed_millis=1.1s
prefilling_size=9436841 prefilling_elapsed_millis=1.201s
prefilling_size=9548574 prefilling_elapsed_millis=1.301s
prefilling_size=9636670 prefilling_elapsed_millis=1.401s
prefilling_size=9707122 prefilling_elapsed_millis=1.501s
prefilling_size=9762567 prefilling_elapsed_millis=1.601s
prefilling_size=9809576 prefilling_elapsed_millis=1.701s
finished prefilling to size 9809644 for expected size 10000000 keysum=98093231524013, performing 79514851 updates; total_prefilling_elapsed_ms=1803 ms)
pref_size=9809644
pref_millis=1803
prefill_elapsed_ms=1820
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=906

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6984053.92150815
REALTIME_END_PERF_FORMAT=6984063.92246776

###############################################################################
################################## TIME IS UP #################################
###############################################################################

joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################

10.1s
PRODUCING OUTPUT
computing tree_stats in PARALLEL...
bounded depth BFS to partition into subtrees for parallel computation (192 threads)...
partitioned into 1024 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.039s

tree_stats_numInternalsAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262132 522956 1008566 1641732 1798461 1060219 267649 20326 158 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 12 1244 33716 320554 1197848 1931521 1331008 348830 25925 193
tree_stats_numNodesAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262144 524200 1042282 1962286 2996309 2991740 1598657 369156 26083 193
tree_stats_numKeysAtDepth=0 1 1 2 4 7 15 28 58 126 243 525 1010 2033 4109 8212 16309 32723 65988 133812 279069 628994 1438339 2583467 2826094 1571374 367769 26075 193
tree_stats_avgDegreeAtDepth=1 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99971 1.9907 1.91503 1.6903 1.39823 1.17995 1.06348 1.01559 1.00134 1

tree_stats_height=29
tree_stats_numInternals=6844343
tree_stats_numLeaves=5190851
tree_stats_numNodes=12035194
tree_stats_numKeys=9986580

tree_stats_avgDegreeInternal=1.75841
tree_stats_avgDegreeLeaves=0.999966
tree_stats_avgDegree=1.43129
tree_stats_avgKeyDepth=23.2324

tree_stats_bytesAtDepth=56 56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917504 1835008 3670016 7340032 14680064 29355200 58367792 109888016 167793304 167537440 89524792 20672736 1460648 10808
tree_stats_sizeInBytes=673970864

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=7079


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:40 4:3308 8:172843 16:413235 32:2990
    (2^01, 2^02]: 40
    (2^02, 2^03]: 3308
    (2^03, 2^04]: 172843
    (2^04, 2^05]: 413235
    (2^05, 2^06]: 2990
sum_limbo_reclamation_event_size_total=10761174
count_limbo_reclamation_event_size_by_thread=6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171 6171
count_limbo_reclamation_event_size_total=592416
sum_limbo_reclamation_event_count_total=592608
first_thread_announced_epoch_by_thread=14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158 14158
sum_num_inserts_by_thread=283440 285597 288515 287494 287459 283709 285940 285646 290182 289254 285260 284439 286125 288876 287391 287961 286385 285589 284370 285383 286620 288662 284371 281449 284411 285651 286297 287414 286201 284452 284845 285798 289027 288394 284448 284331 283533 288008 289558 291903 286325 286113 283418 284680 285411 287599 282971 280517 285398 287398 290796 288634 288884 285786 286471 287519 290070 291265 287210 285233 286162 287715 289106 290327 289054 284055 283844 285218 289454 289463 286532 283539 285244 287015 289134 290644 288598 286398 287782 287924 291652 291141 287655 284050 285336 288005 290982 288756 288186 282992 283503 286379 290184 290370 288753 283965
sum_num_inserts_total=27535203
sum_num_deletes_by_thread=284188 284693 288607 287133 287195 284751 285014 286830 289561 288439 284775 284312 286412 287723 287547 288553 286497 286009 283771 285783 285942 288670 283916 281167 284158 285499 286213 287352 285327 284597 284957 285421 289979 287656 285425 284899 285922 288466 289637 288971 287468 284945 282550 284017 286360 287188 282871 281125 285793 286463 291006 288393 287240 286155 286545 289132 289829 290299 288079 284848 285645 287575 288309 290560 289447 283837 283772 286154 288457 290155 285742 283756 285539 287358 289081 291275 288070 287577 288083 287597 291106 289953 288651 285081 285370 287245 289586 289831 288724 284260 283448 286256 289218 290424 287926 285427
sum_num_deletes_total=27532768
sum_num_searches_by_thread=5105481 5134031 5195710 5176640 5169875 5112489 5139833 5141676 5218790 5199882 5134413 5131066 5149933 5181014 5183669 5193226 5150008 5137339 5112560 5143901 5153593 5196340 5127978 5067649 5106267 5151322 5170434 5164188 5141968 5114717 5135431 5140100 5217238 5198897 5134606 5121666 5125706 5189465 5211286 5213381 5180885 5149071 5086354 5116708 5148509 5173136 5105244 5061392 5143618 5168038 5236076 5186532 5175989 5139343 5160433 5181649 5212570 5227581 5181631 5129733 5147764 5176126 5205693 5229672 5197760 5109635 5106375 5149696 5222588 5214075 5147352 5115058 5139057 5167509 5209056 5234526 5183074 5152911 5166370 5188424 5239141 5241930 5192538 5129985 5150547 5170187 5221304 5202645 5194984 5102489 5119089 5147834 5220535 5230551 5184063 5125265
sum_num_searches_total=495694068
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5673109 5704321 5772832 5751267 5744529 5680949 5710787 5714152 5798533 5777575 5704448 5699817 5722470 5757613 5758607 5769740 5722890 5708937 5680701 5715067 5726155 5773672 5696265 5630265 5674836 5722472 5742944 5738954 5713496 5683766 5705233 5711319 5796244 5774947 5704479 5690896 5695161 5765939 5790481 5794255 5754678 5720129 5652322 5685405 5720280 5747923 5671086 5623034 5714809 5741899 5817878 5763559 5752113 5711284 5733449 5758300 5792469 5809145 5756920 5699814 5719571 5751416 5783108 5810559 5776261 5677527 5673991 5721068 5800499 5793693 5719626 5682353 5709840 5741882 5787271 5816445 5759742 5726886 5742235 5763945 5821899 5823024 5768844 5699116 5721253 5745437 5801872 5781232 5771894 5669741 5686040 5720469 5799937 5811345 5760742 5694657
average_num_operations_total=5737104
stdev_num_operations_total=4665
sum_num_operations_total=550762039
min_num_operations_total=5623034
max_num_operations_total=5823024
first_time_thread_terminate_by_thread=10000096 10000096 10000099 10000097 10000099 10000096 10000098 10000098 10000097 10000097 10000096 10000099 10000097 10000099 10000096 10000096 10000099 10000098 10000099 10000098 10000096 10000097 10000097 10000099 10000096 10000096 10000099 10000096 10000096 10000096 10000098 10000098 10000097 10000097 10000099 10000096 10000096 10000099 10000096 10000096 10000099 10000098 10000099 10000097 10000096 10000097 10000097 10000099 10000095 10000096 10000098 10000097 10000095 10000096 10000097 10000098 10000099 10000097 10000095 10000097 10000096 10000096 10000096 10000096 10000095 10000099 10000098 10000097 10000095 10000098 10000097 10000097 10000099 10000096 10000096 10000097 10000095 10000096 10000097 10000098 10000169 10000097 10000095 10000097 10000096 10000096 10000097 10000096 10000095 10000099 10000096 10000097 10000095 10000098 10000097 10000095
min_time_thread_terminate_total=10000095
max_time_thread_terminate_total=10000169
first_time_thread_start_by_thread=14 15 14 14 14 14 14 14 14 14 14 14 14 5 5 14 14 14 14 14 14 14 14 14 14 15 14 14 14 14 14 14 14 14 14 14 14 5 5 14 14 14 14 14 14 14 14 14 4 5 4 5 4 4 5 5 4 5 4 4 5 5 5 4 4 4 4 5 4 5 5 4 4 5 4 5 4 4 5 5 8 5 4 4 5 5 5 4 4 4 4 5 4 5 5 4
min_time_thread_start_total=4
max_time_thread_start_total=15
sum_duration_all_ops_total=

threads_final_keysum=99844538891695
threads_final_size=9986580
final_keysum=99844538891695
final_size=9986580
validate_result=success
Validation OK.
Structural validation OK.

total_find=495694068
total_rq=0
total_inserts=27535203
total_deletes=27532768
total_updates=55067971
total_queries=495694068
total_ops=550762039
find_throughput=49569406
rq_throughput=0
update_throughput=5506797
query_throughput=49569406
total_throughput=55076203


total find                    : 495694068
total rq                      : 0
total inserts                 : 27535203
total deletes                 : 27532768
total updates                 : 55067971
total queries                 : 495694068
total ops                     : 550762039
find throughput               : 49569406
rq throughput                 : 0
update throughput             : 5506797
query throughput              : 49569406
total throughput              : 55076203

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=29.9387
PAPI_L3_TCM=10.733
PAPI_TOT_CYC=4842.72
PAPI_TOT_INS=1293.85
garbage=2462242721350465
total_execution_walltime=12.254s
REALTIME_MAIN_END_PERF_FORMAT=6984063.313228819
[time_cmd_output] time_elapsed_sec=12.43, faults_major=0, faults_minor=271047, mem_maxresident_kb=1081864, user_cputime=1162.05, sys_cputime=4.04, percent_cpu=9374%
timeout=false
algorithm=bronson_pext_bst_occ.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2