__step=000465
__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.hytm1 -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=data000465.txt
__path_data=data/data000465.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=7000404.524132269
binary=./brown_int_bst_tm_auto.debra.hytm1
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


HyTM1 system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.008s
prefilling_size=99815 prefilling_elapsed_millis=1.001s
finished prefilling to size 99877 for expected size 100000 keysum=9982094279, performing 61469429 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99877
pref_millis=1102
prefill_elapsed_ms=1130
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=2795

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=7000405.825782932
REALTIME_END_PERF_FORMAT=7000415.825927000

###############################################################################
################################## 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 838 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 125 243 445 759 1282 2015 2918 4050 5228 6330 7048 7135 6795 6014 4834 3651 2506 1707 1017 554 280 112 51 15 1 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 3 24 79 144 300 611 956 1604 2226 3026 3771 3997 3987 3836 3178 2517 1696 1237 766 431 225 93 43 14 0 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 126 246 469 838 1426 2315 3529 5006 6832 8556 10074 10906 10792 10001 8670 6829 5023 3403 2254 1320 711 337 144 58 15 1 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 126 246 469 838 1426 2315 3529 5006 6832 8556 10074 10906 10792 10001 8670 6829 5023 3403 2254 1320 711 337 144 58 15 1 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.96875 1.96032 1.9187 1.83795 1.79594 1.7244 1.654 1.59167 1.55573 1.48712 1.43759 1.38297 1.33532 1.29707 1.26557 1.2301 1.20091 1.17858 1.16074 1.13443 1.11894 1.08017 1.09496 1.04861 1 1 1 1

tree_stats_height=34
tree_stats_numInternals=65243
tree_stats_numLeaves=34766
tree_stats_numNodes=100009
tree_stats_numKeys=100009

tree_stats_avgDegreeInternal=1.53287
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34763
tree_stats_avgKeyDepth=18.4262

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:57 2:1593 4:52868 8:369552 16:55823 32:8
    [2^00, 2^01]: 57
    (2^01, 2^02]: 1593
    (2^02, 2^03]: 52868
    (2^03, 2^04]: 369552
    (2^04, 2^05]: 55823
    (2^05, 2^06]: 8
sum_limbo_reclamation_event_size_total=5500093
count_limbo_reclamation_event_size_by_thread=9998 9998 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 9997 9998 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=479901
sum_limbo_reclamation_event_count_total=1556304
first_thread_announced_epoch_by_thread=70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436 70436
sum_num_inserts_by_thread=738478 754871 743463 720073 743354 740294 744358 741272 748867 750964 757064 744415 742540 743952 756860 750289 744572 742638 739393 754601 734451 749013 744256 741379 686781 755751 721763 756175 751625 746756 743078 743569 744544 753362 734443 739638 742976 741782 745867 757958 744697 743838 737689 752795 751236 754659 733369 741643
sum_num_inserts_total=35697411
sum_num_deletes_by_thread=738035 755913 743773 717304 743775 739761 743331 741808 748117 750146 757114 744248 743021 744446 756545 750930 744306 743163 739575 755600 733153 750886 742895 740240 688774 754594 721221 757144 750141 747999 741851 744397 745156 752784 735865 740394 744327 741965 745633 758243 743866 744247 737203 754378 749552 755132 734271 742623
sum_num_deletes_total=35699845
sum_num_searches_by_thread=13273837 13598939 13394255 12938656 13379910 13328957 13388700 13324201 13490171 13499689 13614969 13398917 13392592 13399631 13614321 13509853 13387003 13366806 13321753 13559778 13200364 13491858 13381081 13327371 12368256 13593935 12976802 13619546 13511634 13463691 13385390 13396154 13413192 13547138 13233812 13322614 13385753 13361031 13427846 13646822 13417999 13381900 13282197 13568913 13469631 13594604 13204198 13335202
sum_num_searches_total=642491872
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=14750350 15109723 14881491 14376033 14867039 14809012 14876389 14807281 14987155 15000799 15129147 14887580 14878153 14888029 15127726 15011072 14875881 14852607 14800721 15069979 14667968 14991757 14868232 14808990 13743811 15104280 14419786 15132865 15013400 14958446 14870319 14884120 14902892 15053284 14704120 14802646 14873056 14844778 14919346 15163023 14906562 14869985 14757089 15076086 14970419 15104395 14671838 14819468
average_num_operations_total=14872690
stdev_num_operations_total=34012
sum_num_operations_total=713889128
min_num_operations_total=13743811
max_num_operations_total=15163023
first_time_thread_terminate_by_thread=10000142 10000142 10000142 10000142 10000142 10000142 10000142 10000141 10000142 10000142 10000141 10000142 10000142 10000142 10000141 10000142 10000142 10000142 10000142 10000141 10000142 10000142 10000141 10000142 10000142 10000142 10000142 10000142 10000142 10000142 10000142 10000141 10000142 10000142 10000141 10000142 10000142 10000142 10000141 10000142 10000142 10000142 10000142 10000141 10000142 10000142 10000141 10000142
min_time_thread_terminate_total=10000141
max_time_thread_terminate_total=10000142
first_time_thread_start_by_thread=3 3 3 4 4 4 4 3 3 4 3 4 4 4 4 4 4 4 3 4 3 4 4 3 3 3 3 4 4 4 4 3 3 4 3 4 4 4 4 4 4 4 3 4 3 4 4 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=10001117102
threads_final_size=100009
final_keysum=10001117102
final_size=100009
validate_result=success
Validation OK.
Structural validation OK.

total_find=642491872
total_rq=0
total_inserts=35697411
total_deletes=35699845
total_updates=71397256
total_queries=642491872
total_ops=713889128
find_throughput=64249187
rq_throughput=0
update_throughput=7139725
query_throughput=64249187
total_throughput=71388912


total find                    : 642491872
total rq                      : 0
total inserts                 : 35697411
total deletes                 : 35699845
total updates                 : 71397256
total queries                 : 642491872
total ops                     : 713889128
find throughput               : 64249187
rq throughput                 : 0
update throughput             : 7139725
query throughput              : 64249187
total throughput              : 71388912

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=3.53237
PAPI_L3_TCM=0.000161539
PAPI_TOT_CYC=1786.01
PAPI_TOT_INS=995.295
garbage=31450192741567
total_execution_walltime=11.427s
REALTIME_MAIN_END_PERF_FORMAT=7000415.953071599
HyTM1 system shutdown:
    HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit         : 775349211
[slow htm]
[fallback]
total fallback commit         : 9347
seconds global lock is held   : 0.0530781
[time_cmd_output] time_elapsed_sec=11.56, faults_major=0, faults_minor=78168, mem_maxresident_kb=309968, user_cputime=558.02, sys_cputime=1.84, percent_cpu=4841%
timeout=false
algorithm=brown_int_bst_tm_auto.debra.hytm1
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1