__step=000305
__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.hybridnorec -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=data000305.txt
__path_data=data/data000305.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6998390.849099711
binary=./brown_abtree_tm_auto.debra.hybridnorec
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=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=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


Hybrid noREC system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.009s
prefilling_size=571691 prefilling_elapsed_millis=1.001s
prefilling_size=606692 prefilling_elapsed_millis=1.101s
prefilling_size=638481 prefilling_elapsed_millis=1.201s
prefilling_size=667304 prefilling_elapsed_millis=1.301s
prefilling_size=694254 prefilling_elapsed_millis=1.401s
prefilling_size=718609 prefilling_elapsed_millis=1.502s
prefilling_size=741291 prefilling_elapsed_millis=1.602s
prefilling_size=762577 prefilling_elapsed_millis=1.702s
prefilling_size=781826 prefilling_elapsed_millis=1.802s
prefilling_size=799222 prefilling_elapsed_millis=1.902s
prefilling_size=815097 prefilling_elapsed_millis=2.003s
prefilling_size=829926 prefilling_elapsed_millis=2.103s
prefilling_size=843841 prefilling_elapsed_millis=2.203s
prefilling_size=856474 prefilling_elapsed_millis=2.303s
prefilling_size=868131 prefilling_elapsed_millis=2.403s
prefilling_size=878845 prefilling_elapsed_millis=2.504s
prefilling_size=888930 prefilling_elapsed_millis=2.604s
prefilling_size=898012 prefilling_elapsed_millis=2.704s
prefilling_size=906789 prefilling_elapsed_millis=2.804s
prefilling_size=913825 prefilling_elapsed_millis=2.904s
prefilling_size=920851 prefilling_elapsed_millis=3.005s
prefilling_size=926873 prefilling_elapsed_millis=3.105s
prefilling_size=932528 prefilling_elapsed_millis=3.205s
prefilling_size=938035 prefilling_elapsed_millis=3.305s
prefilling_size=943018 prefilling_elapsed_millis=3.405s
prefilling_size=947502 prefilling_elapsed_millis=3.506s
prefilling_size=951867 prefilling_elapsed_millis=3.606s
prefilling_size=955455 prefilling_elapsed_millis=3.706s
prefilling_size=958770 prefilling_elapsed_millis=3.806s
prefilling_size=962013 prefilling_elapsed_millis=3.906s
prefilling_size=965076 prefilling_elapsed_millis=4.007s
prefilling_size=967612 prefilling_elapsed_millis=4.107s
prefilling_size=970241 prefilling_elapsed_millis=4.207s
prefilling_size=972505 prefilling_elapsed_millis=4.307s
prefilling_size=974732 prefilling_elapsed_millis=4.407s
prefilling_size=976925 prefilling_elapsed_millis=4.508s
prefilling_size=978648 prefilling_elapsed_millis=4.608s
prefilling_size=979697 prefilling_elapsed_millis=4.708s
prefilling_size=982020 prefilling_elapsed_millis=4.808s
finished prefilling to size 982004 for expected size 1000000 keysum=981732094597, performing 8179154 updates; total_prefilling_elapsed_ms=4909 ms)
pref_size=982004
pref_millis=4909
prefill_elapsed_ms=4935
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6998395.986464880
REALTIME_END_PERF_FORMAT=6998405.986605739

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

tree_stats_computeWalltime=0.051s

tree_stats_numInternalsAtDepth=1 1 8 56 423 3174 24673 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 190953
tree_stats_numNodesAtDepth=1 1 8 56 423 3174 24673 190953
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 999189
tree_stats_avgDegreeAtDepth=1 8 7 7.55357 7.50355 7.77347 7.73935 5.23264

tree_stats_height=8
tree_stats_numInternals=28336
tree_stats_numLeaves=190953
tree_stats_numNodes=219289
tree_stats_numKeys=999189

tree_stats_avgDegreeInternal=7.73888
tree_stats_avgDegreeLeaves=5.23264
tree_stats_avgDegree=5.55649
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=551568
first_thread_announced_epoch_by_thread=23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848 23848
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=177104 181186 182155 182541 185244 188227 180552 182996 184323 185331 185808 189659 182220 183466 183655 185754 185662 190508 180133 181343 184221 184811 184231 189778 181673 186367 187293 189331 191228 194402 187237 188972 190517 191901 192416 195351 188700 187691 188647 191351 192476 197849 185881 186919 190805 190505 191661 197367
sum_num_inserts_total=8987448
sum_num_deletes_by_thread=177125 181807 182846 183014 185257 187092 181222 183672 184287 185593 185768 189248 182477 183322 183401 186310 185999 190367 180229 181944 182754 184745 184123 189820 182369 185707 187412 189588 190789 194147 187030 189581 189616 192032 192254 196159 189781 188475 188675 190889 193460 196785 185658 186243 190864 191315 190532 197754
sum_num_deletes_total=8989537
sum_num_searches_by_thread=3177995 3266187 3295187 3293165 3329952 3374609 3256873 3300365 3325554 3345469 3352992 3409611 3292619 3290286 3295451 3347989 3343107 3442931 3241737 3263305 3302423 3334614 3314419 3419959 3278181 3349194 3378592 3407861 3442637 3496417 3373271 3408662 3425892 3453654 3463900 3508346 3398964 3393564 3400683 3430325 3468449 3556151 3343975 3365791 3438115 3431048 3442248 3557436
sum_num_searches_total=161830155
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3532224 3629180 3660188 3658720 3700453 3749928 3618647 3667033 3694164 3716393 3724568 3788518 3657316 3657074 3662507 3720053 3714768 3823806 3602099 3626592 3669398 3704170 3682773 3799557 3642223 3721268 3753297 3786780 3824654 3884966 3747538 3787215 3806025 3837587 3848570 3899856 3777445 3769730 3778005 3812565 3854385 3950785 3715514 3738953 3819784 3812868 3824441 3952557
average_num_operations_total=3745982
stdev_num_operations_total=13312
sum_num_operations_total=179807140
min_num_operations_total=3532224
max_num_operations_total=3952557
first_time_thread_terminate_by_thread=10000153 10000152 10000138 10000154 10000149 10000156 10000148 10000138 10000138 10000138 10000138 10000156 10000138 10000145 10000138 10000138 10000160 10000147 10000153 10000162 10000155 10000158 10000138 10000155 10000162 10000150 10000138 10000138 10000138 10000144 10000138 10000155 10000152 10000160 10000138 10000153 10000157 10000147 10000138 10000138 10000138 10000154 10000159 10000138 10000138 10000140 10000143 10000138
min_time_thread_terminate_total=10000138
max_time_thread_terminate_total=10000162
first_time_thread_start_by_thread=4 4 3 4 4 4 4 4 3 4 4 4 4 3 3 3 4 4 4 4 4 4 4 3 4 4 3 4 4 4 4 4 3 4 4 4 4 3 3 3 4 4 4 4 4 4 4 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=999284887389
threads_final_size=999189
final_keysum=999284887389
final_size=999189
validate_result=success
Validation OK.
Structural validation OK.

total_find=161830155
total_rq=0
total_inserts=8987448
total_deletes=8989537
total_updates=17976985
total_queries=161830155
total_ops=179807140
find_throughput=16183015
rq_throughput=0
update_throughput=1797698
query_throughput=16183015
total_throughput=17980714


total find                    : 161830155
total rq                      : 0
total inserts                 : 8987448
total deletes                 : 8989537
total updates                 : 17976985
total queries                 : 161830155
total ops                     : 179807140
find throughput               : 16183015
rq throughput                 : 0
update throughput             : 1797698
query throughput              : 16183015
total throughput              : 17980714

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=16.36
PAPI_L3_TCM=1.88462
PAPI_TOT_CYC=7394.85
PAPI_TOT_INS=2542.97
garbage=80764662363745
total_execution_walltime=15.288s
REALTIME_MAIN_END_PERF_FORMAT=6998406.139349010
Hybrid noREC system shutdown:
    HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit         : 183092209
[slow htm]
[fallback]
total fallback commit         : 4894086
seconds global lock is held   : 0.414977
[time_cmd_output] time_elapsed_sec=15.43, faults_major=0, faults_minor=138716, mem_maxresident_kb=555888, user_cputime=745.95, sys_cputime=4.56, percent_cpu=4863%
timeout=false
algorithm=brown_abtree_tm_auto.debra.hybridnorec
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1