__step=000049
__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" ./natarajan_ext_bst_lf.debra -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000049.txt
__path_data=data/data000049.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6979343.849826265
binary=./natarajan_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=natarajan_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=0.5
DEL_FRAC=0.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=0.5 0.5
PREFILL_TYPE=PREFILL_HYBRID
PREFILL_HYBRID_MIN_MS=1000
PREFILL_HYBRID_MAX_MS=5000
sizes: node=32
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.023s
prefilling_size=7225125 prefilling_elapsed_millis=1.001s
prefilling_size=7497161 prefilling_elapsed_millis=1.101s
prefilling_size=7739393 prefilling_elapsed_millis=1.201s
prefilling_size=7958630 prefilling_elapsed_millis=1.301s
prefilling_size=8154746 prefilling_elapsed_millis=1.402s
prefilling_size=8329265 prefilling_elapsed_millis=1.502s
prefilling_size=8486409 prefilling_elapsed_millis=1.602s
prefilling_size=8627084 prefilling_elapsed_millis=1.702s
prefilling_size=8755273 prefilling_elapsed_millis=1.803s
prefilling_size=8869834 prefilling_elapsed_millis=1.903s
prefilling_size=8974398 prefilling_elapsed_millis=2.003s
prefilling_size=9068382 prefilling_elapsed_millis=2.103s
prefilling_size=9154455 prefilling_elapsed_millis=2.203s
prefilling_size=9231851 prefilling_elapsed_millis=2.303s
prefilling_size=9301671 prefilling_elapsed_millis=2.404s
prefilling_size=9362556 prefilling_elapsed_millis=2.504s
prefilling_size=9419731 prefilling_elapsed_millis=2.604s
prefilling_size=9471682 prefilling_elapsed_millis=2.704s
prefilling_size=9518515 prefilling_elapsed_millis=2.804s
prefilling_size=9562259 prefilling_elapsed_millis=2.905s
prefilling_size=9600530 prefilling_elapsed_millis=3.005s
prefilling_size=9636477 prefilling_elapsed_millis=3.105s
prefilling_size=9668274 prefilling_elapsed_millis=3.205s
prefilling_size=9698128 prefilling_elapsed_millis=3.305s
prefilling_size=9724924 prefilling_elapsed_millis=3.406s
prefilling_size=9747754 prefilling_elapsed_millis=3.506s
prefilling_size=9769698 prefilling_elapsed_millis=3.606s
prefilling_size=9790370 prefilling_elapsed_millis=3.706s
prefilling_size=9810022 prefilling_elapsed_millis=3.806s
finished prefilling to size 9810043 for expected size 10000000 keysum=98083718710376, performing 79264984 updates; total_prefilling_elapsed_ms=3907 ms)
pref_size=9810043
pref_millis=3907
prefill_elapsed_ms=3932
6node_tIxPvE_object_size=32
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=3629

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6979348.5894474
REALTIME_END_PERF_FORMAT=6979358.6030238

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

tree_stats_computeWalltime=0.245s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 510 1009 1977 3751 6953 12427 21307 34952 55025 83041 120173 166837 223117 287829 359514 435189 510533 579027 636525 678264 698322 696532 672584 629783 571314 503520 430198 357352 287431 224535 169789 123839 87874 59581 39393 24944 15148 8705 4826 2649 1393 639 275 108 47 12 4 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 2 11 41 203 549 1479 3547 7662 14879 27009 45909 73509 110557 158405 216144 283839 359845 442039 521529 594786 658206 700112 720480 715385 688252 639108 576842 503044 427273 350327 279281 215739 159804 116167 79769 53842 34740 21591 12584 7003 3905 2147 1003 442 169 82 20 6 4
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1020 2018 3954 7502 13906 24854 42614 69904 110050 166082 240346 333674 446234 575658 719028 870378 1021066 1158054 1273050 1356528 1396644 1393064 1345168 1259566 1142628 1007040 860396 714704 574862 449070 339578 247678 175748 119162 78786 49888 30296 17410 9652 5298 2786 1278 550 216 94 24 8 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 2 11 41 203 549 1479 3547 7662 14879 27009 45909 73509 110557 158405 216144 283839 359845 442039 521529 594786 658206 700112 720480 715385 688252 639108 576842 503044 427273 350327 279281 215739 159804 116167 79769 53842 34740 21591 12584 7003 3905 2147 1003 442 169 82 20 6 4
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 1.99609 1.98922 1.97968 1.94866 1.92682 1.89364 1.85729 1.8202 1.78715 1.75458 1.72358 1.69415 1.66867 1.64502 1.62453 1.60525 1.58656 1.56708 1.54965 1.53279 1.51479 1.49872 1.48281 1.46818 1.45358 1.44067 1.42719 1.41533 1.40217 1.39059 1.37809 1.36468 1.35479 1.33901 1.33058 1.3166 1.30364 1.28733 1.2772 1.27445 1.26293 1.22936 1.21518 1.19636 1.21759 1.12766 1.16667 1.25 1

tree_stats_height=58
tree_stats_numInternals=9829270
tree_stats_numLeaves=9829271
tree_stats_numNodes=19658541
tree_stats_numKeys=9829271

tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=31.529

tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8192 16384 32640 64576 126528 240064 444992 795328 1363648 2236928 3521600 5314624 7691072 10677568 14279488 18421056 23008896 27852096 32674112 37057728 40737600 43408896 44692608 44578048 43045376 40306112 36564096 32225280 27532672 22870528 18395584 14370240 10866496 7925696 5623936 3813184 2521152 1596416 969472 557120 308864 169536 89152 40896 17600 6912 3008 768 256 128
tree_stats_sizeInBytes=629073312

6node_tIxPvE_object_size=32
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=13282


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:168927 4:131821 8:12969 16:9
    (2^01, 2^02]: 168927
    (2^02, 2^03]: 131821
    (2^03, 2^04]: 12969
    (2^04, 2^05]: 9
sum_limbo_reclamation_event_size_total=1048318
count_limbo_reclamation_event_size_by_thread=6516 6538 6555 6533 6575 6494 6563 6501 6560 6547 6543 6490 6578 6509 6616 6501 6586 6511 6481 6496 6542 6560 6574 6512 6538 6504 6543 6548 6598 6577 6474 6520 6604 6534 6556 6446 6507 6539 6565 6552 6588 6558 6437 6581 6529 6567 6414 6566
count_limbo_reclamation_event_size_total=313726
sum_limbo_reclamation_event_count_total=463344
first_thread_announced_epoch_by_thread=26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564 26564
sum_num_inserts_by_thread=22306 22095 21935 22286 22443 22177 21939 22215 22469 22325 22236 22446 22137 22280 22539 22335 22373 22180 21887 22232 22112 22288 21951 22050 22230 21970 22603 22294 22319 21871 22278 22247 22322 22475 22067 21948 22298 22211 22618 22470 22098 21873 21917 21953 22452 22160 22095 21964
sum_num_inserts_total=1065969
sum_num_deletes_by_thread=21868 22028 22340 22406 22262 22011 22451 22128 22592 22432 22441 22020 22236 22191 22571 22324 22518 22202 21905 21988 22492 22285 22264 21977 22038 22150 22329 22332 22159 22199 21949 22181 22588 22125 22366 22110 22050 22194 22174 22241 22403 22299 21845 22164 22082 22235 21881 22185
sum_num_deletes_total=1066211
sum_num_searches_by_thread=4361028 4382220 4419639 4420737 4406160 4358316 4378882 4396758 4447956 4450254 4404180 4378860 4387243 4404956 4433863 4432594 4416010 4384855 4355046 4383107 4416527 4432506 4388431 4356591 4364476 4379880 4420995 4418936 4407838 4359466 4381571 4397863 4445323 4448080 4404532 4382039 4388549 4405672 4434912 4431881 4414443 4384651 4354625 4380539 4411208 4431416 4389480 4355019
sum_num_searches_total=211190113
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4405202 4426343 4463914 4465429 4450865 4402504 4423272 4441101 4493017 4495011 4448857 4423326 4431616 4449427 4478973 4477253 4460901 4429237 4398838 4427327 4461131 4477079 4432646 4400618 4408744 4424000 4465927 4463562 4452316 4403536 4425798 4442291 4490233 4492680 4448965 4426097 4432897 4450077 4479704 4476592 4458944 4428823 4398387 4424656 4455742 4475811 4433456 4399168
average_num_operations_total=4444214
stdev_num_operations_total=4100
sum_num_operations_total=213322293
min_num_operations_total=4398387
max_num_operations_total=4495011
first_time_thread_terminate_by_thread=10000136 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000134 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000136 10000134 10000135 10000135 10000135 10000135
min_time_thread_terminate_total=10000134
max_time_thread_terminate_total=10000136
first_time_thread_start_by_thread=3 3 3 3 3 4 3 3 3 3 3 4 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 4 3 3 3 3 3 3 3 4 3 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=98277203996556
threads_final_size=9829271
final_keysum=98277203996556
final_size=9829271
validate_result=success
Validation OK.
Structural validation OK.

total_find=211190113
total_rq=0
total_inserts=1065969
total_deletes=1066211
total_updates=2132180
total_queries=211190113
total_ops=213322293
find_throughput=21119011
rq_throughput=0
update_throughput=213218
query_throughput=21119011
total_throughput=21332229


total find                    : 211190113
total rq                      : 0
total inserts                 : 1065969
total deletes                 : 1066211
total updates                 : 2132180
total queries                 : 211190113
total ops                     : 213322293
find throughput               : 21119011
rq throughput                 : 0
update throughput             : 213218
query throughput              : 21119011
total throughput              : 21332229

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=24.9447
PAPI_L3_TCM=8.97906
PAPI_TOT_CYC=6274.15
PAPI_TOT_INS=370.332
garbage=1036776077665936
total_execution_walltime=14.486s
REALTIME_MAIN_END_PERF_FORMAT=6979358.347183563
[time_cmd_output] time_elapsed_sec=14.67, faults_major=0, faults_minor=232963, mem_maxresident_kb=933944, user_cputime=698.23, sys_cputime=3.69, percent_cpu=4784%
timeout=false
algorithm=natarajan_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=1