__step=000930
__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" ./ellen_ext_bst_lf.debra -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000930.txt
__path_data=data/data000930.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6990155.16249485
binary=./ellen_ext_bst_lf.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=ellen_ext_bst_lf
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=200000
PREFILL_THREADS=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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=40 descriptor=64
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


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.004s
prefilling_size=99700 prefilling_elapsed_millis=1.001s
finished prefilling to size 99712 for expected size 100000 keysum=9960843275, performing 50359253 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99712
pref_millis=1102
prefill_elapsed_ms=1121
6node_tIxPvE_object_size=40
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=2730

6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=0

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6990156.281583029
REALTIME_END_PERF_FORMAT=6990166.281730964

###############################################################################
################################## 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 (192 threads)...
partitioned into 948 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.037s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 246 474 878 1542 2461 3554 4906 6334 7689 8822 9228 9263 8684 7780 6444 5193 3999 3084 2438 1948 1522 1131 784 458 295 207 155 122 64 24 9 1 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 10 18 70 214 623 1368 2202 3478 4979 6556 8416 9193 9842 9588 9116 7695 6387 4914 3730 2928 2374 1913 1478 1110 621 383 259 188 180 104 39 17 2
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 492 948 1756 3084 4922 7108 9812 12668 15378 17644 18456 18526 17368 15560 12888 10386 7998 6168 4876 3896 3044 2262 1568 916 590 414 310 244 128 48 18 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 10 18 70 214 623 1368 2202 3478 4979 6556 8416 9193 9842 9588 9116 7695 6387 4914 3730 2928 2374 1913 1478 1110 621 383 259 188 180 104 39 17 2
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 1.96094 1.96341 1.92616 1.87813 1.79799 1.72206 1.69021 1.64554 1.60696 1.57368 1.52301 1.5019 1.46875 1.44795 1.41414 1.40293 1.38504 1.3856 1.39527 1.39951 1.39066 1.37155 1.3466 1.29209 1.32205 1.35085 1.3744 1.39355 1.2623 1.1875 1.1875 1.05556 1

tree_stats_height=43
tree_stats_numInternals=99996
tree_stats_numLeaves=99997
tree_stats_numNodes=199993
tree_stats_numKeys=99995

tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=0.99998
tree_stats_avgDegree=1.49999
tree_stats_avgKeyDepth=23.1798

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 19680 37920 70240 123360 196880 284320 392480 506720 615120 705760 738240 741040 694720 622400 515520 415440 319920 246720 195040 155840 121760 90480 62720 36640 23600 16560 12400 9760 5120 1920 720 80
tree_stats_sizeInBytes=7999720

6node_tIxPvE_object_size=40
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=29535

6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=0


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:39 2:12 4:1 8:0 16:3 32:4 64:3660 128:285010 256:191032 512:3
    [2^00, 2^01]: 39
    (2^01, 2^02]: 12
    (2^02, 2^03]: 1
    (2^03, 2^04]: 0
    (2^04, 2^05]: 3
    (2^05, 2^06]: 4
    (2^06, 2^07]: 3660
    (2^07, 2^08]: 285010
    (2^08, 2^09]: 191032
    (2^09, 2^10]: 3
sum_limbo_reclamation_event_size_total=115134639
count_limbo_reclamation_event_size_by_thread=9996 9996 9994 9996 9994 9994 9996 9994 9996 9996 9996 9996 9994 9994 9996 9996 9996 9994 9994 9996 9994 9996 9996 9996 9994 9994 9996 9996 9994 9994 9996 9996 9994 9996 9994 9994 9996 9994 9996 9996 9994 9996 9994 9994 9994 9994 9996 9996
count_limbo_reclamation_event_size_total=479764
sum_limbo_reclamation_event_count_total=2573280
first_thread_announced_epoch_by_thread=59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070 59070
sum_num_inserts_by_thread=5102664 5131504 5173556 5161245 5143627 5089986 5137174 5145401 5194719 5205427 5138822 5113367 5135731 5160022 5181854 5179368 5162846 5133310 5103051 5140387 5180782 5175420 5144087 5092468 5092770 5131096 5153598 5164266 5146669 5098479 5143139 5148019 5194159 5213401 5141749 5124047 5144869 5166417 5202399 5196038 5145482 5122420 5102000 5134924 5159299 5188158 5147131 5093525
sum_num_inserts_total=247080872
sum_num_deletes_by_thread=5101634 5132983 5169592 5161884 5144715 5090806 5136301 5145518 5196973 5202989 5145395 5118972 5134418 5155773 5184187 5175250 5161826 5135538 5110203 5136864 5178315 5180317 5141363 5098358 5097177 5130324 5154680 5159970 5146678 5100939 5145076 5151295 5193252 5210356 5144817 5124949 5143089 5167990 5198586 5195950 5147720 5121890 5100869 5133734 5158962 5185380 5143924 5093944
sum_num_deletes_total=247091725
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=10204298 10264487 10343148 10323129 10288342 10180792 10273475 10290919 10391692 10408416 10284217 10232339 10270149 10315795 10366041 10354618 10324672 10268848 10213254 10277251 10359097 10355737 10285450 10190826 10189947 10261420 10308278 10324236 10293347 10199418 10288215 10299314 10387411 10423757 10286566 10248996 10287958 10334407 10400985 10391988 10293202 10244310 10202869 10268658 10318261 10373538 10291055 10187469
average_num_operations_total=10295262
stdev_num_operations_total=9299
sum_num_operations_total=494172597
min_num_operations_total=10180792
max_num_operations_total=10423757
first_time_thread_terminate_by_thread=10000147 10000147 10000147 10000146 10000147 10000147 10000146 10000147 10000147 10000146 10000147 10000147 10000147 10000146 10000147 10000146 10000147 10000147 10000146 10000146 10000147 10000146 10000146 10000147 10000147 10000146 10000147 10000146 10000147 10000147 10000146 10000146 10000147 10000146 10000147 10000147 10000146 10000146 10000147 10000146 10000147 10000147 10000146 10000146 10000147 10000146 10000146 10000147
min_time_thread_terminate_total=10000146
max_time_thread_terminate_total=10000147
first_time_thread_start_by_thread=4 4 4 4 4 4 3 3 4 3 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 3 4 4 4 3 3 4 3 4 4 4 4 4 4 4 4 4 4 4 3 4 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=10016863341
threads_final_size=99995
final_keysum=10016863341
final_size=99995
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=247080872
total_deletes=247091725
total_updates=494172597
total_queries=0
total_ops=494172597
find_throughput=0
rq_throughput=0
update_throughput=49417259
query_throughput=0
total_throughput=49417259


total find                    : 0
total rq                      : 0
total inserts                 : 247080872
total deletes                 : 247091725
total updates                 : 494172597
total queries                 : 0
total ops                     : 494172597
find throughput               : 0
rq throughput                 : 0
update throughput             : 49417259
query throughput              : 0
total throughput              : 49417259

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=21.2097
PAPI_L3_TCM=0.00302878
PAPI_TOT_CYC=2697.94
PAPI_TOT_INS=929.159
garbage=0
total_execution_walltime=11.395s
REALTIME_MAIN_END_PERF_FORMAT=6990166.412154918
[time_cmd_output] time_elapsed_sec=11.51, faults_major=0, faults_minor=78941, mem_maxresident_kb=317532, user_cputime=561.68, sys_cputime=3.60, percent_cpu=4907%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2