__step=000762
__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 50.0 50.0 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000762.txt
__path_data=data/data000762.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=216068.944052146
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=50
DEL_FRAC=50
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=50.0 50.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.02s
prefilling_size=7893165 prefilling_elapsed_millis=1s
prefilling_size=8164539 prefilling_elapsed_millis=1.1s
prefilling_size=8399748 prefilling_elapsed_millis=1.201s
prefilling_size=8604515 prefilling_elapsed_millis=1.301s
prefilling_size=8783251 prefilling_elapsed_millis=1.401s
prefilling_size=8936071 prefilling_elapsed_millis=1.501s
prefilling_size=9067805 prefilling_elapsed_millis=1.601s
prefilling_size=9183059 prefilling_elapsed_millis=1.701s
prefilling_size=9281683 prefilling_elapsed_millis=1.801s
prefilling_size=9369776 prefilling_elapsed_millis=1.901s
prefilling_size=9445659 prefilling_elapsed_millis=2.002s
prefilling_size=9509558 prefilling_elapsed_millis=2.102s
prefilling_size=9568067 prefilling_elapsed_millis=2.202s
prefilling_size=9617895 prefilling_elapsed_millis=2.302s
prefilling_size=9663950 prefilling_elapsed_millis=2.402s
prefilling_size=9702538 prefilling_elapsed_millis=2.502s
prefilling_size=9738053 prefilling_elapsed_millis=2.602s
prefilling_size=9769371 prefilling_elapsed_millis=2.702s
prefilling_size=9795838 prefilling_elapsed_millis=2.802s
prefilling_size=9821537 prefilling_elapsed_millis=2.903s
finished prefilling to size 9821531 for expected size 10000000 keysum=98199463348783, performing 84581716 updates; total_prefilling_elapsed_ms=3003 ms)
pref_size=9821531
pref_millis=3003
prefill_elapsed_ms=3021
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=2171

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=216072.2057515
REALTIME_END_PERF_FORMAT=216082.2089463

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

tree_stats_numInternalsAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262090 521758 999105 1619134 1788541 1079750 295258 29299 741 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 53 2220 39532 322358 1171248 1906251 1343749 383138 37619 921
tree_stats_numNodesAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262143 523978 1038637 1941492 2959789 2986001 1639007 412437 38360 921
tree_stats_numKeysAtDepth=0 1 1 1 4 6 17 33 67 128 269 509 1032 2037 4064 8231 16350 32561 65769 133166 279643 628921 1418870 2542018 2810808 1606292 410184 38316 921
tree_stats_avgDegreeAtDepth=1 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99999 1.99903 1.98645 1.90733 1.69052 1.40456 1.18726 1.07146 1.02195 1.00467 1

tree_stats_height=29
tree_stats_numInternals=6857820
tree_stats_numLeaves=5207089
tree_stats_numNodes=12064909
tree_stats_numKeys=10000219

tree_stats_avgDegreeInternal=1.75929
tree_stats_avgDegreeLeaves=0.999959
tree_stats_avgDegree=1.43157
tree_stats_avgKeyDepth=23.2577

tree_stats_bytesAtDepth=56 56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917504 1835008 3670016 7340032 14680008 29342768 58163672 108723552 165748184 167216056 91784392 23096472 2148160 51576
tree_stats_sizeInBytes=675634904

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:2 16:2 32:8 64:349904 128:105801 256:346 512:1
    (2^03, 2^04]: 2
    (2^04, 2^05]: 2
    (2^05, 2^06]: 8
    (2^06, 2^07]: 349904
    (2^07, 2^08]: 105801
    (2^08, 2^09]: 346
    (2^09, 2^10]: 1
sum_limbo_reclamation_event_size_total=54282057
count_limbo_reclamation_event_size_by_thread=7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126 7126
count_limbo_reclamation_event_size_total=456064
sum_limbo_reclamation_event_count_total=456192
first_thread_announced_epoch_by_thread=18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598 18598
sum_num_inserts_by_thread=2159536 2195748 2192854 2137350 2143933 2143362 2149018 2151798 2152234 2200192 2193709 2195848 2178469 2131632 2167065 2119653 2124141 2166342 2163783 2162046 2140739 2181903 2131021 2177074 2134567 2179505 2177006 2170835 2125251 2169648 2164951 2163898 2164856 2120840 2183442 2180353 2137881 2135348 2176274 2129558 2179211 2133813 2167967 2157027 2117836 2161290 2158622 2114639 2115688 2190534 2180672 2180494 2131394 2174935 2129662 2172263 2178639 2171462 2121884 2167212 2168111 2174731 2128709 2145418
sum_num_inserts_total=138095876
sum_num_deletes_by_thread=2158390 2200626 2191182 2140828 2146347 2142228 2150234 2150400 2153937 2200909 2195820 2196122 2179285 2129997 2166789 2119825 2121437 2169248 2161519 2161783 2141135 2184392 2133641 2177234 2136188 2181504 2175979 2169240 2127188 2170008 2165733 2163480 2167182 2119823 2183058 2181582 2139060 2137411 2172652 2132098 2181981 2134091 2166085 2158209 2120457 2160468 2155415 2110925 2116276 2188291 2179807 2179613 2133299 2181386 2127623 2173265 2171948 2173268 2119123 2167895 2170268 2173614 2127841 2144599
sum_num_deletes_total=138111241
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4317926 4396374 4384036 4278178 4290280 4285590 4299252 4302198 4306171 4401101 4389529 4391970 4357754 4261629 4333854 4239478 4245578 4335590 4325302 4323829 4281874 4366295 4264662 4354308 4270755 4361009 4352985 4340075 4252439 4339656 4330684 4327378 4332038 4240663 4366500 4361935 4276941 4272759 4348926 4261656 4361192 4267904 4334052 4315236 4238293 4321758 4314037 4225564 4231964 4378825 4360479 4360107 4264693 4356321 4257285 4345528 4350587 4344730 4241007 4335107 4338379 4348345 4256550 4290017
average_num_operations_total=4315736
stdev_num_operations_total=5991
sum_num_operations_total=276207117
min_num_operations_total=4225564
max_num_operations_total=4401101
first_time_thread_terminate_by_thread=10000032 10000032 10000032 10000032 10000035 10000035 10000035 10000035 10000034 10000034 10000034 10000034 10000034 10000034 10000034 10000034 10000035 10000035 10000035 10000035 10000035 10000035 10000035 10000035 10000033 10000033 10000033 10000033 10000034 10000034 10000034 10000034 10000034 10000034 10000034 10000034 10000031 10000031 10000036 10000031 10000031 10000033 10000033 10000031 10000033 10000033 10000033 10000033 10000034 10000033 10000031 10000031 10000033 10000033 10000035 10000033 10000033 10000033 10000033 10000033 10000032 10000032 10000032 10000032
min_time_thread_terminate_total=10000031
max_time_thread_terminate_total=10000036
first_time_thread_start_by_thread=6 6 6 6 4 4 4 4 5 5 5 5 4 3 3 4 7 7 7 7 5 5 5 5 6 6 6 6 7 7 7 7 5 5 5 5 6 6 6 6 4 4 4 4 7 7 7 7 5 5 5 5 6 6 7 6 8 8 8 8 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=8
sum_duration_all_ops_total=

threads_final_keysum=100004985014376
threads_final_size=10000219
final_keysum=100004985014376
final_size=10000219
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=138095876
total_deletes=138111241
total_updates=276207117
total_queries=0
total_ops=276207117
find_throughput=0
rq_throughput=0
update_throughput=27620711
query_throughput=0
total_throughput=27620711


total find                    : 0
total rq                      : 0
total inserts                 : 138095876
total deletes                 : 138111241
total updates                 : 276207117
total queries                 : 0
total ops                     : 276207117
find throughput               : 0
rq throughput                 : 0
update throughput             : 27620711
query throughput              : 0
total throughput              : 27620711

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=0
total_execution_walltime=13.193s
REALTIME_MAIN_END_PERF_FORMAT=216082.137835074
[time_cmd_output] time_elapsed_sec=13.35, faults_major=0, faults_minor=275890, mem_maxresident_kb=1104052, user_cputime=848.67, sys_cputime=5.70, percent_cpu=6398%
timeout=false
algorithm=bronson_pext_bst_occ.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2