__step=000450
__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 48 -nprefill 48 -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=data000450.txt
__path_data=data/data000450.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=7000222.910640069
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=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


RH noREC w/postfix htm system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.005s
prefilling_size=99635 prefilling_elapsed_millis=1.001s
finished prefilling to size 99631 for expected size 100000 keysum=9961952081, performing 1016766 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99631
pref_millis=1102
prefill_elapsed_ms=1119
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=52

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=7000224.201971298
REALTIME_END_PERF_FORMAT=7000234.202127501

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

tree_stats_computeWalltime=0.039s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 63 120 228 402 674 1071 1636 2424 3392 4489 5487 6291 6730 6768 6223 5349 4317 3297 2266 1475 973 669 442 285 172 96 52 15 5 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 1 6 9 25 67 144 283 465 780 1241 1857 2465 3123 3544 3887 3797 3347 2770 2246 1592 1027 648 448 327 201 125 74 42 12 4 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 126 237 427 741 1215 1919 2889 4172 5730 7344 8756 9853 10312 10110 9146 7664 6067 4512 3067 2000 1317 890 612 373 221 126 57 17 5 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 126 237 427 741 1215 1919 2889 4172 5730 7344 8756 9853 10312 10110 9146 7664 6067 4512 3067 2000 1317 890 612 373 221 126 57 17 5 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.98438 1.92857 1.83966 1.79391 1.73009 1.69794 1.65294 1.60505 1.5604 1.49825 1.44513 1.40681 1.36354 1.32409 1.28912 1.25312 1.22834 1.20026 1.17753 1.17118 1.172 1.16781 1.19101 1.14379 1.13137 1.13575 1.03968 1.03509 1 1 1

tree_stats_height=37
tree_stats_numInternals=65475
tree_stats_numLeaves=34558
tree_stats_numNodes=100033
tree_stats_numKeys=100033

tree_stats_avgDegreeInternal=1.5278
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34547
tree_stats_avgKeyDepth=19.1434

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:75 2:1744 4:56526 8:369293 16:52251 32:5
    [2^00, 2^01]: 75
    (2^01, 2^02]: 1744
    (2^02, 2^03]: 56526
    (2^03, 2^04]: 369293
    (2^04, 2^05]: 52251
    (2^05, 2^06]: 5
sum_limbo_reclamation_event_size_total=5431743
count_limbo_reclamation_event_size_by_thread=9997 9998 9998 9997 9998 9998 9998 9996 9997 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9996 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998
count_limbo_reclamation_event_size_total=479894
sum_limbo_reclamation_event_count_total=1438704
first_thread_announced_epoch_by_thread=60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050 60050
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=651975516
sum_fasthtm_abort_total=88323565
sum_htmpostfix_commit_total=2167
sum_htmpostfix_abort_total=3442
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=4922
sum_stmprefix_commit_total=46
sum_slow_commit_total=81
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=675482 678676 684503 684667 681962 676692 683136 634829 698252 693850 694564 689385 628500 690260 662040 690865 694490 685320 690048 691644 689707 699406 681123 685193 647645 656902 662833 663638 661246 657086 658912 607722 696029 695260 690816 689814 677957 693726 680463 697457 692255 684611 685449 686869 691375 691680 680541 687907
sum_num_inserts_total=32602787
sum_num_deletes_by_thread=674551 678042 684268 683980 682297 677531 682415 633986 699077 693961 695089 688387 627153 690892 661037 690477 695524 685891 688281 692696 692048 700230 681806 685369 647492 657230 664040 664981 658735 657100 659834 609353 694058 696319 690224 689700 678395 693586 680435 696935 692537 683612 684216 688942 690327 693694 680742 685554
sum_num_deletes_total=32603029
sum_num_searches_by_thread=12134991 12204804 12316168 12318642 12276628 12182408 12284961 11440377 12573949 12488194 12512779 12413242 11310831 12426167 11907044 12443115 12501174 12353580 12408136 12451003 12431887 12574952 12253978 12334766 11667219 11807608 11944242 11950460 11888715 11857084 11872722 10928421 12478846 12539271 12449887 12408597 12215371 12475754 12233582 12545719 12448496 12317926 12332827 12386047 12444020 12461852 12232514 12341038
sum_num_searches_total=586771994
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=13485024 13561522 13684939 13687289 13640887 13536631 13650512 12709192 13971278 13876005 13902432 13791014 12566484 13807319 13230121 13824457 13891188 13724791 13786465 13835343 13813642 13974588 13616907 13705328 12962356 13121740 13271115 13279079 13208696 13171270 13191468 12145496 13868933 13930850 13830927 13788111 13571723 13863066 13594480 13940111 13833288 13686149 13702492 13761858 13825722 13847226 13593797 13714499
average_num_operations_total=13582871
stdev_num_operations_total=56257
sum_num_operations_total=651977810
min_num_operations_total=12145496
max_num_operations_total=13974588
first_time_thread_terminate_by_thread=10000155 10000154 10000155 10000155 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000153 10000154 10000155 10000154 10000154 10000154 10000155 10000155 10000155 10000154 10000154 10000154 10000154 10000155 10000154 10000155 10000155 10000154 10000154 10000155 10000154 10000154 10000154 10000154 10000153 10000154 10000155 10000154 10000154 10000154 10000155 10000155 10000155 10000154 10000154 10000154 10000154
min_time_thread_terminate_total=10000153
max_time_thread_terminate_total=10000155
first_time_thread_start_by_thread=6 6 6 6 6 7 6 6 6 5 6 6 6 6 6 6 6 6 5 6 6 6 6 5 6 6 6 6 6 7 6 5 6 5 6 6 6 6 6 6 6 6 5 6 6 6 6 5
min_time_thread_start_total=5
max_time_thread_start_total=7
sum_duration_all_ops_total=

threads_final_keysum=10010731849
threads_final_size=100033
final_keysum=10010731849
final_size=100033
validate_result=success
Validation OK.
Structural validation OK.

total_find=586771994
total_rq=0
total_inserts=32602787
total_deletes=32603029
total_updates=65205816
total_queries=586771994
total_ops=651977810
find_throughput=58677199
rq_throughput=0
update_throughput=6520581
query_throughput=58677199
total_throughput=65197781


total find                    : 586771994
total rq                      : 0
total inserts                 : 32602787
total deletes                 : 32603029
total updates                 : 65205816
total queries                 : 586771994
total ops                     : 651977810
find throughput               : 58677199
rq throughput                 : 0
update throughput             : 6520581
query throughput              : 58677199
total throughput              : 65197781

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=4.12753
PAPI_L3_TCM=0.000756372
PAPI_TOT_CYC=1986.35
PAPI_TOT_INS=1063.34
garbage=29337362225707
total_execution_walltime=11.428s
REALTIME_MAIN_END_PERF_FORMAT=7000234.345546645
RH noREC w/postfix htm system shutdown:
    HTM_ATTEMPT_THRESH=40
[time_cmd_output] time_elapsed_sec=11.56, faults_major=0, faults_minor=78333, mem_maxresident_kb=315608, user_cputime=561.47, sys_cputime=3.43, percent_cpu=4886%
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=2