__step=000426
__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 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000426.txt
__path_data=data/data000426.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=212006.872738081
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=20000000
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=7916477 prefilling_elapsed_millis=1s
prefilling_size=8188729 prefilling_elapsed_millis=1.1s
prefilling_size=8424068 prefilling_elapsed_millis=1.201s
prefilling_size=8627530 prefilling_elapsed_millis=1.301s
prefilling_size=8800934 prefilling_elapsed_millis=1.401s
prefilling_size=8950191 prefilling_elapsed_millis=1.501s
prefilling_size=9079371 prefilling_elapsed_millis=1.601s
prefilling_size=9191893 prefilling_elapsed_millis=1.701s
prefilling_size=9291026 prefilling_elapsed_millis=1.801s
prefilling_size=9374954 prefilling_elapsed_millis=1.901s
prefilling_size=9450818 prefilling_elapsed_millis=2.002s
prefilling_size=9515156 prefilling_elapsed_millis=2.102s
prefilling_size=9572013 prefilling_elapsed_millis=2.202s
prefilling_size=9621734 prefilling_elapsed_millis=2.302s
prefilling_size=9666775 prefilling_elapsed_millis=2.402s
prefilling_size=9706047 prefilling_elapsed_millis=2.502s
prefilling_size=9740437 prefilling_elapsed_millis=2.602s
prefilling_size=9771430 prefilling_elapsed_millis=2.702s
prefilling_size=9798450 prefilling_elapsed_millis=2.802s
prefilling_size=9821071 prefilling_elapsed_millis=2.903s
finished prefilling to size 9821055 for expected size 10000000 keysum=98238759328925, performing 83701449 updates; total_prefilling_elapsed_ms=3003 ms)
pref_size=9821055
pref_millis=3003
prefill_elapsed_ms=3017
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=2139

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=212009.930068014
REALTIME_END_PERF_FORMAT=212019.930143308

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

tree_stats_numInternalsAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262135 523372 1011198 1644595 1777596 1029257 273236 28002 593 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 9 852 32275 323166 1218899 1918416 1282611 354719 36108 739
tree_stats_numNodesAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262144 524224 1043473 1967761 2996495 2947673 1555847 382721 36701 739
tree_stats_numKeysAtDepth=0 1 2 3 4 7 14 35 58 148 257 512 1007 2083 4169 8350 16371 32847 66160 133672 280541 633451 1451667 2596569 2786910 1525579 380647 36674 739
tree_stats_avgDegreeAtDepth=1 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99979 1.99214 1.91671 1.68702 1.39047 1.17862 1.07035 1.02271 1.00398 1

tree_stats_height=29
tree_stats_numInternals=6812128
tree_stats_numLeaves=5167794
tree_stats_numNodes=11979922
tree_stats_numKeys=9958477

tree_stats_avgDegreeInternal=1.75862
tree_stats_avgDegreeLeaves=0.999971
tree_stats_avgDegree=1.43136
tree_stats_avgKeyDepth=23.2253

tree_stats_bytesAtDepth=56 56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917504 1835008 3670016 7340032 14680064 29356544 58434488 110194616 167803720 165069688 87127432 21432376 2055256 41384
tree_stats_sizeInBytes=670875632

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:102 2:2571 4:56902 8:351506 16:86183 32:247 64:1
    [2^00, 2^01]: 102
    (2^01, 2^02]: 2571
    (2^02, 2^03]: 56902
    (2^03, 2^04]: 351506
    (2^04, 2^05]: 86183
    (2^05, 2^06]: 247
    (2^06, 2^07]: 1
sum_limbo_reclamation_event_size_total=5937188
count_limbo_reclamation_event_size_by_thread=7774 7774 7774 7769 7774 7774 7772 7774 7774 7774 7773 7773 7772 7774 7774 7773 7773 7774 7774 7774 7774 7773 7774 7774 7773 7774 7774 7774 7774 7774 7774 7774 7774 7774 7774 7774 7774 7774 7774 7774 7774 7774 7773 7774 7773 7774 7774 7772 7774 7774 7773 7773 7774 7774 7774 7774 7774 7773 7773 7774 7774 7774 7773 7774
count_limbo_reclamation_event_size_total=497512
sum_limbo_reclamation_event_count_total=497662
first_thread_announced_epoch_by_thread=19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830 19830
sum_num_inserts_by_thread=243124 243228 241977 239774 239193 239935 239826 241875 239914 239033 240723 239233 236853 238958 235224 239217 236321 240262 238597 242157 242237 241998 240950 240663 237320 239981 237481 238337 238343 238430 234977 237966 244595 240367 243034 242140 240093 242378 238741 237573 237453 237010 237881 235101 238995 235412 242377 239452 238055 238373 239049 240444 241931 236493 234685 238131 238470 237866 237359 234157 243461 243241 241777 239315
sum_num_inserts_total=15319516
sum_num_deletes_by_thread=243603 243522 242040 238403 240392 238926 238713 241929 239272 239214 240013 238821 236188 239583 235733 237545 236466 240102 238642 241810 243070 241878 240820 241609 238160 239716 239087 237673 237621 238203 234673 237064 244074 240403 243013 241957 239653 243275 238839 238175 237117 236074 239345 235304 238257 235796 242493 238525 238544 238446 239911 240294 240819 236528 235870 236548 238441 236787 237700 233910 243375 242426 241906 239384
sum_num_deletes_total=15313680
sum_num_searches_by_thread=4381895 4380675 4356159 4301587 4321410 4319335 4307891 4355463 4305465 4299437 4322398 4305382 4256272 4301399 4236076 4287633 4254106 4320921 4301671 4345727 4361920 4355550 4347944 4341040 4277364 4309793 4289643 4286175 4291258 4286728 4224233 4273083 4386126 4327867 4361406 4360915 4312489 4362882 4295530 4279912 4267270 4254319 4288418 4233529 4294254 4238224 4359180 4300826 4289507 4291209 4322623 4325922 4334471 4265447 4238027 4272797 4287195 4285080 4269353 4213591 4366217 4363365 4352639 4304540
sum_num_searches_total=275610763
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4868622 4867425 4840176 4779764 4800995 4798196 4786430 4839267 4784651 4777684 4803134 4783436 4729313 4779940 4707033 4764395 4726893 4801285 4778910 4829694 4847227 4839426 4829714 4823312 4752844 4789490 4766211 4762185 4767222 4763361 4693883 4748113 4874795 4808637 4847453 4845012 4792235 4848535 4773110 4755660 4741840 4727403 4765644 4703934 4771506 4709432 4844050 4778803 4766106 4768028 4801583 4806660 4817221 4738468 4708582 4747476 4764106 4759733 4744412 4681658 4853053 4849032 4836322 4783239
average_num_operations_total=4785061
stdev_num_operations_total=5895
sum_num_operations_total=306243959
min_num_operations_total=4681658
max_num_operations_total=4874795
first_time_thread_terminate_by_thread=10000080 10000080 10000080 10000080 10000079 10000079 10000079 10000079 10000079 10000079 10000079 10000079 10000077 10000077 10000077 10000077 10000080 10000080 10000080 10000080 10000077 10000077 10000077 10000077 10000077 10000077 10000076 10000076 10000079 10000079 10000079 10000079 10000081 10000081 10000081 10000081 10000078 10000078 10000078 10000078 10000076 10000076 10000076 10000076 10000077 10000077 10000077 10000077 10000081 10000081 10000081 10000081 10000078 10000078 10000078 10000078 10000076 10000076 10000076 10000076 10000075 10000075 10000075 10000075
min_time_thread_terminate_total=10000075
max_time_thread_terminate_total=10000081
first_time_thread_start_by_thread=5 5 5 5 7 7 7 7 9 9 9 9 5 5 5 4 8 8 8 8 6 6 6 6 6 6 6 7 4 4 4 4 4 4 4 4 9 9 10 9 5 5 5 5 7 7 7 7 10 10 10 10 4 4 4 4 11 11 11 11 8 8 8 8
min_time_thread_start_total=4
max_time_thread_start_total=11
sum_duration_all_ops_total=

threads_final_keysum=99612682227598
threads_final_size=9958477
final_keysum=99612682227598
final_size=9958477
validate_result=success
Validation OK.
Structural validation OK.

total_find=275610763
total_rq=0
total_inserts=15319516
total_deletes=15313680
total_updates=30633196
total_queries=275610763
total_ops=306243959
find_throughput=27561076
rq_throughput=0
update_throughput=3063319
query_throughput=27561076
total_throughput=30624395


total find                    : 275610763
total rq                      : 0
total inserts                 : 15319516
total deletes                 : 15313680
total updates                 : 30633196
total queries                 : 275610763
total ops                     : 306243959
find throughput               : 27561076
rq throughput                 : 0
update throughput             : 3063319
query throughput              : 27561076
total throughput              : 30624395

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=748119120012417
total_execution_walltime=13.198s
REALTIME_MAIN_END_PERF_FORMAT=212020.71544779
[time_cmd_output] time_elapsed_sec=13.35, faults_major=0, faults_minor=268158, mem_maxresident_kb=1073260, user_cputime=849.49, sys_cputime=5.29, percent_cpu=6400%
timeout=false
algorithm=bronson_pext_bst_occ.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2