__step=000273
__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 0.5 0.5 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000273.txt
__path_data=data/data000273.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6982072.644134810
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=200000
PREFILL_THREADS=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.004s
prefilling_size=100221 prefilling_elapsed_millis=1.001s
finished prefilling to size 100203 for expected size 100000 keysum=10031240319, performing 66713053 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=100203
pref_millis=1102
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=3344

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6982073.926258638
REALTIME_END_PERF_FORMAT=6982083.926391217

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

tree_stats_computeWalltime=0.033s

tree_stats_numInternalsAtDepth=1 2 4 8 16 31 61 116 220 405 731 1250 2031 3159 4731 6454 8053 9065 9547 9428 8857 7888 6709 5556 4516 3523 2647 1892 1276 787 493 296 155 78 35 16 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 1 1 6 12 35 79 212 469 903 1587 3008 4855 7041 8583 9666 9999 9826 9067 7862 6596 5509 4399 3402 2508 1765 1081 690 437 232 121 54 31 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 62 122 232 440 810 1462 2500 4062 6318 9462 12908 16106 18130 19094 18856 17714 15776 13418 11112 9032 7046 5294 3784 2552 1574 986 592 310 156 70 32 2
tree_stats_numKeysAtDepth=0 0 0 0 0 1 1 6 12 35 79 212 469 903 1587 3008 4855 7041 8583 9666 9999 9826 9067 7862 6596 5509 4399 3402 2508 1765 1081 690 437 232 121 54 31 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 1.96875 1.98387 1.95082 1.94828 1.92045 1.90247 1.85499 1.8124 1.7777 1.74881 1.6821 1.62388 1.56283 1.52659 1.49377 1.46972 1.4453 1.42527 1.41407 1.40641 1.39006 1.37567 1.35739 1.33721 1.30839 1.31321 1.3002 1.26182 1.25161 1.22436 1.22857 1.03125 1

tree_stats_height=38
tree_stats_numInternals=100038
tree_stats_numLeaves=100039
tree_stats_numNodes=200077
tree_stats_numKeys=100039

tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=21.1594

tree_stats_bytesAtDepth=32 64 128 256 512 1024 1984 3904 7424 14080 25920 46784 80000 129984 202176 302784 413056 515392 580160 611008 603392 566848 504832 429376 355584 289024 225472 169408 121088 81664 50368 31552 18944 9920 4992 2240 1024 64
tree_stats_sizeInBytes=6402464

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:174555 4:140036 8:14253 16:15
    (2^01, 2^02]: 174555
    (2^02, 2^03]: 140036
    (2^03, 2^04]: 14253
    (2^04, 2^05]: 15
sum_limbo_reclamation_event_size_total=1108530
count_limbo_reclamation_event_size_by_thread=6823 6888 6917 6891 6841 6773 6791 6942 6878 6946 6831 6838 6811 6904 6948 6853 6880 6866 6754 6846 6934 6889 6906 6830 6786 6903 6872 6867 6840 6782 6817 6842 6876 6865 6794 6819 6771 6854 6884 6830 6833 6815 6799 6855 6790 6920 6902 6763
count_limbo_reclamation_event_size_total=328859
sum_limbo_reclamation_event_count_total=2176175
first_thread_announced_epoch_by_thread=97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362 97362
sum_num_inserts_by_thread=103514 104577 105580 104830 105210 103001 104511 105216 105952 106615 105625 104374 104687 105137 105913 106070 105417 105191 103695 104685 106248 106521 104822 104338 103185 104322 105094 104623 104696 103538 103966 104159 105575 106028 104834 105011 104814 104814 105624 105523 104999 104688 103808 104498 105918 106095 104844 103917
sum_num_inserts_total=5036302
sum_num_deletes_by_thread=103424 104255 105966 105678 104925 102798 104042 104828 105647 105839 105135 104811 104812 105503 105883 105159 106194 104475 103735 105183 105761 106826 104921 103906 103383 104386 105690 104841 104698 103537 104315 104690 105253 106449 104821 104308 104782 105235 105868 105610 106072 104761 103925 104743 105824 106005 105082 103465
sum_num_deletes_total=5037449
sum_num_searches_by_thread=20529306 20744346 20906444 20903231 20767752 20462767 20648362 20815874 20984124 21091044 20830259 20646865 20698214 20834479 20994905 20923854 20913010 20765269 20595490 20781697 20959059 21027628 20815076 20643398 20482934 20595567 20830807 20801536 20750978 20465204 20593740 20791716 20940962 21099506 20795668 20704652 20724795 20826540 20988983 20899959 20902675 20760735 20600036 20722728 20947749 21008853 20772454 20579945
sum_num_searches_total=997871175
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=20736244 20953178 21117990 21113739 20977887 20668566 20856915 21025918 21195723 21303498 21041019 20856050 20907713 21045119 21206701 21135083 21124621 20974935 20802920 20991565 21171068 21240975 21024819 20851642 20689502 20804275 21041591 21011000 20960372 20672279 20802021 21000565 21151790 21311983 21005323 20913971 20934391 21036589 21200475 21111092 21113746 20970184 20807769 20931969 21159491 21220953 20982380 20787327
average_num_operations_total=20998852
stdev_num_operations_total=23933
sum_num_operations_total=1007944926
min_num_operations_total=20668566
max_num_operations_total=21311983
first_time_thread_terminate_by_thread=10000132 10000131 10000132 10000132 10000132 10000131 10000132 10000132 10000131 10000132 10000132 10000132 10000131 10000132 10000132 10000132 10000131 10000131 10000131 10000132 10000132 10000132 10000132 10000131 10000132 10000131 10000132 10000132 10000132 10000131 10000132 10000132 10000131 10000132 10000132 10000132 10000131 10000132 10000132 10000132 10000132 10000131 10000131 10000132 10000132 10000132 10000132 10000131
min_time_thread_terminate_total=10000131
max_time_thread_terminate_total=10000132
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 4 3 3 3 3 3 3
min_time_thread_start_total=2
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=10015052994
threads_final_size=100039
final_keysum=10015052994
final_size=100039
validate_result=success
Validation OK.
Structural validation OK.

total_find=997871175
total_rq=0
total_inserts=5036302
total_deletes=5037449
total_updates=10073751
total_queries=997871175
total_ops=1007944926
find_throughput=99787117
rq_throughput=0
update_throughput=1007375
query_throughput=99787117
total_throughput=100794492


total find                    : 997871175
total rq                      : 0
total inserts                 : 5036302
total deletes                 : 5037449
total updates                 : 10073751
total queries                 : 997871175
total ops                     : 1007944926
find throughput               : 99787117
rq throughput                 : 0
update throughput             : 1007375
query throughput              : 99787117
total throughput              : 100794492

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=4.83933
PAPI_L3_TCM=0.000142107
PAPI_TOT_CYC=1302.76
PAPI_TOT_INS=297.576
garbage=49873912242637
total_execution_walltime=11.431s
REALTIME_MAIN_END_PERF_FORMAT=6982084.76111566
[time_cmd_output] time_elapsed_sec=11.54, faults_major=0, faults_minor=76264, mem_maxresident_kb=306992, user_cputime=561.80, sys_cputime=3.44, percent_cpu=4895%
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=1