__step=000457
__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=data000457.txt
__path_data=data/data000457.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=7000311.94283186
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.007s
prefilling_size=100016 prefilling_elapsed_millis=1.001s
finished prefilling to size 100024 for expected size 100000 keysum=9989467815, performing 17676281 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=100024
pref_millis=1102
prefill_elapsed_ms=1123
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=815

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=7000312.398545513
REALTIME_END_PERF_FORMAT=7000322.398697732

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

tree_stats_computeWalltime=0.034s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 242 453 819 1405 2246 3311 4500 5602 6378 6560 6421 6080 5410 4566 3671 2766 1895 1211 733 392 208 105 48 15 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 8 16 51 122 316 641 1199 1864 2587 3367 3592 3525 3561 3298 2857 2366 1908 1319 886 552 298 169 80 46 17 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 250 469 870 1527 2562 3952 5699 7466 8965 9927 10013 9605 8971 7864 6528 5132 3803 2530 1619 944 506 274 128 61 19 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 250 469 870 1527 2562 3952 5699 7466 8965 9927 10013 9605 8971 7864 6528 5132 3803 2530 1619 944 506 274 128 61 19 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.95312 1.908 1.88913 1.81379 1.75769 1.66589 1.60425 1.52044 1.45044 1.39587 1.34784 1.31799 1.30099 1.27355 1.24949 1.22381 1.20207 1.16697 1.16126 1.13033 1.12076 1.13043 1.08394 1.10156 1.06557 1 1

tree_stats_height=34
tree_stats_numInternals=65294
tree_stats_numLeaves=34647
tree_stats_numNodes=99941
tree_stats_numKeys=99941

tree_stats_avgDegreeInternal=1.53063
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34667
tree_stats_avgKeyDepth=18.4

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:65 2:1343 4:49695 8:372368 16:56427
    [2^00, 2^01]: 65
    (2^01, 2^02]: 1343
    (2^02, 2^03]: 49695
    (2^03, 2^04]: 372368
    (2^04, 2^05]: 56427
sum_limbo_reclamation_event_size_total=5533801
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9997
count_limbo_reclamation_event_size_total=479898
sum_limbo_reclamation_event_count_total=712560
first_thread_announced_epoch_by_thread=31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320 31320
sum_num_inserts_by_thread=338589 339920 342769 343894 342226 337957 339261 342582 344606 345655 345229 340531 342088 341261 343949 344090 346357 340188 338735 342393 343403 345281 341261 339208 339170 341467 342202 345050 344130 339676 340224 340986 346606 346483 343096 340337 342560 341644 344456 347002 344517 341599 339952 342546 341782 345355 341838 338499
sum_num_inserts_total=16432610
sum_num_deletes_by_thread=337452 341361 342557 345525 343632 337646 340867 342079 345473 346549 343150 340144 341653 339827 343083 344402 344953 340697 338684 341784 342642 347196 342469 340178 340467 340223 342454 344441 344485 340586 340554 341748 347241 346990 342763 340420 342481 343486 342503 345978 344542 341269 339144 341851 342395 345550 342863 338203
sum_num_deletes_total=16436640
sum_num_searches_by_thread=6086450 6151300 6179485 6221677 6175115 6091261 6130847 6173733 6216043 6227128 6198384 6131327 6160775 6132228 6186779 6201524 6219589 6132450 6093567 6155956 6173684 6225866 6147885 6116813 6124889 6135824 6166783 6216951 6191063 6136828 6120025 6145518 6240405 6232348 6170942 6129113 6165331 6164378 6180569 6240363 6205502 6141231 6124608 6157453 6166065 6219599 6171075 6095909
sum_num_searches_total=295972638
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=6762491 6832581 6864811 6911096 6860973 6766864 6810975 6858394 6906122 6919332 6886763 6812002 6844516 6813316 6873811 6890016 6910899 6813335 6770986 6840133 6859729 6918343 6831615 6796199 6804526 6817514 6851439 6906442 6879678 6817090 6800803 6828252 6934252 6925821 6856801 6809870 6850372 6849508 6867528 6933343 6894561 6824099 6803704 6841850 6850242 6910504 6855776 6772611
average_num_operations_total=6850872
stdev_num_operations_total=6784
sum_num_operations_total=328841888
min_num_operations_total=6762491
max_num_operations_total=6934252
first_time_thread_terminate_by_thread=10000150 10000150 10000150 10000150 10000149 10000150 10000150 10000150 10000151 10000150 10000150 10000150 10000150 10000150 10000150 10000150 10000151 10000151 10000150 10000149 10000149 10000150 10000150 10000150 10000151 10000150 10000150 10000150 10000149 10000150 10000150 10000150 10000151 10000150 10000150 10000150 10000150 10000150 10000150 10000150 10000151 10000150 10000150 10000149 10000149 10000151 10000150 10000150
min_time_thread_terminate_total=10000149
max_time_thread_terminate_total=10000151
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=3
sum_duration_all_ops_total=

threads_final_keysum=9977164103
threads_final_size=99941
final_keysum=9977164103
final_size=99941
validate_result=success
Validation OK.
Structural validation OK.

total_find=295972638
total_rq=0
total_inserts=16432610
total_deletes=16436640
total_updates=32869250
total_queries=295972638
total_ops=328841888
find_throughput=29597263
rq_throughput=0
update_throughput=3286925
query_throughput=29597263
total_throughput=32884188


total find                    : 295972638
total rq                      : 0
total inserts                 : 16432610
total deletes                 : 16436640
total updates                 : 32869250
total queries                 : 295972638
total ops                     : 328841888
find throughput               : 29597263
rq throughput                 : 0
update throughput             : 3286925
query throughput              : 29597263
total throughput              : 32884188

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=8.67359
PAPI_L3_TCM=0.000373496
PAPI_TOT_CYC=2488.81
PAPI_TOT_INS=1957.25
garbage=14800549044986
total_execution_walltime=11.443s
REALTIME_MAIN_END_PERF_FORMAT=7000322.538304894
TL2 system shutdown:
  GCLOCK=0x2134BF0 Starts=347454075 Aborts=935905
  Overflows: R=0 W=0 L=0
[time_cmd_output] time_elapsed_sec=11.55, faults_major=0, faults_minor=78204, mem_maxresident_kb=308916, user_cputime=483.26, sys_cputime=76.24, percent_cpu=4842%
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=1