__step=000249
__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 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000249.txt
__path_data=data/data000249.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6997552.750930388
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=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


HyTM1 system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.007s
prefilling_size=999721 prefilling_elapsed_millis=1.001s
finished prefilling to size 999730 for expected size 1000000 keysum=999574055899, performing 35001617 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=999730
pref_millis=1102
prefill_elapsed_ms=1136
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=1614

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6997554.33802327
REALTIME_END_PERF_FORMAT=6997564.33944528

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

tree_stats_computeWalltime=0.038s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 126 252 492 927 1717 2990 5070 7984 11957 17004 22774 28967 35003 40014 44177 47137 48804 48789 47418 44617 40556 35796 30331 24908 19700 15155 11047 7808 5085 3399 1986 1125 585 280 142 72 30 8 2 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 0 7 30 76 236 534 1197 2201 3726 6117 8973 12194 16192 19179 22047 24114 26046 26543 26549 25724 23748 21713 18732 15840 12614 10019 7413 5529 3525 2487 1499 849 464 221 111 57 26 7 1 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 127 252 499 957 1793 3226 5604 9181 14158 20730 28891 37940 47197 56206 63356 69184 72918 74835 73961 71166 66280 59544 52044 43640 35540 27769 21066 15221 10614 6924 4473 2624 1434 744 363 183 87 34 9 2 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 127 252 499 957 1793 3226 5604 9181 14158 20730 28891 37940 47197 56206 63356 69184 72918 74835 73961 71166 66280 59544 52044 43640 35540 27769 21066 15221 10614 6924 4473 2624 1434 744 363 183 87 34 9 2 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.98438 1.99213 1.98016 1.93186 1.90491 1.84161 1.81029 1.73358 1.67248 1.61965 1.57342 1.52494 1.4805 1.44924 1.41529 1.39471 1.37264 1.35699 1.33637 1.32109 1.3044 1.28648 1.27287 1.25573 1.24363 1.22704 1.21286 1.19814 1.18435 1.17326 1.15511 1.14263 1.11776 1.11088 1.11156 1.11295 1.08197 1.04598 1.02941 1 1 1

tree_stats_height=48
tree_stats_numInternals=654362
tree_stats_numLeaves=346542
tree_stats_numNodes=1000904
tree_stats_numKeys=1000904

tree_stats_avgDegreeInternal=1.52959
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34623
tree_stats_avgKeyDepth=24.4976

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:65 2:1519 4:53736 8:369753 16:54824
    [2^00, 2^01]: 65
    (2^01, 2^02]: 1519
    (2^02, 2^03]: 53736
    (2^03, 2^04]: 369753
    (2^04, 2^05]: 54824
sum_limbo_reclamation_event_size_total=5485244
count_limbo_reclamation_event_size_by_thread=9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9997 9997 9998 9998 9998 9998 9997 9997 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=479897
sum_limbo_reclamation_event_count_total=1083888
first_thread_announced_epoch_by_thread=48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390 48390
sum_num_inserts_by_thread=510853 515058 514870 520836 522333 518517 518666 526019 529446 524338 517734 514322 515000 520529 525421 515057 521059 520061 502005 523515 520417 522877 520224 507166 499668 504742 517698 520165 525136 504587 502718 514864 522300 516151 515132 518604 518215 523402 520088 521065 518058 512801 486618 514671 514014 522360 514894 509998
sum_num_inserts_total=24784272
sum_num_deletes_by_thread=510108 514855 514011 520200 523150 516373 519073 524008 527970 525052 517685 513285 514622 521202 524511 516944 521435 519766 501809 523139 519130 523344 519160 507502 500392 504933 517376 520489 524729 506515 503661 515589 522352 517129 515419 519091 516781 522901 520926 519514 518900 511574 487356 514845 515254 523414 515182 509735
sum_num_deletes_total=24782391
sum_num_searches_by_thread=9189424 9260622 9264876 9367160 9421094 9301124 9347400 9427698 9522812 9442795 9328603 9241890 9248325 9371228 9440615 9296744 9376645 9368081 9037503 9428839 9341718 9415334 9374336 9105462 8980699 9086731 9307360 9366916 9447505 9110005 9059925 9278327 9393768 9296319 9270893 9331612 9328161 9429691 9356671 9375829 9345168 9203927 8761684 9268770 9261611 9414939 9276220 9172405
sum_num_searches_total=446045464
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=10210385 10290535 10293757 10408196 10466577 10336014 10385139 10477725 10580228 10492185 10364022 10269497 10277947 10412959 10490547 10328745 10419139 10407908 10041317 10475493 10381265 10461555 10413720 10120130 9980759 10096406 10342434 10407570 10497370 10121107 10066304 10308780 10438420 10329599 10301444 10369307 10363157 10475994 10397685 10416408 10382126 10228302 9735658 10298286 10290879 10460713 10306296 10192138
average_num_operations_total=10325252
stdev_num_operations_total=22943
sum_num_operations_total=495612127
min_num_operations_total=9735658
max_num_operations_total=10580228
first_time_thread_terminate_by_thread=10000141 10000142 10000141 10000142 10000142 10000142 10000141 10000142 10000141 10000141 10000141 10000142 10000142 10000141 10000141 10000142 10000142 10000142 10000142 10000142 10000142 10000142 10000141 10000142 10000141 10000142 10000141 10000142 10000142 10000142 10000142 10000142 10000141 10000141 10000141 10000142 10000142 10000141 10000141 10000142 10000142 10000142 10000142 10000142 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 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=

threads_final_keysum=1000763418942
threads_final_size=1000904
final_keysum=1000763418942
final_size=1000904
validate_result=success
Validation OK.
Structural validation OK.

total_find=446045464
total_rq=0
total_inserts=24784272
total_deletes=24782391
total_updates=49566663
total_queries=446045464
total_ops=495612127
find_throughput=44604546
rq_throughput=0
update_throughput=4956666
query_throughput=44604546
total_throughput=49561212


total find                    : 446045464
total rq                      : 0
total inserts                 : 24784272
total deletes                 : 24782391
total updates                 : 49566663
total queries                 : 446045464
total ops                     : 495612127
find throughput               : 44604546
rq throughput                 : 0
update throughput             : 4956666
query throughput              : 44604546
total throughput              : 49561212

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=8.44875
PAPI_L3_TCM=0.258329
PAPI_TOT_CYC=2661.95
PAPI_TOT_INS=1217.19
garbage=223053738117204
total_execution_walltime=11.416s
REALTIME_MAIN_END_PERF_FORMAT=6997564.167621637
HyTM1 system shutdown:
    HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit         : 530585469
[slow htm]
[fallback]
total fallback commit         : 28276
seconds global lock is held   : 0.279952
[time_cmd_output] time_elapsed_sec=11.53, faults_major=0, faults_minor=93127, mem_maxresident_kb=342724, user_cputime=557.76, sys_cputime=2.83, percent_cpu=4858%
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