__step=000164
__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 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000164.txt
__path_data=data/data000164.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6980795.448332155
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=2000000
PREFILL_THREADS=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.022s
prefilling_size=999723 prefilling_elapsed_millis=1.001s
finished prefilling to size 999744 for expected size 1000000 keysum=999545876072, performing 49214016 updates; total_prefilling_elapsed_ms=1103 ms)
pref_size=999744
pref_millis=1103
prefill_elapsed_ms=1119
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=766

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6980796.760103841
REALTIME_END_PERF_FORMAT=6980806.760251053

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

tree_stats_computeWalltime=0.032s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 254 501 965 1791 3206 5508 9096 14273 21308 30324 40790 52002 62791 72331 79767 84135 85250 82359 76143 67281 57026 46228 35431 25608 17739 11549 7037 3974 2048 1006 437 178 65 29 16 6 3 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 2 7 37 139 376 904 1920 3919 7238 12292 19858 29578 41213 53251 64895 75399 83020 88141 88575 85005 77536 67824 57025 45254 33477 23929 16061 10100 5900 3090 1575 696 291 101 42 26 9 5 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 508 1002 1930 3582 6412 11016 18192 28546 42616 60648 81580 104004 125582 144662 159534 168270 170500 164718 152286 134562 114052 92456 70862 51216 35478 23098 14074 7948 4096 2012 874 356 130 58 32 12 6 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 2 7 37 139 376 904 1920 3919 7238 12292 19858 29578 41213 53251 64895 75399 83020 88141 88575 85005 77536 67824 57025 45254 33477 23929 16061 10100 5900 3090 1575 696 291 101 42 26 9 5 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99219 1.98622 1.96307 1.92798 1.89503 1.85901 1.82571 1.78458 1.74644 1.71156 1.67257 1.63744 1.60374 1.57597 1.5514 1.52738 1.50663 1.48304 1.46226 1.44181 1.42379 1.40532 1.38322 1.36138 1.34636 1.32553 1.30466 1.28236 1.25767 1.24561 1.2172 1.20366 1.18258 1.22308 1.27586 1.1875 1.25 1.16667 1

tree_stats_height=47
tree_stats_numInternals=998711
tree_stats_numLeaves=998712
tree_stats_numNodes=1997423
tree_stats_numKeys=998712

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

tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8192 16256 32064 61760 114624 205184 352512 582144 913472 1363712 1940736 2610560 3328128 4018624 4629184 5105088 5384640 5456000 5270976 4873152 4305984 3649664 2958592 2267584 1638912 1135296 739136 450368 254336 131072 64384 27968 11392 4160 1856 1024 384 192 64
tree_stats_sizeInBytes=63917536

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:218080 4:451608 8:193964 16:2586 32:1
    (2^01, 2^02]: 218080
    (2^02, 2^03]: 451608
    (2^03, 2^04]: 193964
    (2^04, 2^05]: 2586
    (2^05, 2^06]: 1
sum_limbo_reclamation_event_size_total=4456914
count_limbo_reclamation_event_size_by_thread=8956 9034 9053 8999 8982 8972 8968 9042 9045 9004 8990 9064 8982 9063 9065 9034 8974 9029 9010 9027 8982 9075 9028 8962 8981 8956 9071 9021 9035 8970 8999 8989 9027 9134 9040 9049 9065 9013 9070 9041 9037 9018 8989 9023 9012 9035 8990 8948 8953 8996 9080 9063 9020 9086 9038 9073 9053 9060 9010 9025 9012 9060 9060 9065 9094 8998 9029 9014 9104 9064 8996 9019 8973 8987 9051 8995 9013 8973 8995 9024 8997 9089 9038 9051 9017 9031 9051 8996 9012 8919 8992 9072 9092 9039 9029 8978
count_limbo_reclamation_event_size_total=866239
sum_limbo_reclamation_event_count_total=1146048
first_thread_announced_epoch_by_thread=25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408 25408
sum_num_inserts_by_thread=55154 55149 55641 55651 55858 54896 54839 55045 55682 56091 55548 54930 55422 55480 55935 56080 55460 54903 53964 54956 55205 55575 54938 54419 54123 54992 55729 55537 55221 54079 54651 55018 56124 56013 55125 55210 55114 55104 55967 55334 55281 54632 54824 55203 55440 55842 54959 54940 54808 55054 55850 55625 55625 55549 55288 55576 56367 55826 55589 54854 55288 55541 55981 56035 55854 55416 54477 55451 56303 56366 55707 55161 54868 55283 55730 55622 55534 54979 55144 55681 56579 56083 55871 55319 55769 55412 56266 55958 55542 54606 54739 54857 56126 56374 55932 55367
sum_num_inserts_total=5318515
sum_num_deletes_by_thread=54794 55328 55669 55230 55955 55319 54540 54963 56288 55849 55583 55392 55130 55163 55285 56123 55401 55066 54561 55059 55757 55955 55390 54293 54650 54758 55789 55525 55248 54247 55010 55441 55869 56384 55401 55176 55284 55078 56010 55899 55122 54464 54780 54862 55899 55860 54839 54376 54765 55089 56049 56146 55908 55618 55461 55959 56552 56229 55605 55001 55254 55936 56011 56410 56092 54828 55015 55251 56333 56431 55788 55002 54616 55150 55662 55707 55501 54381 55507 55800 56341 56513 55877 55761 55585 55646 55730 56107 54912 54549 54171 55127 56163 56165 55748 55601
sum_num_deletes_total=5323117
sum_num_searches_by_thread=10857289 10917465 11022003 11010380 10997291 10825830 10867411 10935620 11077137 11086655 10956855 10878075 10944909 10934877 11047415 11085556 11030191 10879912 10790544 10892373 10998747 11011004 10917775 10789254 10828083 10881461 11030681 11016745 10952758 10721703 10893828 10941879 11091227 11089004 10947051 10879254 10900069 10939061 11050300 11034030 10983080 10833998 10779552 10889677 10997576 11035214 10879011 10804913 10856132 10907940 11094921 11090115 10982023 10923244 10930245 11013655 11166320 11106134 11030067 10908461 10943002 11005466 11112193 11104050 11031085 10848939 10816464 10927681 11099060 11113356 10993909 10942142 10875567 10926035 11080890 11078811 10976630 10874692 10939889 11016738 11192260 11160187 11049748 10947265 10994819 10991757 11087812 11082839 10989236 10814257 10781494 10882063 11121055 11104595 11040600 10973743
sum_num_searches_total=1053084309
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=10967237 11027942 11133313 11121261 11109104 10936045 10976790 11045628 11189107 11198595 11067986 10988397 11055461 11045520 11158635 11197759 11141052 10989881 10899069 11002388 11109709 11122534 11028103 10897966 10936856 10991211 11142199 11127807 11063227 10830029 11003489 11052338 11203220 11201401 11057577 10989640 11010467 11049243 11162277 11145263 11093483 10943094 10889156 10999742 11108915 11146916 10988809 10914229 10965705 11018083 11206820 11201886 11093556 11034411 11040994 11125190 11279239 11218189 11141261 11018316 11053544 11116943 11224185 11216495 11143031 10959183 10925956 11038383 11211696 11226153 11105404 11052305 10985051 11036468 11192282 11190140 11087665 10984052 11050540 11128219 11305180 11272783 11161496 11058345 11106173 11102815 11199808 11194904 11099690 10923412 10890404 10992047 11233344 11217134 11152280 11084711
average_num_operations_total=11080478
stdev_num_operations_total=10498
sum_num_operations_total=1063725941
min_num_operations_total=10830029
max_num_operations_total=11305180
first_time_thread_terminate_by_thread=10000149 10000149 10000149 10000150 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000148 10000150 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000150 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000148 10000150 10000149 10000149 10000149 10000149 10000147 10000148 10000147 10000147 10000147 10000148 10000147 10000148 10000147 10000147 10000147 10000147 10000148 10000147 10000147 10000149 10000147 10000149 10000147 10000149 10000147 10000149 10000149 10000148 10000147 10000148 10000147 10000147 10000147 10000148 10000147 10000148 10000147 10000147 10000147 10000147 10000148 10000147 10000147 10000148 10000147 10000147 10000147 10000149 10000147 10000149 10000149 10000148
min_time_thread_terminate_total=10000147
max_time_thread_terminate_total=10000150
first_time_thread_start_by_thread=4 4 4 4 4 5 5 4 4 5 5 5 4 4 4 5 4 4 5 5 4 4 4 4 4 4 4 4 4 5 5 4 4 5 5 5 4 4 4 5 4 4 5 5 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 5 4 5 4 4 5 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 5 4 5 4 4 5 4 4 4 4
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=

threads_final_keysum=999134210845
threads_final_size=998712
final_keysum=999134210845
final_size=998712
validate_result=success
Validation OK.
Structural validation OK.

total_find=1053084309
total_rq=0
total_inserts=5318515
total_deletes=5323117
total_updates=10641632
total_queries=1053084309
total_ops=1063725941
find_throughput=105308430
rq_throughput=0
update_throughput=1064163
query_throughput=105308430
total_throughput=106372594


total find                    : 1053084309
total rq                      : 0
total inserts                 : 5318515
total deletes                 : 5323117
total updates                 : 10641632
total queries                 : 1053084309
total ops                     : 1063725941
find throughput               : 105308430
rq throughput                 : 0
update throughput             : 1064163
query throughput              : 105308430
total throughput              : 106372594

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=12.2537
PAPI_L3_TCM=1.93234
PAPI_TOT_CYC=2510.74
PAPI_TOT_INS=329.145
garbage=526403370596576
total_execution_walltime=11.44s
REALTIME_MAIN_END_PERF_FORMAT=6980806.889542474
[time_cmd_output] time_elapsed_sec=11.57, faults_major=0, faults_minor=94091, mem_maxresident_kb=374348, user_cputime=1090.74, sys_cputime=3.91, percent_cpu=9460%
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=2