__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 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000498.txt
__path_data=data/data000498.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6984899.588617643
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=5
DEL_FRAC=5
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=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,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=998877 prefilling_elapsed_millis=1.001s
finished prefilling to size 998865 for expected size 1000000 keysum=998828351785, performing 39156508 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=998865
pref_millis=1101
prefill_elapsed_ms=1124
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=1869

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6984900.874370591
REALTIME_END_PERF_FORMAT=6984910.874514887

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

tree_stats_computeWalltime=0.04s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 498 946 1716 3043 5188 8535 13454 20117 28709 38900 50121 61360 71770 80083 84994 86200 83463 76649 67281 56487 45365 34979 25880 18706 12935 8733 5594 3454 1985 1100 581 310 146 59 20 9 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 14 50 176 389 898 1841 3616 6791 11525 18518 27679 38882 50950 63457 75172 83788 88937 90277 86017 78075 67609 55751 44078 33054 24477 17137 11872 7734 4923 2870 1619 852 474 233 98 31 16 4
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 996 1892 3432 6086 10376 17070 26908 40234 57418 77800 100242 122720 143540 160166 169988 172400 166926 153298 134562 112974 90730 69958 51760 37412 25870 17466 11188 6908 3970 2200 1162 620 292 118 40 18 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 14 50 176 389 898 1841 3616 6791 11525 18518 27679 38882 50950 63457 75172 83788 88937 90277 86017 78075 67609 55751 44078 33054 24477 17137 11872 7734 4923 2870 1619 852 474 233 98 31 16 4
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 1.97266 1.9498 1.90698 1.88666 1.85245 1.82257 1.78817 1.74762 1.71355 1.67749 1.64423 1.61212 1.58483 1.55791 1.53066 1.50709 1.48412 1.45918 1.43889 1.41978 1.40155 1.38553 1.36994 1.3614 1.34574 1.33757 1.32028 1.30872 1.28735 1.27708 1.26409 1.26678 1.23548 1.20205 1.16949 1.225 1.11111 1

tree_stats_height=47
tree_stats_numInternals=999883
tree_stats_numLeaves=999884
tree_stats_numNodes=1999767
tree_stats_numKeys=999884

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

tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8192 16384 31872 60544 109824 194752 332032 546240 861056 1287488 1837376 2489600 3207744 3927040 4593280 5125312 5439616 5516800 5341632 4905536 4305984 3615168 2903360 2238656 1656320 1197184 827840 558912 358016 221056 127040 70400 37184 19840 9344 3776 1280 576 128
tree_stats_sizeInBytes=63992544

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:69 4:1407 8:52792 16:370639 32:54805 64:99 128:34 256:47
    (2^01, 2^02]: 69
    (2^02, 2^03]: 1407
    (2^03, 2^04]: 52792
    (2^04, 2^05]: 370639
    (2^05, 2^06]: 54805
    (2^06, 2^07]: 99
    (2^07, 2^08]: 34
    (2^08, 2^09]: 47
sum_limbo_reclamation_event_size_total=11003150
count_limbo_reclamation_event_size_by_thread=9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9997 9998 9998 9997 9998 9998 9998 9998 9998 9998 9997 9997 9997 9998 9997 9997 9998 9998 9998 9998 9997 9998 9998 9997
count_limbo_reclamation_event_size_total=479892
sum_limbo_reclamation_event_count_total=1058832
first_thread_announced_epoch_by_thread=47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856 47856
sum_num_inserts_by_thread=500838 504867 507477 507712 505900 500187 498662 506726 511107 513888 505325 501741 504467 505862 511880 512325 508361 504054 501757 506448 509646 512427 503160 500815 499598 504090 507345 507993 504776 499395 500747 504300 512388 512239 506989 504650 503681 506074 507588 510811 508856 505140 499729 505755 508123 511770 505706 501937
sum_num_inserts_total=24285312
sum_num_deletes_by_thread=499923 503370 506473 510087 505953 501256 500354 506072 510425 514277 505289 502036 504366 506508 510685 511267 507198 503948 501618 504915 508819 511999 504221 500079 501038 504205 508912 507383 503221 499741 499863 504429 512325 512628 506417 504454 503086 505123 507636 511066 508495 504101 499561 504316 506531 511372 504526 500318
sum_num_deletes_total=24271885
sum_num_searches_by_thread=8999499 9077822 9127542 9158179 9105646 9002687 9000913 9111890 9188722 9241655 9092204 9033087 9070024 9104403 9211358 9216587 9146279 9076768 9029325 9102622 9177357 9224780 9063858 9010910 9019964 9081268 9147542 9118335 9085403 8997289 9014470 9064057 9206697 9229325 9118355 9082832 9064814 9090798 9144924 9199810 9144995 9102675 8985739 9085000 9131337 9191571 9099608 9019343
sum_num_searches_total=437000268
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=10000260 10086059 10141492 10175978 10117499 10004130 9999929 10124688 10210254 10269820 10102818 10036864 10078857 10116773 10233923 10240179 10161838 10084770 10032700 10113985 10195822 10249206 10071239 10011804 10020600 10089563 10163799 10133711 10093400 9996425 10015080 10072786 10231410 10254192 10131761 10091936 10071581 10101995 10160148 10221687 10162346 10111916 9985029 10095071 10145991 10214713 10109840 10021598
average_num_operations_total=10115780
stdev_num_operations_total=11426
sum_num_operations_total=485557465
min_num_operations_total=9985029
max_num_operations_total=10269820
first_time_thread_terminate_by_thread=10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000142 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000142 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000142 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000142 10000143 10000143
min_time_thread_terminate_total=10000142
max_time_thread_terminate_total=10000143
first_time_thread_start_by_thread=6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 7 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 7 6 6 6 6 6
min_time_thread_start_total=6
max_time_thread_start_total=7
sum_duration_all_ops_total=

threads_final_keysum=999557248953
threads_final_size=999884
final_keysum=999557248953
final_size=999884
validate_result=success
Validation OK.
Structural validation OK.

total_find=437000268
total_rq=0
total_inserts=24285312
total_deletes=24271885
total_updates=48557197
total_queries=437000268
total_ops=485557465
find_throughput=43700026
rq_throughput=0
update_throughput=4855719
query_throughput=43700026
total_throughput=48555746


total find                    : 437000268
total rq                      : 0
total inserts                 : 24285312
total deletes                 : 24271885
total updates                 : 48557197
total queries                 : 437000268
total ops                     : 485557465
find throughput               : 43700026
rq throughput                 : 0
update throughput             : 4855719
query throughput              : 43700026
total throughput              : 48555746

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=11.9786
PAPI_L3_TCM=1.72829
PAPI_TOT_CYC=2755.56
PAPI_TOT_INS=377.806
garbage=218528031811095
total_execution_walltime=11.437s
REALTIME_MAIN_END_PERF_FORMAT=6984911.26925435
[time_cmd_output] time_elapsed_sec=11.56, faults_major=0, faults_minor=91538, mem_maxresident_kb=368536, user_cputime=562.62, sys_cputime=3.33, percent_cpu=4893%
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