__step=000498
__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 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000498.txt
__path_data=data/data000498.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=212866.80239646
binary=./natarajan_ext_bst_lf.debra
parsed custom binding: 0-63,128-191,64-127,192-255
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=5
DEL_FRAC=5
RQ=0
RQSIZE=0
MAXKEY=2000000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
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
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,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=1000604 prefilling_elapsed_millis=1.001s
finished prefilling to size 1000616 for expected size 1000000 keysum=1000665181487, performing 34979038 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=1000616
pref_millis=1102
prefill_elapsed_ms=1109
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=996

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=212867.229884705
REALTIME_END_PERF_FORMAT=212877.229984533

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

tree_stats_computeWalltime=0.14s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 253 490 921 1678 2955 4879 7692 11460 16322 22454 30055 39132 49040 59319 68895 76494 81265 81561 78426 71249 62449 53186 43946 35576 28138 21375 15807 11402 8067 5405 3476 2190 1292 797 416 204 94 40 22 12 6 1 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 3 16 59 164 401 1031 2066 3924 6598 10190 14853 20978 29224 38761 49743 61296 71723 80969 84696 85603 80049 71712 62426 52316 43014 34901 26943 20212 14737 10729 7334 4762 3088 1787 1178 628 314 148 58 32 18 11 1 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 506 980 1842 3356 5910 9758 15384 22920 32644 44908 60110 78264 98080 118638 137790 152988 162530 163122 156852 142498 124898 106372 87892 71152 56276 42750 31614 22804 16134 10810 6952 4380 2584 1594 832 408 188 80 44 24 12 2 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 3 16 59 164 401 1031 2066 3924 6598 10190 14853 20978 29224 38761 49743 61296 71723 80969 84696 85603 80049 71712 62426 52316 43014 34901 26943 20212 14737 10729 7334 4762 3088 1787 1178 628 314 148 58 32 18 11 1 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.98828 1.96838 1.9398 1.91097 1.88051 1.82555 1.78828 1.74493 1.71213 1.68784 1.66926 1.65101 1.6266 1.6048 1.58072 1.55515 1.53119 1.50182 1.48078 1.45424 1.43824 1.42584 1.41314 1.40477 1.39546 1.37982 1.36975 1.36066 1.35375 1.33501 1.32155 1.31502 1.29498 1.30844 1.26098 1.24519 1.23039 1.21277 1.275 1.27273 1.25 1.08333 1.5 1

tree_stats_height=52
tree_stats_numInternals=998697
tree_stats_numLeaves=998698
tree_stats_numNodes=1997395
tree_stats_numKeys=998698

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

tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8192 16192 31360 58944 107392 189120 312256 492288 733440 1044608 1437056 1923520 2504448 3138560 3796416 4409280 4895616 5200960 5219904 5019264 4559936 3996736 3403904 2812544 2276864 1800832 1368000 1011648 729728 516288 345920 222464 140160 82688 51008 26624 13056 6016 2560 1408 768 384 64 64
tree_stats_sizeInBytes=63916640

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:1 4:90 8:8840 16:335854 32:294642 64:258 128:181 256:4
    (2^01, 2^02]: 1
    (2^02, 2^03]: 90
    (2^03, 2^04]: 8840
    (2^04, 2^05]: 335854
    (2^05, 2^06]: 294642
    (2^06, 2^07]: 258
    (2^07, 2^08]: 181
    (2^08, 2^09]: 4
sum_limbo_reclamation_event_size_total=19595866
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 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=639870
sum_limbo_reclamation_event_count_total=802624
first_thread_announced_epoch_by_thread=27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074 27074
sum_num_inserts_by_thread=392940 392000 388486 384138 388396 387016 386090 385283 384358 387983 387087 387164 387413 386234 386609 386573 385176 381551 380707 380118 379601 379961 378272 386322 384899 385699 383736 384225 384833 384609 381318 379200 381691 381025 379862 380038 380207 380962 389612 387356 389155 387771 385638 387444 387263 385582 382951 381257 378814 379518 377534 376593 386553 386150 385580 384269 384150 385286 383641 381971 382129 383091 382577 383417
sum_num_inserts_total=24587084
sum_num_deletes_by_thread=391338 391882 388855 384168 388198 387245 385708 385223 384434 388514 387321 387099 387245 386253 387068 385649 383459 382431 379613 379769 381069 380170 378915 386689 385581 385592 385328 384011 385711 384393 381597 380820 382453 382623 380070 379089 380445 379256 388691 387309 389005 388220 386557 388001 387231 385499 382396 381512 378729 378038 376863 376589 386953 384645 384264 383131 384748 384464 383122 382485 383038 382920 383409 384800
sum_num_deletes_total=24587903
sum_num_searches_by_thread=7060296 7052168 6986874 6925375 6981887 6969123 6942181 6926236 6930599 7010122 6975476 6964901 6975633 6966305 6957258 6950767 6913436 6877433 6843683 6831146 6845341 6832055 6815003 6963939 6939046 6940709 6927774 6918885 6935777 6931643 6860980 6837211 6884262 6875620 6845489 6849113 6855483 6834208 6996502 6973157 6988591 6988317 6949151 6965667 6961100 6936273 6874894 6853222 6818567 6800122 6792784 6771915 6960909 6942646 6919331 6909903 6917339 6924709 6905212 6885065 6885685 6883124 6904980 6915610
sum_num_searches_total=442558212
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=7844574 7836050 7764215 7693681 7758481 7743384 7713979 7696742 7699391 7786619 7749884 7739164 7750291 7738792 7730935 7722989 7682071 7641415 7604003 7591033 7606011 7592186 7572190 7736950 7709526 7712000 7696838 7687121 7706321 7700645 7623895 7597231 7648406 7639268 7605421 7608240 7616135 7594426 7774805 7747822 7766751 7764308 7721346 7741112 7735594 7707354 7640241 7615991 7576110 7557678 7547181 7525097 7734415 7713441 7689175 7677303 7686237 7694459 7671975 7649521 7650852 7649135 7670966 7683827
average_num_operations_total=7683331
stdev_num_operations_total=8720
sum_num_operations_total=491733199
min_num_operations_total=7525097
max_num_operations_total=7844574
first_time_thread_terminate_by_thread=10000102 10000102 10000102 10000102 10000100 10000100 10000100 10000100 10000098 10000100 10000098 10000099 10000101 10000101 10000101 10000101 10000100 10000100 10000100 10000100 10000102 10000102 10000102 10000102 10000099 10000099 10000099 10000099 10000102 10000102 10000102 10000102 10000101 10000101 10000101 10000101 10000100 10000100 10000100 10000100 10000103 10000103 10000103 10000103 10000102 10000102 10000102 10000102 10000100 10000101 10000101 10000100 10000103 10000103 10000103 10000103 10000101 10000101 10000101 10000101 10000103 10000103 10000103 10000103
min_time_thread_terminate_total=10000098
max_time_thread_terminate_total=10000103
first_time_thread_start_by_thread=8 8 8 8 8 8 8 8 9 9 9 9 10 10 10 10 14 14 14 14 13 13 13 13 6 5 6 6 12 12 12 12 10 10 10 10 11 11 11 11 14 14 14 14 14 14 14 14 12 12 12 12 13 13 13 13 11 11 11 11 12 12 12 12
min_time_thread_start_total=5
max_time_thread_start_total=14
sum_duration_all_ops_total=

threads_final_keysum=999040914089
threads_final_size=998698
final_keysum=999040914089
final_size=998698
validate_result=success
Validation OK.
Structural validation OK.

total_find=442558212
total_rq=0
total_inserts=24587084
total_deletes=24587903
total_updates=49174987
total_queries=442558212
total_ops=491733199
find_throughput=44255821
rq_throughput=0
update_throughput=4917498
query_throughput=44255821
total_throughput=49173319


total find                    : 442558212
total rq                      : 0
total inserts                 : 24587084
total deletes                 : 24587903
total updates                 : 49174987
total queries                 : 442558212
total ops                     : 491733199
find throughput               : 44255821
rq throughput                 : 0
update throughput             : 4917498
query throughput              : 44255821
total throughput              : 49173319

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=107237380735701
total_execution_walltime=11.385s
REALTIME_MAIN_END_PERF_FORMAT=212877.466208988
[time_cmd_output] time_elapsed_sec=11.49, faults_major=0, faults_minor=92349, mem_maxresident_kb=370568, user_cputime=744.11, sys_cputime=5.52, percent_cpu=6522%
timeout=false
algorithm=natarajan_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2