__step=000276
__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_sigouin_int_avl_tm_auto.debra.rhnorec_post -nwork 96 -nprefill 96 -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=data000276.txt
__path_data=data/data000276.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6997961.333866447
binary=./brown_sigouin_int_avl_tm_auto.debra.rhnorec_post
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=brown_sigouin_int_avl_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=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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=48
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


RH noREC w/postfix htm system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.011s
prefilling_size=158288 prefilling_elapsed_millis=1.001s
prefilling_size=173401 prefilling_elapsed_millis=1.101s
prefilling_size=188294 prefilling_elapsed_millis=1.201s
prefilling_size=202575 prefilling_elapsed_millis=1.301s
prefilling_size=217094 prefilling_elapsed_millis=1.402s
prefilling_size=231374 prefilling_elapsed_millis=1.502s
prefilling_size=245492 prefilling_elapsed_millis=1.602s
prefilling_size=259263 prefilling_elapsed_millis=1.702s
prefilling_size=272636 prefilling_elapsed_millis=1.802s
prefilling_size=285839 prefilling_elapsed_millis=1.903s
prefilling_size=298991 prefilling_elapsed_millis=2.003s
prefilling_size=311670 prefilling_elapsed_millis=2.103s
prefilling_size=324397 prefilling_elapsed_millis=2.203s
prefilling_size=336532 prefilling_elapsed_millis=2.303s
prefilling_size=348828 prefilling_elapsed_millis=2.404s
prefilling_size=360966 prefilling_elapsed_millis=2.504s
prefilling_size=372582 prefilling_elapsed_millis=2.604s
prefilling_size=384250 prefilling_elapsed_millis=2.704s
prefilling_size=395604 prefilling_elapsed_millis=2.804s
prefilling_size=406572 prefilling_elapsed_millis=2.904s
prefilling_size=417292 prefilling_elapsed_millis=3.005s
prefilling_size=428101 prefilling_elapsed_millis=3.105s
prefilling_size=438580 prefilling_elapsed_millis=3.205s
prefilling_size=448983 prefilling_elapsed_millis=3.305s
prefilling_size=458943 prefilling_elapsed_millis=3.405s
prefilling_size=469150 prefilling_elapsed_millis=3.506s
prefilling_size=478929 prefilling_elapsed_millis=3.606s
prefilling_size=488669 prefilling_elapsed_millis=3.706s
prefilling_size=498352 prefilling_elapsed_millis=3.806s
prefilling_size=507486 prefilling_elapsed_millis=3.906s
prefilling_size=516847 prefilling_elapsed_millis=4.007s
prefilling_size=525908 prefilling_elapsed_millis=4.107s
prefilling_size=534680 prefilling_elapsed_millis=4.207s
prefilling_size=543400 prefilling_elapsed_millis=4.307s
prefilling_size=551892 prefilling_elapsed_millis=4.407s
prefilling_size=560309 prefilling_elapsed_millis=4.508s
prefilling_size=568371 prefilling_elapsed_millis=4.608s
prefilling_size=576480 prefilling_elapsed_millis=4.708s
prefilling_size=584392 prefilling_elapsed_millis=4.808s
prefilling_size=592193 prefilling_elapsed_millis=4.908s
prefilling_size=599976 prefilling_elapsed_millis=5.009s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 399987 keys with 96 threads...
tid=0 thread_prefill_amount=6249 percent_done_estimate=150.0 elapsed_s=5 est_remaining_s=-4 / 1
tid=0 thread_prefill_amount=8332 percent_done_estimate=200.0 elapsed_s=7 est_remaining_s=-7 / -1
timing_elapsed 2.18101s
prefilling_size=1000000 prefilling_elapsed_millis=2.186s
finished prefilling to size 1000000 for expected size 1000000 keysum=999401695346, performing 2510837 updates; total_prefilling_elapsed_ms=2186 ms)
pref_size=1000000
pref_millis=2186
prefill_elapsed_ms=2186
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6997968.816162996
REALTIME_END_PERF_FORMAT=6997978.816291607

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

tree_stats_computeWalltime=0.01s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16382 32728 64380 115101 153800 122349 46335 6376 185 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 2 35 953 11671 61847 141594 142536 58565 8071 226
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32763 65333 126772 215647 263943 188871 64941 8256 226
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32763 65333 126772 215647 263943 188871 64941 8256 226
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99982 1.99518 1.95498 1.79312 1.51076 1.25203 1.09851 1.02895 1.00497 1

tree_stats_height=24
tree_stats_numInternals=574019
tree_stats_numLeaves=425500
tree_stats_numNodes=999519
tree_stats_numKeys=999519

tree_stats_avgDegreeInternal=1.74126
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.4257
tree_stats_avgKeyDepth=18.3513


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=54221
first_thread_announced_epoch_by_thread=1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192 1192
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=33560088
sum_fasthtm_abort_total=71856909
sum_htmpostfix_commit_total=1723269
sum_htmpostfix_abort_total=9229999
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=56468219
sum_stmprefix_commit_total=72
sum_slow_commit_total=41769
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=17578 17776 16852 17801 18199 17963 18017 17680 17063 17946 18527 18162 17865 17997 17010 17990 18309 18197 18353 18059 16840 17605 17912 18105 17786 17466 16855 17892 18528 17819 17911 17905 17176 18224 18785 18070 17501 18132 17112 18008 18326 18034 18191 17911 16467 17736 18024 18136 18762 18766 18113 18880 19106 18774 19153 19074 18585 19550 19445 19450 18808 19183 17724 18806 19188 18990 18800 19193 17858 19344 19531 19266 18808 18840 18014 19246 19344 18690 19142 18863 18544 19265 19462 19826 18744 18903 17789 18691 19256 19433 18922 18853 17809 19523 19689 19276
sum_num_inserts_total=1765082
sum_num_deletes_by_thread=17330 17659 17085 18104 18463 17642 17611 18215 16895 17945 18608 18069 17680 17822 16903 18118 18362 18185 17820 18042 16535 17843 18117 18215 17718 17544 17099 17935 18613 18198 17956 18228 16953 17849 18543 18241 17936 18189 16892 18265 18352 18176 17987 17988 16432 17980 18054 18053 18730 18846 18050 18866 19461 18685 19096 19229 18530 19513 19831 19517 18891 18963 17877 18969 19201 19054 19054 18954 17981 19127 19149 19153 18897 18736 17956 19109 19083 18719 18989 18813 18300 19416 19828 19493 18902 19014 17687 18840 19438 18949 18875 18895 17759 19403 19380 19613
sum_num_deletes_total=1765270
sum_num_searches_by_thread=313059 317763 306015 323476 330934 319204 322077 325293 303703 322681 337392 328552 321965 323038 306783 325644 327654 324479 324548 322201 298733 314545 323304 326066 319209 315876 301665 321505 334250 321722 323148 324569 306029 321789 338003 326555 320652 326055 307874 326691 329012 328821 323723 325013 297208 322441 325070 326806 336418 340832 326887 338769 346868 340242 344607 347649 335791 349462 353839 350439 339380 343105 321260 342998 343964 342583 343087 341885 326167 347030 347372 347673 339720 337718 327373 346333 345032 337940 344621 338496 331882 348739 355794 356320 340388 343849 319397 336225 346572 344495 338777 341578 320284 348200 352991 351020
sum_num_searches_total=31794846
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=347967 353198 339952 359381 367596 354809 357705 361188 337661 358572 374527 364783 357510 358857 340696 361752 364325 360861 360721 358302 332108 349993 359333 362386 354713 350886 335619 357332 371391 357739 359015 360702 340158 357862 375331 362866 356089 362376 341878 362964 365690 365031 359901 360912 330107 358157 361148 362995 373910 378444 363050 376515 385435 377701 382856 385952 372906 388525 393115 389406 377079 381251 356861 380773 382353 380627 380941 380032 362006 385501 386052 386092 377425 375294 363343 384688 383459 375349 382752 376172 368726 387420 395084 395639 378034 381766 354873 373756 385266 382877 376574 379326 355852 387126 392060 389909
average_num_operations_total=367970
stdev_num_operations_total=1556
sum_num_operations_total=35325198
min_num_operations_total=330107
max_num_operations_total=395639
first_time_thread_terminate_by_thread=10000648 10000643 10000642 10000128 10000250 10000638 10000613 10000193 10000668 10000671 10000180 10000633 10000596 10000246 10000161 10000223 10000196 10000659 10000564 10000193 10000617 10000130 10000664 10000650 10000298 10000646 10000203 10000130 10000621 10000662 10000129 10000603 10000615 10000672 10000137 10000128 10000181 10000653 10000201 10000577 10000128 10000241 10000289 10000622 10000638 10000651 10000670 10000565 10000239 10000666 10000274 10000655 10000631 10000239 10000281 10000132 10000283 10000129 10000643 10000289 10000669 10000605 10000568 10000130 10000605 10000571 10000278 10000211 10000182 10000591 10000257 10000146 10000555 10000130 10000234 10000618 10000625 10000128 10000618 10000594 10000604 10000657 10000127 10000561 10000624 10000218 10000215 10000210 10000586 10000640 10000261 10000629 10000660 10000227 10000587 10000129
min_time_thread_terminate_total=10000127
max_time_thread_terminate_total=10000672
first_time_thread_start_by_thread=9 5 5 5 6 6 5 5 5 6 5 6 6 5 5 5 6 5 6 5 5 6 6 6 5 5 5 5 6 6 5 5 5 6 5 6 6 5 5 5 6 5 6 5 5 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6
min_time_thread_start_total=5
max_time_thread_start_total=9
sum_duration_all_ops_total=

threads_final_keysum=999792878879
threads_final_size=999519
final_keysum=999792878879
final_size=999519
validate_result=success
Validation OK.
Structural validation OK.

total_find=31794846
total_rq=0
total_inserts=1765082
total_deletes=1765270
total_updates=3530352
total_queries=31794846
total_ops=35325198
find_throughput=3179484
rq_throughput=0
update_throughput=353035
query_throughput=3179484
total_throughput=3532519


total find                    : 31794846
total rq                      : 0
total inserts                 : 1765082
total deletes                 : 1765270
total updates                 : 3530352
total queries                 : 31794846
total ops                     : 35325198
find throughput               : 3179484
rq throughput                 : 0
update throughput             : 353035
query throughput              : 3179484
total throughput              : 3532519

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=34.9603
PAPI_L3_TCM=8.92209
PAPI_TOT_CYC=67759.7
PAPI_TOT_INS=4095.09
garbage=15895986234324
total_execution_walltime=17.608s
REALTIME_MAIN_END_PERF_FORMAT=6997978.943527832
RH noREC w/postfix htm system shutdown:
    HTM_ATTEMPT_THRESH=40
[time_cmd_output] time_elapsed_sec=17.76, faults_major=0, faults_minor=129349, mem_maxresident_kb=515844, user_cputime=1639.29, sys_cputime=26.71, percent_cpu=9380%
timeout=false
algorithm=brown_sigouin_int_avl_tm_auto.debra.rhnorec_post
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2