__step=000336
__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_abtree_tm_auto.debra.hytm1 -nwork 190 -nprefill 190 -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=data000336.txt
__path_data=data/data000336.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6998875.239716131
binary=./brown_abtree_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_abtree_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=190
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=190
WORK_THREADS=190
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=200
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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,64,65,66,67,68,69,70,71,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,72,73,74,75,76,77,78,79,80,81,82,83,84,85,86,87,88,89,90,91,92,93,94,95,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189


HyTM1 system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.067s
prefilling_size=475198 prefilling_elapsed_millis=1s
prefilling_size=525991 prefilling_elapsed_millis=1.1s
prefilling_size=555107 prefilling_elapsed_millis=1.2s
prefilling_size=582456 prefilling_elapsed_millis=1.301s
prefilling_size=610495 prefilling_elapsed_millis=1.401s
prefilling_size=648085 prefilling_elapsed_millis=1.501s
prefilling_size=705354 prefilling_elapsed_millis=1.601s
prefilling_size=765858 prefilling_elapsed_millis=1.701s
prefilling_size=821211 prefilling_elapsed_millis=1.801s
prefilling_size=864634 prefilling_elapsed_millis=1.901s
prefilling_size=893649 prefilling_elapsed_millis=2.001s
prefilling_size=913524 prefilling_elapsed_millis=2.101s
prefilling_size=929557 prefilling_elapsed_millis=2.202s
prefilling_size=941241 prefilling_elapsed_millis=2.302s
prefilling_size=949884 prefilling_elapsed_millis=2.402s
prefilling_size=957414 prefilling_elapsed_millis=2.502s
prefilling_size=963971 prefilling_elapsed_millis=2.602s
prefilling_size=971405 prefilling_elapsed_millis=2.702s
prefilling_size=978148 prefilling_elapsed_millis=2.802s
prefilling_size=983241 prefilling_elapsed_millis=2.902s
finished prefilling to size 983269 for expected size 1000000 keysum=982473535255, performing 8252619 updates; total_prefilling_elapsed_ms=3005 ms)
pref_size=983269
pref_millis=3005
prefill_elapsed_ms=3037
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6998878.573136416
REALTIME_END_PERF_FORMAT=6998888.573201993

###############################################################################
################################## TIME IS UP #################################
###############################################################################

joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################

10.1s
PRODUCING OUTPUT
computing tree_stats in PARALLEL...
bounded depth BFS to partition into subtrees for parallel computation (192 threads)...
partitioned into 3505 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.055s

tree_stats_numInternalsAtDepth=1 1 8 64 463 3505 27048 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 196435
tree_stats_numNodesAtDepth=1 1 8 64 463 3505 27048 196435
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 999639
tree_stats_avgDegreeAtDepth=1 8 8 7.23438 7.57019 7.71698 7.26246 5.0889

tree_stats_height=8
tree_stats_numInternals=31090
tree_stats_numLeaves=196435
tree_stats_numNodes=227525
tree_stats_numKeys=999639

tree_stats_avgDegreeInternal=7.31827
tree_stats_avgDegreeLeaves=5.0889
tree_stats_avgDegree=5.39353
tree_stats_avgKeyDepth=7


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0
    [2^00, 2^01]: 0
sum_limbo_reclamation_event_size_total=
count_limbo_reclamation_event_size_by_thread=
count_limbo_reclamation_event_size_total=
sum_limbo_reclamation_event_count_total=422560
first_thread_announced_epoch_by_thread=4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504 4504
sum_commit_tx_reader_total=
sum_commit_tx_reader_by_thread=
sum_commit_tx_writer_total=
sum_commit_tx_writer_by_thread=
sum_abort_tx_total=
sum_abort_tx_by_thread=
max_ht_capacity_by_thread=

linear_histogram_of_none_tx_rdset_size_full_data=

linear_histogram_of_none_tx_wrset_size_full_data=
sum_fasthtm_commit_total=
sum_fasthtm_abort_total=
sum_htmpostfix_commit_total=
sum_htmpostfix_abort_total=
sum_htmprefix_commit_total=
sum_htmprefix_abort_total=
sum_htmprefix_abort_explicit_total=
sum_htmprefix_abort_conflict_total=
sum_htmprefix_abort_capacity_total=
sum_htmprefix_abort_nesting_total=
sum_htmprefix_abort_illegal_total=
sum_htmprefix_abort_zero_total=
sum_stmprefix_abort_total=
sum_stmprefix_commit_total=
sum_slow_commit_total=
sum_abtree_insert_repeat_total=
sum_abtree_erase_repeat_total=
sum_abtree_search_repeat_total=
sum_abtree_search_complete_total=
sum_abtree_fix_weight_viol_attempt_total=
sum_abtree_fix_degree_viol_attempt_total=
sum_abtree_rebalancing_kcas_attempt_total=
sum_abtree_update_kcas_attempt_total=
sum_abtree_internal_complex_search_while_iters_total=
sum_abtree_internal_basic_search_while_iters_total=
sum_kcas_desc_new_total=
sum_num_inserts_by_thread=157610 156748 159233 159198 158895 156780 157368 157539 159521 160474 158293 157358 157861 158263 158654 159451 158831 157466 157712 157233 157579 159349 158417 156967 156540 157308 158707 157981 159225 157061 158741 158152 158283 158788 159073 156651 157605 158071 159023 158562 158919 157450 156562 156019 158175 158681 158124 156668 158755 160320 159948 160035 159383 157588 158331 159301 160598 161363 160295 157409 158530 160253 161045 161906 160269 159789 158785 159706 160715 160380 160004 159235 159307 160090 160194 158900 160617 158298 159277 159515 160323 160979 160773 158709 159691 158867 160571 160844 159269 158318 157967 159736 162244 161199 161488 160202 155172 155248 156354 157078 158107 156404 155723 156664 157342 157614 156353 154936 157026 156067 157046 157484 155794 153971 154718 155053 156223 156437 156065 154555 155367 154941 155014 156342 157030 156034 156588 156702 157099 158210 157188 155166 155446 156241 155824 156405 155462 154108 154004 155189 158054 156938 155812 155122 159052 160550 161153 160704 161330 160995 160193 160686 162020 162910 158747 160524 160329 160192 161443 161687 160719 159029 159279 159728 161510 162617 208981 208076 160802 161066 161481 161066 162257 161636 160897 161399 162998 162420 160430 160949 160188 161487 161917 162593 159378 159611 159263 160236 161787 162468
sum_num_inserts_total=30248993
sum_num_deletes_by_thread=157781 157386 158242 159103 158455 156414 158433 158317 159514 159284 158994 157150 159033 158545 159278 158878 159448 158286 157565 157994 158624 159974 158783 155997 157276 157021 157886 158758 159436 156492 158946 157991 159065 159695 158550 157606 157531 158444 159060 158427 157923 157202 157249 156263 158467 159086 158467 157253 158745 160027 160238 159455 159830 157412 158254 159684 160052 161183 160552 158000 158963 160385 160844 160876 161004 159420 158901 159863 160050 160181 160098 159420 158347 159064 159312 160180 160305 158672 159405 159971 160689 160596 160159 159182 159887 159116 160289 161072 159891 158583 158360 159364 161215 160673 160712 159773 155466 155811 156889 157743 157675 156152 155308 156941 157044 156977 155867 154634 155390 155772 157274 157345 156519 153839 154480 155679 156420 156755 156008 154623 153877 154735 155717 155656 156781 155678 155727 157122 158295 157973 157441 155539 155990 155842 155900 156856 156420 154499 154254 155644 157255 157793 156294 154771 159058 160594 161038 160738 161649 161242 159701 161983 161873 162033 159757 161425 160992 160224 160835 161693 159855 159889 159312 160973 161519 162743 209396 208527 160819 160757 160977 160105 161984 161604 160665 161027 162869 162447 160252 160466 160173 161210 161874 162167 160337 159718 158917 159856 162020 162507
sum_num_deletes_total=30256296
sum_num_searches_by_thread=2841711 2833203 2853408 2858239 2854868 2829514 2844973 2847324 2870819 2873032 2860139 2830763 2847747 2853926 2861104 2864541 2866301 2840896 2840671 2831095 2855984 2870065 2851306 2822755 2824350 2825331 2850450 2855558 2870189 2826273 2850189 2845138 2856916 2869107 2855136 2835660 2840766 2847473 2861846 2854045 2853556 2832901 2822664 2812369 2851265 2855591 2844397 2821358 2867116 2880295 2881297 2873455 2877587 2839503 2864756 2872580 2891647 2894537 2886928 2841345 2864730 2882554 2906319 2905201 2900619 2868387 2857416 2869670 2888283 2892388 2881503 2858229 2858373 2866869 2878695 2876811 2876405 2854675 2859192 2870197 2890540 2903576 2883701 2855922 2872047 2864693 2893657 2890363 2874076 2859319 2852839 2864464 2901200 2904394 2895798 2875328 2798476 2803937 2821017 2830721 2834454 2814887 2811645 2822313 2833402 2834138 2814870 2795865 2812919 2803258 2829679 2833153 2807433 2773835 2783331 2795300 2811101 2822032 2805981 2780715 2787387 2782253 2801638 2806637 2810109 2803663 2810873 2815241 2835918 2850203 2827010 2796511 2794581 2808860 2812343 2827494 2810086 2778136 2783049 2808878 2832705 2826560 2803902 2793434 2868198 2880954 2894516 2895773 2907214 2899904 2881741 2902901 2916344 2928624 2868974 2883875 2890885 2887073 2905738 2915394 2883640 2872131 2872318 2889523 2907267 2923996 3762298 3741953 2885070 2892998 2899655 2895818 2923138 2909777 2888214 2906318 2927487 2923763 2898198 2889317 2901339 2894699 2920894 2924872 2888468 2879619 2862531 2888164 2906625 2922005
sum_num_searches_total=544628527
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3157102 3147337 3170883 3176540 3172218 3142708 3160774 3163180 3189854 3192790 3177426 3145271 3164641 3170734 3179036 3182870 3184580 3156648 3155948 3146322 3172187 3189388 3168506 3135719 3138166 3139660 3167043 3172297 3188850 3139826 3167876 3161281 3174264 3187590 3172759 3149917 3155902 3163988 3179929 3171034 3170398 3147553 3136475 3124651 3167907 3173358 3160988 3135279 3184616 3200642 3201483 3192945 3196800 3154503 3181341 3191565 3212297 3217083 3207775 3156754 3182223 3203192 3228208 3227983 3221892 3187596 3175102 3189239 3209048 3212949 3201605 3176884 3176027 3186023 3198201 3195891 3197327 3171645 3177874 3189683 3211552 3225151 3204633 3173813 3191625 3182676 3214517 3212279 3193236 3176220 3169166 3183564 3224659 3226266 3217998 3195303 3109114 3114996 3134260 3145542 3150236 3127443 3122676 3135918 3147788 3148729 3127090 3105435 3125335 3115097 3143999 3147982 3119746 3081645 3092529 3106032 3123744 3135224 3118054 3089893 3096631 3091929 3112369 3118635 3123920 3115375 3123188 3129065 3151312 3166386 3141639 3107216 3106017 3120943 3124067 3140755 3121968 3086743 3091307 3119711 3148014 3141291 3116008 3103327 3186308 3202098 3216707 3217215 3230193 3222141 3201635 3225570 3240237 3253567 3187478 3205824 3212206 3207489 3228016 3238774 3204214 3191049 3190909 3210224 3230296 3249356 4180675 4158556 3206691 3214821 3222113 3216989 3247379 3233017 3209776 3228744 3253354 3248630 3218880 3210732 3221700 3217396 3244685 3249632 3208183 3198948 3180711 3208256 3230432 3246980
average_num_operations_total=3184914
stdev_num_operations_total=7978
sum_num_operations_total=605133816
min_num_operations_total=3081645
max_num_operations_total=4180675
first_time_thread_terminate_by_thread=10000092 10000093 10000093 10000092 10000093 10000091 10000096 10000093 10000092 10000096 10000098 10000095 10000097 10000099 10000092 10000093 10000092 10000097 10000099 10000092 10000092 10000096 10000098 10000093 10000092 10000093 10000092 10000092 10000093 10000091 10000096 10000093 10000092 10000095 10000156 10000096 10000097 10000099 10000092 10000093 10000092 10000097 10000099 10000092 10000092 10000096 10000092 10000092 10000097 10000095 10000095 10000095 10000095 10000096 10000096 10000093 10000097 10000097 10000094 10000096 10000094 10000097 10000094 10000096 10000096 10000096 10000094 10000095 10000099 10000096 10000095 10000095 10000097 10000095 10000095 10000095 10000095 10000096 10000096 10000094 10000097 10000097 10000094 10000096 10000094 10000097 10000097 10000096 10000096 10000096 10000094 10000095 10000098 10000096 10000096 10000095 10000095 10000093 10000090 10000098 10000098 10000093 10000094 10000095 10000090 10000094 10000095 10000099 10000093 10000099 10000098 10000094 10000093 10000094 10000099 10000095 10000097 10000096 10000092 10000097 10000097 10000093 10000092 10000098 10000098 10000093 10000094 10000095 10000090 10000094 10000095 10000099 10000093 10000099 10000098 10000094 10000093 10000099 10000099 10000095 10000097 10000096 10000092 10000097 10000090 10000093 10000097 10000090 10000093 10000092 10000099 10000098 10000092 10000094 10000090 10000092 10000093 10000092 10000092 10000092 10000097 10000099 10000185 10000092 10000093 10000095 10000090 10000092 10000093 10000093 10000097 10000092 10000093 10000092 10000090 10000098 10000092 10000094 10000090 10000092 10000093 10000092 10000092 10000092 10000097 10000099 10000092 10000092 10000093 10000095
min_time_thread_terminate_total=10000090
max_time_thread_terminate_total=10000185
first_time_thread_start_by_thread=5 5 5 5 4 4 5 5 5 5 4 5 5 4 4 4 5 4 5 4 5 5 5 5 5 5 5 5 4 4 5 5 5 5 4 5 5 4 5 4 5 4 5 4 5 5 5 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 4 5 5 4 4 5 5 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 4 5 5 4 4 5 5 5 4 4 5 5 5 4 4 5 5 5 5 5 4 4 4 4 5 4 5 5 4 4 5 4 4 4 5 5 5 4 4 5 5 5 5 5 4 4 4 4 5 4 5 5 4 4 5 5 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=5
sum_duration_all_ops_total=

threads_final_keysum=1000213841589
threads_final_size=999639
final_keysum=1000213841589
final_size=999639
validate_result=success
Validation OK.
Structural validation OK.

total_find=544628527
total_rq=0
total_inserts=30248993
total_deletes=30256296
total_updates=60505289
total_queries=544628527
total_ops=605133816
find_throughput=54462852
rq_throughput=0
update_throughput=6050528
query_throughput=54462852
total_throughput=60513381


total find                    : 544628527
total rq                      : 0
total inserts                 : 30248993
total deletes                 : 30256296
total updates                 : 60505289
total queries                 : 544628527
total ops                     : 605133816
find throughput               : 54462852
rq throughput                 : 0
update throughput             : 6050528
query throughput              : 54462852
total throughput              : 60513381

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=11.8784
PAPI_L3_TCM=2.07529
PAPI_TOT_CYC=8649.62
PAPI_TOT_INS=6822.95
garbage=272141369390805
total_execution_walltime=13.529s
REALTIME_MAIN_END_PERF_FORMAT=6998888.782220034
HyTM1 system shutdown:
    HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit         : 612784130
[slow htm]
[fallback]
total fallback commit         : 602306
seconds global lock is held   : 9.53435
[time_cmd_output] time_elapsed_sec=13.72, faults_major=0, faults_minor=323850, mem_maxresident_kb=1179724, user_cputime=2496.25, sys_cputime=9.04, percent_cpu=18252%
timeout=false
algorithm=brown_abtree_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=2