__step=000834
__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 50.0 50.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000834.txt
__path_data=data/data000834.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6989030.500188406
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=50
DEL_FRAC=50
RQ=0
RQSIZE=0
MAXKEY=2000000
PREFILL_THREADS=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=50.0 50.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,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=1000273 prefilling_elapsed_millis=1.001s
finished prefilling to size 1000327 for expected size 1000000 keysum=1000710016321, performing 39284958 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=1000327
pref_millis=1102
prefill_elapsed_ms=1127
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=1872

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6989031.818086114
REALTIME_END_PERF_FORMAT=6989041.818235451

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

tree_stats_computeWalltime=0.035s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 505 949 1760 3107 5321 8817 13792 20574 29131 39367 50736 61632 71299 79035 84202 85650 82682 76332 67532 57089 46051 36222 27170 19343 13048 8151 4912 2919 1676 944 544 279 120 36 11 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 7 61 138 413 893 1825 3842 7010 12017 18895 27998 39840 51965 63563 73868 82754 88618 89032 85132 77975 68127 55880 45274 34997 25638 17945 11390 6905 4162 2408 1344 809 438 204 61 21 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1010 1898 3520 6214 10642 17634 27584 41148 58262 78734 101472 123264 142598 158070 168404 171300 165364 152664 135064 114178 92102 72444 54340 38686 26096 16302 9824 5838 3352 1888 1088 558 240 72 22 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 7 61 138 413 893 1825 3842 7010 12017 18895 27998 39840 51965 63563 73868 82754 88618 89032 85132 77975 68127 55880 45274 34997 25638 17945 11390 6905 4162 2408 1344 809 438 204 61 21 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 1.98633 1.9396 1.92729 1.88267 1.85629 1.82851 1.78213 1.74587 1.70796 1.67569 1.6444 1.60738 1.57843 1.55425 1.53269 1.5086 1.48267 1.4616 1.44236 1.42268 1.40333 1.39328 1.37505 1.35596 1.33728 1.31235 1.30131 1.29713 1.28708 1.28162 1.28814 1.25643 1.21505 1.15 1.15278 1.04545 1

tree_stats_height=46
tree_stats_numInternals=1001450
tree_stats_numLeaves=1001451
tree_stats_numNodes=2002901
tree_stats_numKeys=1001451

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

tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8192 16384 32320 60736 112640 198848 340544 564288 882688 1316736 1864384 2519488 3247104 3944448 4563136 5058240 5388928 5481600 5291648 4885248 4322048 3653696 2947264 2318208 1738880 1237952 835072 521664 314368 186816 107264 60416 34816 17856 7680 2304 704 64
tree_stats_sizeInBytes=64092832

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:22 4:4 8:2 16:5 32:9 64:124 128:462099 256:17556 512:0 1024:0 2048:47
    (2^01, 2^02]: 22
    (2^02, 2^03]: 4
    (2^03, 2^04]: 2
    (2^04, 2^05]: 5
    (2^05, 2^06]: 9
    (2^06, 2^07]: 124
    (2^07, 2^08]: 462099
    (2^08, 2^09]: 17556
    (2^09, 2^10]: 0
    (2^10, 2^11]: 0
    (2^11, 2^12]: 47
sum_limbo_reclamation_event_size_total=105065528
count_limbo_reclamation_event_size_by_thread=9997 9997 9998 9998 9997 9998 9997 9996 9998 9997 9996 9998 9997 9997 9997 9998 9998 9997 9997 9997 9997 9997 9996 9998 9998 9998 9998 9998 9997 9998 9997 9998 9997 9997 9996 9998 9997 9998 9997 9997 9997 9997 9996 9997 9997 9998 9997 9997
count_limbo_reclamation_event_size_total=479868
sum_limbo_reclamation_event_count_total=877413
first_thread_announced_epoch_by_thread=40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312 40312
sum_num_inserts_by_thread=3963988 3982973 4018114 4021627 4005766 3962115 3980906 4000628 4037945 4039079 4004603 3980282 3984439 4003716 4034840 4032648 4015193 3994191 3965871 3989274 4019392 4036567 3986938 3966900 3970222 3990205 4015894 4019249 4001903 3963142 3975341 3997852 4037781 4043416 4003577 3984509 3982805 4001817 4027578 4035923 4010993 3992651 3965820 3987449 4013820 4034684 3992547 3966276
sum_num_inserts_total=192043449
sum_num_deletes_by_thread=3964865 3987069 4020795 4022191 4007322 3963881 3979266 4002961 4036864 4044856 4003776 3980790 3981552 4003938 4033741 4034907 4015379 3996741 3965324 3990913 4020437 4034138 3990080 3970477 3969128 3984759 4018236 4018111 4009102 3958056 3975219 3998609 4040365 4043209 4002047 3981000 3982629 4005301 4028335 4034372 4013849 3990461 3963530 3985644 4012586 4031421 3989148 3963920
sum_num_deletes_total=192051300
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=7928853 7970042 8038909 8043818 8013088 7925996 7960172 8003589 8074809 8083935 8008379 7961072 7965991 8007654 8068581 8067555 8030572 7990932 7931195 7980187 8039829 8070705 7977018 7937377 7939350 7974964 8034130 8037360 8011005 7921198 7950560 7996461 8078146 8086625 8005624 7965509 7965434 8007118 8055913 8070295 8024842 7983112 7929350 7973093 8026406 8066105 7981695 7930196
average_num_operations_total=8001973
stdev_num_operations_total=7216
sum_num_operations_total=384094749
min_num_operations_total=7921198
max_num_operations_total=8086625
first_time_thread_terminate_by_thread=10000149 10000149 10000149 10000149 10000148 10000149 10000149 10000149 10000149 10000149 10000149 10000148 10000149 10000149 10000148 10000148 10000148 10000149 10000149 10000149 10000149 10000148 10000149 10000149 10000149 10000149 10000149 10000149 10000148 10000149 10000149 10000149 10000149 10000149 10000149 10000148 10000149 10000148 10000148 10000148 10000149 10000149 10000148 10000149 10000149 10000148 10000149 10000149
min_time_thread_terminate_total=10000148
max_time_thread_terminate_total=10000149
first_time_thread_start_by_thread=6 5 5 5 5 5 5 5 5 5 5 5 5 5 6 5 5 5 5 5 5 6 6 6 6 5 5 5 5 5 5 5 5 5 5 5 5 5 6 5 5 5 5 5 5 6 6 6
min_time_thread_start_total=5
max_time_thread_start_total=6
sum_duration_all_ops_total=

threads_final_keysum=1001784309212
threads_final_size=1001451
final_keysum=1001784309212
final_size=1001451
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=192043449
total_deletes=192051300
total_updates=384094749
total_queries=0
total_ops=384094749
find_throughput=0
rq_throughput=0
update_throughput=38409474
query_throughput=0
total_throughput=38409474


total find                    : 0
total rq                      : 0
total inserts                 : 192043449
total deletes                 : 192051300
total updates                 : 384094749
total queries                 : 0
total ops                     : 384094749
find throughput               : 0
rq throughput                 : 0
update throughput             : 38409474
query throughput              : 0
total throughput              : 38409474

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=16.7086
PAPI_L3_TCM=2.31667
PAPI_TOT_CYC=3482.45
PAPI_TOT_INS=989.988
garbage=0
total_execution_walltime=11.455s
REALTIME_MAIN_END_PERF_FORMAT=6989041.955819387
[time_cmd_output] time_elapsed_sec=11.57, faults_major=0, faults_minor=91998, mem_maxresident_kb=368604, user_cputime=561.91, sys_cputime=2.02, percent_cpu=4871%
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