__step=000451
__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.rhnorec_post -nwork 96 -nprefill 96 -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=data000451.txt
__path_data=data/data000451.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=7000234.508437088
binary=./brown_int_bst_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_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=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=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,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=91086 prefilling_elapsed_millis=1.001s
prefilling_size=93243 prefilling_elapsed_millis=1.101s
prefilling_size=94532 prefilling_elapsed_millis=1.201s
prefilling_size=95604 prefilling_elapsed_millis=1.301s
prefilling_size=96658 prefilling_elapsed_millis=1.402s
prefilling_size=97401 prefilling_elapsed_millis=1.502s
prefilling_size=98031 prefilling_elapsed_millis=1.602s
finished prefilling to size 98027 for expected size 100000 keysum=9796984023, performing 773170 updates; total_prefilling_elapsed_ms=1704 ms)
pref_size=98027
pref_millis=1704
prefill_elapsed_ms=1727
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=11

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=7000236.417450514
REALTIME_END_PERF_FORMAT=7000246.417600300

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

tree_stats_computeWalltime=0.033s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 61 119 221 388 651 1030 1542 2242 3073 3925 4740 5389 5723 5867 5789 5472 4951 4223 3250 2413 1704 1084 633 335 192 88 49 21 10 5 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 2 1 10 31 72 147 282 476 774 1209 1673 2180 2700 2901 3133 3262 3168 3016 2715 2136 1608 1197 785 472 243 153 59 39 16 5 4 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 63 120 231 419 723 1177 1824 2718 3847 5134 6413 7569 8423 8768 8922 8734 8119 7239 5965 4549 3312 2281 1418 807 435 241 108 60 26 10 6 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 63 120 231 419 723 1177 1824 2718 3847 5134 6413 7569 8423 8768 8922 8734 8119 7239 5965 4549 3312 2281 1418 807 435 241 108 60 26 10 6 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 1.96875 1.93651 1.93333 1.85714 1.79952 1.72752 1.6746 1.64474 1.59051 1.53574 1.48461 1.44114 1.40085 1.36151 1.34843 1.33008 1.30307 1.28181 1.24064 1.21777 1.19763 1.17421 1.14643 1.12271 1.12392 1.11264 1.08299 1.10185 1.08333 1 1.1 1 1

tree_stats_height=38
tree_stats_numInternals=65255
tree_stats_numLeaves=34471
tree_stats_numNodes=99726
tree_stats_numKeys=99726

tree_stats_avgDegreeInternal=1.52825
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34566
tree_stats_avgKeyDepth=19.7239

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:11 4:1109 8:41010 16:30244 32:10
    (2^01, 2^02]: 11
    (2^02, 2^03]: 1109
    (2^03, 2^04]: 41010
    (2^04, 2^05]: 30244
    (2^05, 2^06]: 10
sum_limbo_reclamation_event_size_total=1082034
count_limbo_reclamation_event_size_by_thread=754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754 754
count_limbo_reclamation_event_size_total=72384
sum_limbo_reclamation_event_count_total=72576
first_thread_announced_epoch_by_thread=1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534 1534
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=41347818
sum_fasthtm_abort_total=88432477
sum_htmpostfix_commit_total=2151667
sum_htmpostfix_abort_total=2243012
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=44745960
sum_stmprefix_commit_total=732
sum_slow_commit_total=17319
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=27826 21265 21414 21541 21441 21177 27585 21194 21163 21487 21161 21474 27823 21458 21417 21515 21470 21792 27572 20782 20359 21689 21268 21082 27849 20888 21591 21335 21544 20980 27658 21163 21462 21294 21047 21553 27888 21818 21596 21833 21333 21537 27286 21109 20958 21474 20968 21247 28332 22083 22103 21843 22036 21143 28045 21774 21984 21698 21896 22171 28174 21575 21187 22188 21887 22113 28352 21419 21473 21926 21593 21769 28409 22221 22231 21617 22153 21183 28431 21818 21775 22130 22212 21941 28075 22133 21188 21938 21609 22070 27982 21742 21747 22078 21872 21835
sum_num_inserts_total=2173520
sum_num_deletes_by_thread=27813 21460 21730 21244 21695 20841 27578 21191 21076 21364 21198 21357 27722 21496 21517 21628 21587 21666 27626 20753 20467 21350 21018 21257 27785 21087 21889 21347 21602 21076 27962 21120 21321 21467 21092 21306 27621 21645 21480 21922 21176 21726 27879 20880 20857 21591 20986 21117 28243 22074 22019 21754 22046 21138 28154 21786 21939 21909 21773 22126 28321 21884 21502 21977 21698 22041 28278 21719 21607 22198 21844 22079 28633 22204 22202 21663 22049 21081 28272 21687 22045 21766 22091 22133 28221 21817 21403 21994 21885 22173 28227 21405 21847 21961 21536 21740
sum_num_deletes_total=2174712
sum_num_searches_by_thread=500865 384873 385490 385432 390801 380515 495379 380006 383019 384197 381646 385370 503534 383756 388630 388042 386005 393645 503037 374120 370415 386870 380763 382296 498756 378712 390063 380721 391322 376247 502057 380015 385197 384892 378301 387165 500937 390174 388734 390024 380188 390614 494876 379321 377516 390828 376734 379543 508104 397364 399130 393989 397654 380670 506796 392498 394193 394488 391485 400956 506455 390986 385406 401415 392142 398274 507813 391590 388551 398112 391621 394288 509691 401388 401601 391079 399900 378740 512652 388358 396556 399635 396915 403167 504804 392160 384202 396427 392169 395439 505924 389661 390846 398044 392138 392185
sum_num_searches_total=39169304
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=556504 427598 428634 428217 433937 422533 550542 422391 425258 427048 424005 428201 559079 426710 431564 431185 429062 437103 558235 415655 411241 429909 423049 424635 554390 420687 433543 423403 434468 418303 557677 422298 427980 427653 420440 430024 556446 433637 431810 433779 422697 433877 550041 421310 419331 433893 418688 421907 564679 441521 443252 437586 441736 422951 562995 436058 438116 438095 435154 445253 562950 434445 428095 445580 435727 442428 564443 434728 431631 442236 435058 438136 566733 445813 446034 434359 444102 421004 569355 431863 440376 443531 441218 447241 561100 436110 426793 440359 435663 439682 562133 432808 434440 442083 435546 435760
average_num_operations_total=453307
stdev_num_operations_total=4977
sum_num_operations_total=43517536
min_num_operations_total=411241
max_num_operations_total=569355
first_time_thread_terminate_by_thread=10000248 10000307 10000278 10000381 10000323 10000389 10000293 10000182 10000372 10000255 10000370 10000376 10000387 10000174 10000154 10000369 10000371 10000378 10000154 10000235 10000372 10000353 10000362 10000311 10000380 10000257 10000325 10000384 10000368 10000353 10000221 10000354 10000165 10000304 10000198 10000375 10000155 10000362 10000299 10000337 10000386 10000235 10000374 10000363 10000383 10000388 10000347 10000325 10000177 10000340 10000292 10000157 10000358 10000182 10000296 10000328 10000152 10000252 10000333 10000360 10000218 10000222 10000171 10000152 10000152 10000306 10000349 10000287 10000297 10000211 10000205 10000198 10000182 10000353 10000251 10000234 10000152 10000152 10000284 10000275 10000212 10000198 10000170 10000390 10000237 10000329 10000252 10000152 10000337 10000356 10000346 10000312 10000240 10000306 10000158 10000330
min_time_thread_terminate_total=10000152
max_time_thread_terminate_total=10000390
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=

threads_final_keysum=9968499728
threads_final_size=99726
final_keysum=9968499728
final_size=99726
validate_result=success
Validation OK.
Structural validation OK.

total_find=39169304
total_rq=0
total_inserts=2173520
total_deletes=2174712
total_updates=4348232
total_queries=39169304
total_ops=43517536
find_throughput=3916930
rq_throughput=0
update_throughput=434823
query_throughput=3916930
total_throughput=4351753


total find                    : 39169304
total rq                      : 0
total inserts                 : 2173520
total deletes                 : 2174712
total updates                 : 4348232
total queries                 : 39169304
total ops                     : 43517536
find throughput               : 3916930
rq throughput                 : 0
update throughput             : 434823
query throughput              : 3916930
total throughput              : 4351753

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=20.5546
PAPI_L3_TCM=4.51327
PAPI_TOT_CYC=55708.6
PAPI_TOT_INS=3221.25
garbage=1936216805261
total_execution_walltime=12.102s
REALTIME_MAIN_END_PERF_FORMAT=7000246.611826941
RH noREC w/postfix htm system shutdown:
    HTM_ATTEMPT_THRESH=40
[time_cmd_output] time_elapsed_sec=12.21, faults_major=0, faults_minor=96019, mem_maxresident_kb=382056, user_cputime=1134.69, sys_cputime=16.15, percent_cpu=9423%
timeout=false
algorithm=brown_int_bst_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=1