__step=000538
__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 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000538.txt
__path_data=data/data000538.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=213329.990965023
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=2000000
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.016s
prefilling_size=1000731 prefilling_elapsed_millis=1s
finished prefilling to size 1000724 for expected size 1000000 keysum=1000601217244, performing 37808168 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=1000724
pref_millis=1101
prefill_elapsed_ms=1122
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=1003

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=213331.145448424
REALTIME_END_PERF_FORMAT=213341.145540973

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

tree_stats_numInternalsAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65472 125992 192840 167962 61812 6625 100 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 64 4553 50533 173375 202736 80740 8399 125
tree_stats_numNodesAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 130545 243373 341337 264548 87365 8499 125
tree_stats_numKeysAtDepth=0 0 1 3 3 7 13 34 71 129 270 511 1022 2009 4110 8228 16685 35114 81457 188157 310126 257264 86943 8495 125
tree_stats_avgDegreeAtDepth=1 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99294 1.89916 1.61015 1.28294 1.09657 1.02145 1.00294 1

tree_stats_height=25
tree_stats_numInternals=686339
tree_stats_numLeaves=520525
tree_stats_numNodes=1206864
tree_stats_numKeys=1000777

tree_stats_avgDegreeInternal=1.75841
tree_stats_avgDegreeLeaves=0.999973
tree_stats_avgDegree=1.43129
tree_stats_avgKeyDepth=19.8357

tree_stats_bytesAtDepth=56 56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917504 1835008 3670016 7310520 13628888 19114872 14814688 4892440 475944 7000
tree_stats_sizeInBytes=67584384

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:169 2:3030 4:69721 8:452189 16:114443 32:141 64:38 128:126
    [2^00, 2^01]: 169
    (2^01, 2^02]: 3030
    (2^02, 2^03]: 69721
    (2^03, 2^04]: 452189
    (2^04, 2^05]: 114443
    (2^05, 2^06]: 141
    (2^06, 2^07]: 38
    (2^07, 2^08]: 126
sum_limbo_reclamation_event_size_total=7708483
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9997 9997 9997 9998 9998 9998 9998 9997 9997 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9997 9998 9998 9998 9997 9998 9997 9998 9998 9998 9998 9996 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9997 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998
count_limbo_reclamation_event_size_total=639857
sum_limbo_reclamation_event_count_total=889661
first_thread_announced_epoch_by_thread=29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808 29808
sum_num_inserts_by_thread=429993 435233 434337 429531 433226 431388 423468 426052 422639 424474 417191 416626 432243 429948 427520 427752 429632 428624 421821 423971 423394 419403 419895 414921 418051 416960 427273 423166 427057 426616 420898 425096 426232 424335 421374 415088 415047 417142 412239 412120 424792 423204 421746 426400 423044 421986 421123 421135 416290 413119 411077 410215 413860 410288 413164 427417 425600 421013 423763 420016 428278 427526 428156 421894
sum_num_inserts_total=27047082
sum_num_deletes_by_thread=430507 436086 434294 430399 432446 430312 423498 426951 420757 424462 417526 418369 433577 429304 428219 428632 427709 429230 422189 423661 421508 419742 418522 414322 416834 417091 427048 423410 426144 425994 421281 425546 427782 425370 421044 414476 414932 417291 413088 412006 425089 424369 421393 426092 422782 421628 421333 419754 416346 412043 411988 409357 414151 410159 410515 426994 426465 421280 424074 420650 427396 426930 428982 421251
sum_num_deletes_total=27042580
sum_num_searches_by_thread=7753939 7842025 7805231 7757756 7794721 7754837 7625687 7682432 7603936 7637739 7524134 7515445 7802790 7724498 7709082 7696780 7732091 7724112 7604544 7632782 7605214 7570492 7553503 7457884 7514143 7496674 7695979 7603421 7677582 7671949 7568450 7646959 7682170 7640121 7580569 7467379 7473582 7517730 7426408 7429791 7653062 7630720 7596546 7664600 7612642 7599877 7581981 7571114 7497574 7416153 7393565 7374007 7464042 7371168 7418686 7693351 7663781 7576702 7641467 7571910 7689739 7691643 7701521 7598068
sum_num_searches_total=486878480
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=8614439 8713344 8673862 8617686 8660393 8616537 8472653 8535435 8447332 8486675 8358851 8350440 8668610 8583750 8564821 8553164 8589432 8581966 8448554 8480414 8450116 8409637 8391920 8287127 8349028 8330725 8550300 8449997 8530783 8524559 8410629 8497601 8536184 8489826 8422987 8296943 8303561 8352163 8251735 8253917 8502943 8478293 8439685 8517092 8458468 8443491 8424437 8412003 8330210 8241315 8216630 8193579 8292053 8191615 8242365 8547762 8515846 8418995 8489304 8412576 8545413 8546099 8558659 8441213
average_num_operations_total=8452627
stdev_num_operations_total=15841
sum_num_operations_total=540968142
min_num_operations_total=8191615
max_num_operations_total=8713344
first_time_thread_terminate_by_thread=10000093 10000093 10000093 10000093 10000092 10000092 10000092 10000092 10000094 10000094 10000094 10000094 10000092 10000092 10000092 10000093 10000094 10000094 10000094 10000094 10000092 10000092 10000091 10000091 10000093 10000090 10000090 10000090 10000095 10000095 10000095 10000095 10000095 10000095 10000095 10000095 10000092 10000092 10000092 10000092 10000095 10000095 10000095 10000095 10000093 10000092 10000092 10000092 10000093 10000093 10000094 10000093 10000093 10000093 10000093 10000093 10000095 10000095 10000095 10000095 10000093 10000093 10000093 10000093
min_time_thread_terminate_total=10000090
max_time_thread_terminate_total=10000095
first_time_thread_start_by_thread=10 10 10 10 10 10 10 10 13 13 13 13 12 12 12 12 11 11 11 12 11 11 11 11 8 9 9 9 12 12 12 12 15 15 15 15 14 14 14 14 15 15 15 15 14 14 14 13 13 13 13 13 12 12 12 12 14 14 14 14 14 14 14 14
min_time_thread_start_total=8
max_time_thread_start_total=15
sum_duration_all_ops_total=

threads_final_keysum=1000434065459
threads_final_size=1000777
final_keysum=1000434065459
final_size=1000777
validate_result=success
Validation OK.
Structural validation OK.

total_find=486878480
total_rq=0
total_inserts=27047082
total_deletes=27042580
total_updates=54089662
total_queries=486878480
total_ops=540968142
find_throughput=48687848
rq_throughput=0
update_throughput=5408966
query_throughput=48687848
total_throughput=54096814


total find                    : 486878480
total rq                      : 0
total inserts                 : 27047082
total deletes                 : 27042580
total updates                 : 54089662
total queries                 : 486878480
total ops                     : 540968142
find throughput               : 48687848
rq throughput                 : 0
update throughput             : 5408966
query throughput              : 48687848
total throughput              : 54096814

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=60692746266802
total_execution_walltime=11.318s
REALTIME_MAIN_END_PERF_FORMAT=213341.310313949
[time_cmd_output] time_elapsed_sec=11.42, faults_major=0, faults_minor=95028, mem_maxresident_kb=380860, user_cputime=730.11, sys_cputime=5.45, percent_cpu=6438%
timeout=false
algorithm=bronson_pext_bst_occ.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2