__step=000090
__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 0.5 0.5 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000090.txt
__path_data=data/data000090.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=207947.356558416
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=0.5
DEL_FRAC=0.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=0.5 0.5
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.018s
prefilling_size=7925753 prefilling_elapsed_millis=1s
prefilling_size=8199041 prefilling_elapsed_millis=1.1s
prefilling_size=8437098 prefilling_elapsed_millis=1.201s
prefilling_size=8640794 prefilling_elapsed_millis=1.301s
prefilling_size=8817172 prefilling_elapsed_millis=1.401s
prefilling_size=8971056 prefilling_elapsed_millis=1.501s
prefilling_size=9104398 prefilling_elapsed_millis=1.601s
prefilling_size=9218512 prefilling_elapsed_millis=1.701s
prefilling_size=9318319 prefilling_elapsed_millis=1.801s
prefilling_size=9406635 prefilling_elapsed_millis=1.901s
prefilling_size=9480492 prefilling_elapsed_millis=2.002s
prefilling_size=9543945 prefilling_elapsed_millis=2.102s
prefilling_size=9598810 prefilling_elapsed_millis=2.202s
prefilling_size=9646984 prefilling_elapsed_millis=2.302s
prefilling_size=9690312 prefilling_elapsed_millis=2.402s
prefilling_size=9726169 prefilling_elapsed_millis=2.502s
prefilling_size=9757777 prefilling_elapsed_millis=2.602s
prefilling_size=9788768 prefilling_elapsed_millis=2.702s
prefilling_size=9813848 prefilling_elapsed_millis=2.802s
finished prefilling to size 9813879 for expected size 10000000 keysum=98133996895393, performing 82359433 updates; total_prefilling_elapsed_ms=2903 ms)
pref_size=9813879
pref_millis=2903
prefill_elapsed_ms=2918
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=2104

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=207950.314318035
REALTIME_END_PERF_FORMAT=207960.314369029

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

tree_stats_numInternalsAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262127 522158 992957 1564976 1684111 1043665 317379 38248 1027 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 17 1989 45846 354741 1157108 1768122 1280811 411520 49685 1261
tree_stats_numNodesAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262144 524147 1038803 1919717 2841219 2811787 1598190 449768 50712 1261
tree_stats_numKeysAtDepth=0 0 2 3 1 9 13 33 58 124 247 527 1061 2097 4189 8321 16802 33301 67129 137050 290312 656269 1447516 2466584 2646535 1562578 446813 50671 1261
tree_stats_avgDegreeAtDepth=1 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99953 1.98569 1.89214 1.6648 1.39689 1.1972 1.08282 1.0277 1.00461 1

tree_stats_height=29
tree_stats_numInternals=6688792
tree_stats_numLeaves=5071100
tree_stats_numNodes=11759892
tree_stats_numKeys=9839506

tree_stats_avgDegreeInternal=1.75815
tree_stats_avgDegreeLeaves=0.999978
tree_stats_avgDegree=1.43121
tree_stats_avgKeyDepth=23.2377

tree_stats_bytesAtDepth=56 56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917504 1835008 3670016 7340032 14680064 29352232 58172968 107504152 159108264 157460072 89498640 25187008 2839872 70616
tree_stats_sizeInBytes=658553952

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:159991 2:141321 4:24836 8:188 16:1
    [2^00, 2^01]: 159991
    (2^01, 2^02]: 141321
    (2^02, 2^03]: 24836
    (2^03, 2^04]: 188
    (2^04, 2^05]: 1
sum_limbo_reclamation_event_size_total=598230
count_limbo_reclamation_event_size_by_thread=5144 5165 5086 5242 5157 5114 5059 5202 5148 5087 5075 5091 4989 5069 5151 5163 5083 5080 5151 5082 5148 5051 5139 5071 5001 5124 5134 4935 5094 5062 5071 5024 5146 5126 5151 5180 5051 5060 5182 5095 4975 5116 5072 5124 5045 5119 5257 5219 5193 5061 5047 5079 5115 5148 5017 4990 5025 5088 5039 5027 5157 5062 5082 5097
count_limbo_reclamation_event_size_total=326337
sum_limbo_reclamation_event_count_total=508800
first_thread_announced_epoch_by_thread=20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108 20108
sum_num_inserts_by_thread=24783 24784 24866 24582 24886 24877 24997 24625 24613 24485 24167 24525 24547 24320 24041 23802 24298 24633 24750 24404 24803 24837 24526 24260 24486 24371 24231 24547 24281 24204 24308 23804 24650 25003 24478 24293 24907 24876 24508 24863 24614 23992 24180 23806 24034 24188 24368 24429 24579 24547 24387 24703 24410 24120 24219 24264 24327 24320 24328 24106 24653 24524 24637 24617
sum_num_inserts_total=1565573
sum_num_deletes_by_thread=24863 24758 24668 24604 24982 24642 24524 24449 24630 24559 24110 24753 24321 24471 23841 24020 24520 24782 24492 24456 24686 24845 24388 24108 24405 24443 24524 24151 24187 24383 23719 24132 24961 24980 24417 24362 24899 24751 24364 24598 24296 24198 23791 24094 24577 24037 24496 24580 24404 24519 24189 24436 24380 24101 24024 24396 24473 24312 24296 24256 24479 24521 24548 24869
sum_num_deletes_total=1564020
sum_num_searches_by_thread=4928414 4869825 4894887 4848313 4926448 4925868 4914362 4853176 4847638 4892070 4811371 4843016 4846785 4845199 4777863 4776637 4845385 4916051 4835081 4889206 4897689 4893565 4828780 4823347 4876679 4803152 4776329 4812239 4771375 4817997 4755115 4799409 4936698 4927998 4851294 4850158 4916559 4918366 4841145 4879848 4861269 4791325 4780304 4767913 4833951 4774225 4850190 4839113 4816726 4879414 4800999 4858466 4807070 4792502 4814523 4799458 4815825 4804587 4797255 4786210 4841230 4898379 4888650 4890803
sum_num_searches_total=310055724
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4978060 4919367 4944421 4897499 4976316 4975387 4963883 4902250 4896881 4941114 4859648 4892294 4895653 4893990 4825745 4824459 4894203 4965466 4884323 4938066 4947178 4943247 4877694 4871715 4925570 4851966 4825084 4860937 4819843 4866584 4803142 4847345 4986309 4977981 4900189 4898813 4966365 4967993 4890017 4929309 4910179 4839515 4828275 4815813 4882562 4822450 4899054 4888122 4865709 4928480 4849575 4907605 4855860 4840723 4862766 4848118 4864625 4853219 4845879 4834572 4890362 4947424 4937835 4940289
average_num_operations_total=4893520
stdev_num_operations_total=6216
sum_num_operations_total=313185317
min_num_operations_total=4803142
max_num_operations_total=4986309
first_time_thread_terminate_by_thread=10000051 10000051 10000051 10000051 10000055 10000055 10000055 10000055 10000054 10000054 10000054 10000054 10000052 10000052 10000052 10000052 10000053 10000053 10000053 10000053 10000053 10000053 10000053 10000053 10000054 10000054 10000054 10000054 10000050 10000051 10000051 10000051 10000054 10000054 10000054 10000054 10000051 10000051 10000052 10000051 10000051 10000052 10000051 10000051 10000053 10000053 10000053 10000053 10000052 10000052 10000052 10000052 10000052 10000053 10000052 10000052 10000055 10000055 10000055 10000055 10000055 10000055 10000055 10000055
min_time_thread_terminate_total=10000050
max_time_thread_terminate_total=10000055
first_time_thread_start_by_thread=11 11 11 11 11 11 11 11 8 8 8 8 13 13 13 13 12 12 12 12 10 10 9 10 10 10 10 10 8 8 7 8 9 9 9 9 9 9 9 9 9 9 9 9 10 10 10 10 12 12 12 12 11 11 11 11 12 12 12 12 11 12 12 12
min_time_thread_start_total=7
max_time_thread_start_total=13
sum_duration_all_ops_total=

threads_final_keysum=98389548567856
threads_final_size=9839506
final_keysum=98389548567856
final_size=9839506
validate_result=success
Validation OK.
Structural validation OK.

total_find=310055724
total_rq=0
total_inserts=1565573
total_deletes=1564020
total_updates=3129593
total_queries=310055724
total_ops=313185317
find_throughput=31005572
rq_throughput=0
update_throughput=312959
query_throughput=31005572
total_throughput=31318531


total find                    : 310055724
total rq                      : 0
total inserts                 : 1565573
total deletes                 : 1564020
total updates                 : 3129593
total queries                 : 310055724
total ops                     : 313185317
find throughput               : 31005572
rq throughput                 : 0
update throughput             : 312959
query throughput              : 31005572
total throughput              : 31318531

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=165199594525911
total_execution_walltime=13.089s
REALTIME_MAIN_END_PERF_FORMAT=207960.446197992
[time_cmd_output] time_elapsed_sec=13.24, faults_major=0, faults_minor=264590, mem_maxresident_kb=1059060, user_cputime=845.36, sys_cputime=5.83, percent_cpu=6425%
timeout=false
algorithm=bronson_pext_bst_occ.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2