__step=000458
__cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 180 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" ./brown_int_bst_tm_auto.debra.tl2 -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000458.txt
__path_data=data/data000458.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=7000322.714175167
binary=./brown_int_bst_tm_auto.debra.tl2
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=brown_int_bst_tm_auto
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=200000
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


TL2 system ready: GV=GV4
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.006s
prefilling_size=100042 prefilling_elapsed_millis=1.001s
finished prefilling to size 100022 for expected size 100000 keysum=10032762529, performing 17649060 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=100022
pref_millis=1102
prefill_elapsed_ms=1115
4NodeIxPvL9tx_safety0EE_object_size=32
4NodeIxPvL9tx_safety0EE_allocated_count=0
4NodeIxPvL9tx_safety0EE_allocated_size=0MB
4NodeIxPvL9tx_safety0EE_get_from_pool=0
4NodeIxPvL9tx_safety0EE_deallocated=0
4NodeIxPvL9tx_safety0EE_limbo_count=0
4NodeIxPvL9tx_safety0EE_limbo_details=0 0 0 

global_epoch_counter=812

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=7000323.986658671
REALTIME_END_PERF_FORMAT=7000333.986815418

###############################################################################
################################## 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 800 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 63 120 227 416 752 1298 2092 3089 4166 5159 5935 6328 6486 6386 5951 5114 4160 3085 2112 1309 650 309 125 43 10 3 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 3 7 21 48 107 284 592 1081 1718 2321 2942 3304 3503 3606 3575 3179 2770 2112 1487 1015 506 261 106 37 10 3
tree_stats_numNodesAtDepth=1 2 4 8 16 32 63 123 234 437 800 1405 2376 3681 5247 6877 8256 9270 9790 9889 9557 8689 7339 5855 4224 2796 1665 815 386 149 47 13 3
tree_stats_numKeysAtDepth=1 2 4 8 16 32 63 123 234 437 800 1405 2376 3681 5247 6877 8256 9270 9790 9889 9557 8689 7339 5855 4224 2796 1665 815 386 149 47 13 3
tree_stats_avgDegreeAtDepth=2 2 2 2 2 1.96875 1.95238 1.92683 1.89744 1.87872 1.81625 1.76726 1.66877 1.58625 1.51668 1.45034 1.40395 1.37346 1.3476 1.32066 1.28649 1.25607 1.23096 1.19453 1.16193 1.12732 1.0991 1.09448 1.06218 1.02685 1.06383 1 1

tree_stats_height=33
tree_stats_numInternals=65451
tree_stats_numLeaves=34598
tree_stats_numNodes=100049
tree_stats_numKeys=100049

tree_stats_avgDegreeInternal=1.52861
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34581
tree_stats_avgKeyDepth=18.5996

4NodeIxPvL9tx_safety0EE_object_size=32
4NodeIxPvL9tx_safety0EE_allocated_count=0
4NodeIxPvL9tx_safety0EE_allocated_size=0MB
4NodeIxPvL9tx_safety0EE_get_from_pool=0
4NodeIxPvL9tx_safety0EE_deallocated=0
4NodeIxPvL9tx_safety0EE_limbo_count=0
4NodeIxPvL9tx_safety0EE_limbo_details=0 0 0 

global_epoch_counter=15527


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:71 2:1294 4:49550 8:372332 16:56654
    [2^00, 2^01]: 71
    (2^01, 2^02]: 1294
    (2^02, 2^03]: 49550
    (2^03, 2^04]: 372332
    (2^04, 2^05]: 56654
sum_limbo_reclamation_event_size_total=5534815
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=479901
sum_limbo_reclamation_event_count_total=706320
first_thread_announced_epoch_by_thread=31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054 31054
sum_num_inserts_by_thread=334971 339515 340485 341447 340295 336740 335729 337270 343068 343525 338572 338678 336796 339988 340925 342947 342119 337934 334220 338308 339560 343340 341186 336331 336384 337867 342031 342463 340639 336939 336211 337466 343212 342209 339219 338970 336301 338458 341086 343119 342574 338173 333871 338413 339716 341953 340403 336178
sum_num_inserts_total=16287804
sum_num_deletes_by_thread=334710 338607 341961 341498 339502 336759 336703 338254 342960 343691 338194 338165 336530 339725 340889 342873 342893 337769 333929 337984 339817 343253 339672 335151 335858 338556 343768 343039 340543 337168 336200 336384 344002 341583 339108 339207 336538 338937 341461 342284 342670 336884 332674 337400 339656 343084 339938 336931
sum_num_deletes_total=16285362
sum_num_searches_by_thread=6036320 6099532 6124418 6149622 6115433 6064926 6051936 6075308 6171903 6190119 6110740 6070790 6067897 6112355 6131955 6162787 6160890 6072811 6004875 6095665 6113625 6174868 6133994 6043632 6053982 6093202 6172795 6171643 6133189 6074814 6056960 6070293 6176000 6162948 6106992 6092368 6036791 6096703 6156750 6165444 6147048 6076542 6005800 6079157 6114221 6163956 6122604 6056797
sum_num_searches_total=293123400
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=6706001 6777654 6806864 6832567 6795230 6738425 6724368 6750832 6857931 6877335 6787506 6747633 6741223 6792068 6813769 6848607 6845902 6748514 6673024 6771957 6793002 6861461 6814852 6715114 6726224 6769625 6858594 6857145 6814371 6748921 6729371 6744143 6863214 6846740 6785319 6770545 6709630 6774098 6839297 6850847 6832292 6751599 6672345 6754970 6793593 6848993 6802945 6729906
average_num_operations_total=6785345
stdev_num_operations_total=7863
sum_num_operations_total=325696566
min_num_operations_total=6672345
max_num_operations_total=6877335
first_time_thread_terminate_by_thread=10000156 10000156 10000156 10000157 10000156 10000155 10000156 10000155 10000156 10000156 10000157 10000157 10000156 10000157 10000156 10000156 10000155 10000155 10000156 10000156 10000156 10000156 10000155 10000155 10000156 10000156 10000156 10000157 10000157 10000155 10000156 10000155 10000156 10000156 10000157 10000157 10000156 10000157 10000156 10000156 10000155 10000155 10000157 10000156 10000156 10000156 10000155 10000155
min_time_thread_terminate_total=10000155
max_time_thread_terminate_total=10000157
first_time_thread_start_by_thread=6 6 6 6 5 6 6 6 6 6 6 6 6 6 6 6 6 6 6 5 6 5 5 6 6 6 6 6 5 6 6 6 6 6 6 6 6 6 6 6 6 6 6 5 6 5 5 6
min_time_thread_start_total=5
max_time_thread_start_total=6
sum_duration_all_ops_total=

threads_final_keysum=9980815250
threads_final_size=100049
final_keysum=9980815250
final_size=100049
validate_result=success
Validation OK.
Structural validation OK.

total_find=293123400
total_rq=0
total_inserts=16287804
total_deletes=16285362
total_updates=32573166
total_queries=293123400
total_ops=325696566
find_throughput=29312340
rq_throughput=0
update_throughput=3257316
query_throughput=29312340
total_throughput=32569656


total find                    : 293123400
total rq                      : 0
total inserts                 : 16287804
total deletes                 : 16285362
total updates                 : 32573166
total queries                 : 293123400
total ops                     : 325696566
find throughput               : 29312340
rq throughput                 : 0
update throughput             : 3257316
query throughput              : 29312340
total throughput              : 32569656

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=9.13899
PAPI_L3_TCM=0.000354235
PAPI_TOT_CYC=2527.35
PAPI_TOT_INS=1974.79
garbage=14345604266307
total_execution_walltime=11.404s
REALTIME_MAIN_END_PERF_FORMAT=7000334.119549822
TL2 system shutdown:
  GCLOCK=0x20D33C2 Starts=344046069 Aborts=700442
  Overflows: R=0 W=0 L=0
[time_cmd_output] time_elapsed_sec=11.51, faults_major=0, faults_minor=78300, mem_maxresident_kb=309612, user_cputime=486.04, sys_cputime=76.88, percent_cpu=4887%
timeout=false
algorithm=brown_int_bst_tm_auto.debra.tl2
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2