__step=000497
__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=data000497.txt
__path_data=data/data000497.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=212854.522110163
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=1000613 prefilling_elapsed_millis=1s
finished prefilling to size 1000595 for expected size 1000000 keysum=999971816872, performing 35246471 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=1000595
pref_millis=1101
prefill_elapsed_ms=1117
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=1029

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=212855.671650209
REALTIME_END_PERF_FORMAT=212865.671730836

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

tree_stats_computeWalltime=0.141s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 252 487 897 1600 2756 4500 7051 10659 15304 21308 28574 36698 45438 54210 62424 69811 75882 79532 80551 78151 71891 62731 52372 41591 31615 22708 15791 10316 6320 3610 2010 1079 590 351 202 118 71 46 19 4 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 4 17 77 194 444 1012 1949 3443 6014 9300 14042 20450 27958 36666 45996 55037 63740 72232 78513 82951 84411 81051 73090 63153 51567 40522 29625 21266 14312 9030 5210 2941 1568 829 500 286 165 96 73 34 8
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 504 974 1794 3200 5512 9000 14102 21318 30608 42616 57148 73396 90876 108420 124848 139622 151764 159064 161102 156302 143782 125462 104744 83182 63230 45416 31582 20632 12640 7220 4020 2158 1180 702 404 236 142 92 38 8
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 4 17 77 194 444 1012 1949 3443 6014 9300 14042 20450 27958 36666 45996 55037 63740 72232 78513 82951 84411 81051 73090 63153 51567 40522 29625 21266 14312 9030 5210 2941 1568 829 500 286 165 96 73 34 8
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.98438 1.96627 1.92094 1.89186 1.86125 1.8164 1.78344 1.75585 1.71789 1.69616 1.6705 1.64216 1.61908 1.59653 1.57576 1.55917 1.54348 1.52405 1.50641 1.4851 1.45995 1.43629 1.41743 1.39707 1.38007 1.35913 1.3477 1.32664 1.30632 1.2856 1.27839 1.26841 1.2734 1.29746 1.28775 1.29208 1.30085 1.32394 1.20652 1.10526 1

tree_stats_height=49
tree_stats_numInternals=999775
tree_stats_numLeaves=999776
tree_stats_numNodes=1999551
tree_stats_numKeys=999776

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

tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8192 16128 31168 57408 102400 176384 288000 451264 682176 979456 1363712 1828736 2348672 2908032 3469440 3995136 4467904 4856448 5090048 5155264 5001664 4601024 4014784 3351808 2661824 2023360 1453312 1010624 660224 404480 231040 128640 69056 37760 22464 12928 7552 4544 2944 1216 256
tree_stats_sizeInBytes=63985632

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:2 4:106 8:9111 16:337210 32:292951 64:207 128:225 256:60
    (2^01, 2^02]: 2
    (2^02, 2^03]: 106
    (2^03, 2^04]: 9111
    (2^04, 2^05]: 337210
    (2^05, 2^06]: 292951
    (2^06, 2^07]: 207
    (2^07, 2^08]: 225
    (2^08, 2^09]: 60
sum_limbo_reclamation_event_size_total=19573892
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 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=639872
sum_limbo_reclamation_event_count_total=798528
first_thread_announced_epoch_by_thread=27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012 27012
sum_num_inserts_by_thread=387078 389133 386426 386317 387502 386610 387136 386385 385769 385010 382338 380135 380327 378387 377274 377082 376423 385247 383695 382469 382933 384133 383305 383906 381641 379167 376210 375365 376668 374579 375116 373807 387268 386785 384311 384699 385212 385081 383448 380176 379493 379326 378127 376635 377156 377683 385730 384331 382213 384719 382604 382834 382141 378768 376063 375408 376418 374853 373792 373968 385843 385396 385741 384805
sum_num_inserts_total=24418600
sum_num_deletes_by_thread=385939 387390 386693 385991 388341 386765 386851 385920 386484 385970 381590 380198 380375 377798 379033 377718 377193 385133 382516 382718 382719 384159 383638 382654 382198 381632 375902 375528 376458 375103 374740 374429 387708 386633 383861 385365 384980 384506 382868 380263 379411 378085 376517 377463 378097 376627 386295 385608 382738 382757 382100 382649 381071 379794 376196 375321 375436 375901 373794 374115 385733 385596 385855 385441
sum_num_deletes_total=24418560
sum_num_searches_by_thread=6959230 6983727 6943963 6964142 6980962 6964912 6966188 6960371 6960790 6928226 6881134 6839157 6838845 6814938 6805071 6803795 6782085 6935164 6899498 6886872 6887179 6908725 6886747 6885286 6882969 6836165 6782777 6761702 6768142 6757099 6744699 6724819 6971952 6952511 6927217 6925101 6931531 6936338 6905589 6853905 6835745 6815618 6795301 6779348 6802840 6788839 6948514 6920085 6905036 6904069 6876123 6878463 6880855 6821073 6772944 6749001 6766254 6759990 6746156 6745616 6940953 6933011 6933814 6939158
sum_num_searches_total=439568329
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=7732247 7760250 7717082 7736450 7756805 7738287 7740175 7732676 7733043 7699206 7645062 7599490 7599547 7571123 7561378 7558595 7535701 7705544 7665709 7652059 7652831 7677017 7653690 7651846 7646808 7596964 7534889 7512595 7521268 7506781 7494555 7473055 7746928 7725929 7695389 7695165 7701723 7705925 7671905 7614344 7594649 7573029 7549945 7533446 7558093 7543149 7720539 7690024 7669987 7671545 7640827 7643946 7644067 7579635 7525203 7499730 7518108 7510744 7493742 7493699 7712529 7704003 7705410 7709404
average_num_operations_total=7631335
stdev_num_operations_total=10687
sum_num_operations_total=488405489
min_num_operations_total=7473055
max_num_operations_total=7760250
first_time_thread_terminate_by_thread=10000081 10000081 10000081 10000081 10000082 10000082 10000082 10000082 10000081 10000081 10000081 10000081 10000082 10000082 10000082 10000082 10000082 10000082 10000082 10000082 10000081 10000081 10000081 10000081 10000080 10000079 10000079 10000079 10000080 10000080 10000080 10000080 10000083 10000083 10000083 10000083 10000079 10000080 10000079 10000079 10000083 10000083 10000083 10000083 10000082 10000082 10000082 10000082 10000080 10000079 10000080 10000080 10000080 10000080 10000080 10000080 10000081 10000081 10000081 10000081 10000080 10000080 10000080 10000080
min_time_thread_terminate_total=10000079
max_time_thread_terminate_total=10000083
first_time_thread_start_by_thread=3 3 3 3 5 5 5 5 4 4 4 4 5 5 5 5 4 4 4 4 7 7 7 7 3 3 3 3 7 7 7 7 7 7 7 7 4 4 4 4 6 6 6 6 6 6 6 6 6 6 6 5 6 6 6 6 4 4 3 3 5 5 5 5
min_time_thread_start_total=3
max_time_thread_start_total=7
sum_duration_all_ops_total=

threads_final_keysum=999471653994
threads_final_size=999776
final_keysum=999471653994
final_size=999776
validate_result=success
Validation OK.
Structural validation OK.

total_find=439568329
total_rq=0
total_inserts=24418600
total_deletes=24418560
total_updates=48837160
total_queries=439568329
total_ops=488405489
find_throughput=43956832
rq_throughput=0
update_throughput=4883716
query_throughput=43956832
total_throughput=48840548


total find                    : 439568329
total rq                      : 0
total inserts                 : 24418600
total deletes                 : 24418560
total updates                 : 48837160
total queries                 : 439568329
total ops                     : 488405489
find throughput               : 43956832
rq throughput                 : 0
update throughput             : 4883716
query throughput              : 43956832
total throughput              : 48840548

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=89436884959412
total_execution_walltime=11.381s
REALTIME_MAIN_END_PERF_FORMAT=212865.903807551
[time_cmd_output] time_elapsed_sec=11.49, faults_major=0, faults_minor=91629, mem_maxresident_kb=367868, user_cputime=744.16, sys_cputime=4.53, percent_cpu=6514%
timeout=false
algorithm=natarajan_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1