__step=000338
__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" ./brown_ext_abtree_lf.debra -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000338.txt
__path_data=data/data000338.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6982835.492180169
binary=./brown_ext_abtree_lf.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=brown_ext_abtree_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=5
DEL_FRAC=5
RQ=0
RQSIZE=0
MAXKEY=20000000
PREFILL_THREADS=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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
size_node=208
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.006s
prefilling_size=8729804 prefilling_elapsed_millis=1.001s
prefilling_size=8953929 prefilling_elapsed_millis=1.101s
prefilling_size=9138677 prefilling_elapsed_millis=1.201s
prefilling_size=9291406 prefilling_elapsed_millis=1.301s
prefilling_size=9414893 prefilling_elapsed_millis=1.401s
prefilling_size=9514671 prefilling_elapsed_millis=1.501s
prefilling_size=9596482 prefilling_elapsed_millis=1.602s
prefilling_size=9664571 prefilling_elapsed_millis=1.702s
prefilling_size=9722083 prefilling_elapsed_millis=1.802s
prefilling_size=9769489 prefilling_elapsed_millis=1.902s
prefilling_size=9808101 prefilling_elapsed_millis=2.002s
finished prefilling to size 9808098 for expected size 10000000 keysum=98075063653461, performing 79380546 updates; total_prefilling_elapsed_ms=2103 ms)
pref_size=9808098
pref_millis=2103
prefill_elapsed_ms=2127
N9abtree_ns4NodeILi11ExEE_object_size=208
N9abtree_ns4NodeILi11ExEE_allocated_count=0
N9abtree_ns4NodeILi11ExEE_allocated_size=0MB
N9abtree_ns4NodeILi11ExEE_get_from_pool=0
N9abtree_ns4NodeILi11ExEE_deallocated=0
N9abtree_ns4NodeILi11ExEE_limbo_count=0
N9abtree_ns4NodeILi11ExEE_limbo_details=0 0 0
global_epoch_counter=3854
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6982837.781960272
REALTIME_END_PERF_FORMAT=6982847.782116998
###############################################################################
################################## 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 3831 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.058s
tree_stats_numInternalsAtDepth=1 1 8 69 507 3831 28676 223410 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1759810
tree_stats_numNodesAtDepth=1 1 8 69 507 3831 28676 223410 1759810
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9990176
tree_stats_avgDegreeAtDepth=1 8 8.625 7.34783 7.55621 7.48525 7.79084 7.87704 5.67685
tree_stats_height=9
tree_stats_numInternals=256503
tree_stats_numLeaves=1759810
tree_stats_numNodes=2016313
tree_stats_numKeys=9990176
tree_stats_avgDegreeInternal=7.86078
tree_stats_avgDegreeLeaves=5.67685
tree_stats_avgDegree=5.95468
tree_stats_avgKeyDepth=8
tree_stats_bytesAtDepth=208 208 1664 14352 105456 796848 5964608 46469280 366040480
tree_stats_sizeInBytes=419393104
N9abtree_ns4NodeILi11ExEE_object_size=208
N9abtree_ns4NodeILi11ExEE_allocated_count=0
N9abtree_ns4NodeILi11ExEE_allocated_size=0MB
N9abtree_ns4NodeILi11ExEE_get_from_pool=0
N9abtree_ns4NodeILi11ExEE_deallocated=0
N9abtree_ns4NodeILi11ExEE_limbo_count=0
N9abtree_ns4NodeILi11ExEE_limbo_details=0 0 0
global_epoch_counter=28311
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:1 4:32 8:18512 16:431469 32:29890
(2^01, 2^02]: 1
(2^02, 2^03]: 32
(2^03, 2^04]: 18512
(2^04, 2^05]: 431469
(2^05, 2^06]: 29890
sum_limbo_reclamation_event_size_total=11392898
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=479904
sum_limbo_reclamation_event_count_total=1173936
first_thread_announced_epoch_by_thread=56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622 56622
sum_num_inserts_by_thread=560623 564057 567355 566314 565405 557410 561871 563658 569200 569139 563572 558511 559887 562295 566096 567911 565579 559747 558798 560469 563998 566856 561834 557869 560661 563546 567358 566388 565158 558957 562200 564011 567749 570462 563012 559135 561574 563791 568144 567026 564565 560586 559120 559877 564292 565152 559939 556621
sum_num_inserts_total=27037778
sum_num_deletes_by_thread=558057 563671 566532 566248 564651 559086 561314 563395 568916 570627 563492 558705 561755 563327 565536 567059 564307 560863 558160 560743 562781 566010 561046 559185 561050 563083 567334 563013 565038 558731 561397 562408 566944 568989 564456 558778 560823 563096 568094 567457 563501 561385 557045 560480 563299 564427 558444 558236
sum_num_deletes_total=27022974
sum_num_searches_by_thread=10071767 10149521 10198616 10197018 10170791 10061894 10125767 10157164 10240256 10243873 10148313 10065771 10092098 10125996 10194809 10201068 10165382 10093932 10062826 10092555 10143229 10193199 10099495 10029022 10093337 10135368 10209398 10177009 10170593 10052994 10097625 10153057 10237568 10233624 10149001 10063942 10097365 10138012 10212948 10199273 10162210 10090671 10045736 10060476 10137397 10154520 10077676 10020540
sum_num_searches_total=486494702
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=11190447 11277249 11332503 11329580 11300847 11178390 11248952 11284217 11378372 11383639 11275377 11182987 11213740 11251618 11326441 11336038 11295268 11214542 11179784 11213767 11270008 11326065 11222375 11146076 11215048 11261997 11344090 11306410 11300789 11170682 11221222 11279476 11372261 11373075 11276469 11181855 11219762 11264899 11349186 11333756 11290276 11212642 11161901 11180833 11264988 11284099 11196059 11135397
average_num_operations_total=11261571
stdev_num_operations_total=9787
sum_num_operations_total=540555454
min_num_operations_total=11135397
max_num_operations_total=11383639
first_time_thread_terminate_by_thread=10000157 10000156 10000157 10000156 10000156 10000157 10000156 10000157 10000157 10000157 10000157 10000157 10000157 10000156 10000156 10000157 10000156 10000157 10000157 10000157 10000156 10000157 10000156 10000156 10000157 10000156 10000157 10000156 10000156 10000157 10000156 10000157 10000157 10000157 10000157 10000157 10000157 10000156 10000156 10000157 10000156 10000157 10000157 10000157 10000156 10000157 10000156 10000156
min_time_thread_terminate_total=10000156
max_time_thread_terminate_total=10000157
first_time_thread_start_by_thread=3 3 3 3 4 3 3 3 3 3 3 3 4 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 4 3 3 3 3 4 3 3 3 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=
threads_final_keysum=99907022166192
threads_final_size=9990176
final_keysum=99907022166192
final_size=9990176
validate_result=success
Validation OK.
Structural validation OK.
total_find=486494702
total_rq=0
total_inserts=27037778
total_deletes=27022974
total_updates=54060752
total_queries=486494702
total_ops=540555454
find_throughput=48649470
rq_throughput=0
update_throughput=5406075
query_throughput=48649470
total_throughput=54055545
total find : 486494702
total rq : 0
total inserts : 27037778
total deletes : 27022974
total updates : 54060752
total queries : 486494702
total ops : 540555454
find throughput : 48649470
rq throughput : 0
update throughput : 5406075
query throughput : 48649470
total throughput : 54055545
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=17.9286
PAPI_L3_TCM=5.75409
PAPI_TOT_CYC=2466.11
PAPI_TOT_INS=409.232
garbage=2416568804115835
total_execution_walltime=12.425s
REALTIME_MAIN_END_PERF_FORMAT=6982847.918466762
[time_cmd_output] time_elapsed_sec=12.59, faults_major=0, faults_minor=185807, mem_maxresident_kb=744572, user_cputime=611.34, sys_cputime=2.96, percent_cpu=4878%
timeout=false
algorithm=brown_ext_abtree_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