__step=000317
__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.rhnorec_post -nwork 144 -nprefill 144 -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=data000317.txt
__path_data=data/data000317.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6998596.300793218
binary=./brown_abtree_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_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=144
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=144
WORK_THREADS=144
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


RH noREC w/postfix htm system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.018s
prefilling_size=87382 prefilling_elapsed_millis=1.001s
prefilling_size=96159 prefilling_elapsed_millis=1.101s
prefilling_size=104818 prefilling_elapsed_millis=1.201s
prefilling_size=113694 prefilling_elapsed_millis=1.301s
prefilling_size=122466 prefilling_elapsed_millis=1.402s
prefilling_size=130787 prefilling_elapsed_millis=1.502s
prefilling_size=139169 prefilling_elapsed_millis=1.602s
prefilling_size=147405 prefilling_elapsed_millis=1.702s
prefilling_size=156115 prefilling_elapsed_millis=1.802s
prefilling_size=164370 prefilling_elapsed_millis=1.903s
prefilling_size=172181 prefilling_elapsed_millis=2.003s
prefilling_size=180394 prefilling_elapsed_millis=2.103s
prefilling_size=188579 prefilling_elapsed_millis=2.203s
prefilling_size=196900 prefilling_elapsed_millis=2.303s
prefilling_size=204981 prefilling_elapsed_millis=2.404s
prefilling_size=212905 prefilling_elapsed_millis=2.504s
prefilling_size=220974 prefilling_elapsed_millis=2.604s
prefilling_size=228851 prefilling_elapsed_millis=2.704s
prefilling_size=236518 prefilling_elapsed_millis=2.804s
prefilling_size=244073 prefilling_elapsed_millis=2.905s
prefilling_size=251925 prefilling_elapsed_millis=3.005s
prefilling_size=259156 prefilling_elapsed_millis=3.105s
prefilling_size=266940 prefilling_elapsed_millis=3.205s
prefilling_size=274524 prefilling_elapsed_millis=3.305s
prefilling_size=281988 prefilling_elapsed_millis=3.406s
prefilling_size=289477 prefilling_elapsed_millis=3.506s
prefilling_size=296617 prefilling_elapsed_millis=3.606s
prefilling_size=303859 prefilling_elapsed_millis=3.706s
prefilling_size=311206 prefilling_elapsed_millis=3.807s
prefilling_size=318440 prefilling_elapsed_millis=3.907s
prefilling_size=325822 prefilling_elapsed_millis=4.007s
prefilling_size=332943 prefilling_elapsed_millis=4.107s
prefilling_size=339916 prefilling_elapsed_millis=4.207s
prefilling_size=347008 prefilling_elapsed_millis=4.308s
prefilling_size=354049 prefilling_elapsed_millis=4.408s
prefilling_size=360767 prefilling_elapsed_millis=4.508s
prefilling_size=367489 prefilling_elapsed_millis=4.608s
prefilling_size=374146 prefilling_elapsed_millis=4.708s
prefilling_size=380733 prefilling_elapsed_millis=4.809s
prefilling_size=387560 prefilling_elapsed_millis=4.909s
prefilling_size=394308 prefilling_elapsed_millis=5.009s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 605576 keys with 144 threads...
tid=0 thread_prefill_amount=4164 percent_done_estimate=99.0 elapsed_s=7 est_remaining_s=0 / 7
tid=0 thread_prefill_amount=5552 percent_done_estimate=132.0 elapsed_s=9 est_remaining_s=-5 / 4
tid=0 thread_prefill_amount=6940 percent_done_estimate=165.0 elapsed_s=11 est_remaining_s=-10 / 1
timing_elapsed 6.25918s
prefilling_size=1000000 prefilling_elapsed_millis=6.274s
finished prefilling to size 1000000 for expected size 1000000 keysum=999788977533, performing 1951890 updates; total_prefilling_elapsed_ms=6274 ms)
pref_size=1000000
pref_millis=6274
prefill_elapsed_ms=6274
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6998607.944163574
REALTIME_END_PERF_FORMAT=6998617.944400425

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

tree_stats_computeWalltime=0.034s

tree_stats_numInternalsAtDepth=1 1 6 46 331 2521 19815 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 156555
tree_stats_numNodesAtDepth=1 1 6 46 331 2521 19815 156555
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 1000408
tree_stats_avgDegreeAtDepth=1 6 7.66667 7.19565 7.61631 7.85998 7.90083 6.39014

tree_stats_height=8
tree_stats_numInternals=22721
tree_stats_numLeaves=156555
tree_stats_numNodes=179276
tree_stats_numKeys=1000408

tree_stats_avgDegreeInternal=7.89032
tree_stats_avgDegreeLeaves=6.39014
tree_stats_avgDegree=6.58027
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=25908
first_thread_announced_epoch_by_thread=386 386 386 386 384 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 384 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 386 384 386 386 386 386 386 386 384 386 386
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=25176557
sum_fasthtm_abort_total=55047818
sum_htmpostfix_commit_total=1314777
sum_htmpostfix_abort_total=3827299
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=53831041
sum_stmprefix_commit_total=70
sum_slow_commit_total=11619
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=9409 9336 8127 9449 9260 8951 9080 9511 8172 9460 9227 9215 9327 9693 7745 9053 9336 9620 9034 9292 7832 9241 8781 8796 9018 9139 8096 9508 9159 9038 9101 9302 7868 9103 9232 9184 8758 9391 7449 9124 9267 9177 9187 9130 7505 9116 8737 8666 10238 10074 8071 10067 10107 9407 10104 10109 8372 9914 9965 10088 9883 10583 8122 10046 9889 10025 10191 9991 8396 9846 10108 10027 10265 10139 7997 10029 10222 9367 10268 9906 8232 10102 10086 10076 10112 10186 8249 10038 9725 10298 9879 9990 8127 9796 9995 9810 9179 9023 7711 9293 9504 9144 9382 9542 7891 9338 8918 9191 9296 9407 7951 9469 8901 9105 9016 9107 7864 9238 9450 9208 9062 9145 7526 9150 9403 8980 9071 9252 7665 9170 8802 9234 9217 9175 7610 9315 9015 9135 9020 8920 7815 8918 9159 9036
sum_num_inserts_total=1325642
sum_num_deletes_by_thread=9272 9259 7961 9327 9265 9051 9010 9268 8306 9450 9129 9259 9415 9602 7720 9240 9269 9368 9325 9142 7695 9291 8971 8938 9052 9278 8022 9323 9047 8942 9273 9437 7780 9026 9376 9109 8936 9191 7321 9115 9165 8969 8970 9223 7624 9327 8801 8750 10313 9841 8026 10055 10128 9363 10375 10004 8481 10067 9982 9947 9961 10642 8175 10059 9894 9779 10076 10274 8276 10062 10231 9949 10064 10028 7854 10209 10160 9342 10344 10197 8198 10003 10035 9944 10378 10206 8425 10286 9716 10172 9958 10063 8112 9782 9885 9919 9126 9191 7794 9491 9419 9256 9456 9431 7720 9284 8973 9325 9287 9468 7875 9452 9025 9017 8949 9080 7764 9179 9266 9347 9095 9286 7293 9031 9310 9173 9256 9318 7423 9041 8961 9248 9226 9229 7527 9283 8949 9081 9027 8852 7923 8929 9214 9130
sum_num_deletes_total=1325810
sum_num_searches_by_thread=166761 169931 144740 169339 168181 161932 161426 166110 150122 170379 164375 163466 167324 173470 137468 161598 166929 168737 163256 166462 140149 167102 158970 160530 161483 165149 145847 167670 164976 163381 166087 168597 141952 162569 167135 163767 159210 169062 135059 165225 167268 166651 161086 164933 137521 165139 158376 158215 184908 180233 141725 180523 182013 169387 185527 179553 154782 178339 182254 181870 177540 189379 148012 181316 182083 177329 182851 184621 151668 181407 184345 179009 182618 181250 142616 180865 183408 169534 186455 181198 147511 180630 179860 177791 186233 182672 151330 182193 175510 182725 178097 181086 144259 174891 177486 177981 165639 162259 139816 168925 168867 164646 170453 168831 141917 169503 159880 165453 166922 168962 144640 168160 162522 162493 159943 161183 139553 164688 164445 167011 162736 165462 133647 165536 168632 162867 164575 167830 134412 165468 162172 166418 167238 164357 133145 164695 162184 165232 163999 160604 140847 161827 164174 162815
sum_num_searches_total=23851571
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=185442 188526 160828 188115 186706 179934 179516 184889 166600 189289 182731 181940 186066 192765 152933 179891 185534 187725 181615 184896 155676 185634 176722 178264 179553 183566 161965 186501 183182 181361 184461 187336 157600 180698 185743 182060 176904 187644 149829 183464 185700 184797 179243 183286 152650 183582 175914 175631 205459 200148 157822 200645 202248 188157 206006 199666 171635 198320 202201 201905 197384 210604 164309 201421 201866 197133 203118 204886 168340 201315 204684 198985 202947 201417 158467 201103 203790 188243 207067 201301 163941 200735 199981 197811 206723 203064 168004 202517 194951 203195 197934 201139 160498 194469 197366 197710 183944 180473 155321 187709 187790 183046 189291 187804 157528 188125 177771 183969 185505 187837 160466 187081 180448 180615 177908 179370 155181 183105 183161 185566 180893 183893 148466 183717 187345 181020 182902 186400 149500 183679 179935 184900 185681 182761 148282 183293 180148 183448 182046 178376 156585 179674 182547 180981
average_num_operations_total=184048
stdev_num_operations_total=1203
sum_num_operations_total=26503023
min_num_operations_total=148282
max_num_operations_total=210604
first_time_thread_terminate_by_thread=10000504 10000245 10000484 10000294 10003333 10000245 10000234 10000290 10000366 10000289 10000500 10000275 10000275 10000683 10000727 10000687 10000754 10000675 10000752 10000669 10000245 10000723 10000634 10000531 10000530 10000650 10000286 10000682 10000509 10000674 10000433 10000597 10000567 10000585 10000692 10000543 10000611 10000232 10000713 10000273 10001701 10000708 10001682 10000762 10000674 10000737 10000702 10000614 10000614 10000461 10000631 10000742 10000242 10001689 10000630 10000690 10000756 10000633 10000748 10000746 10000230 10000306 10000686 10000743 10002636 10000547 10000613 10000706 10000576 10000233 10000689 10000767 10000662 10000234 10000241 10000634 10000457 10000433 10000319 10000736 10000313 10000758 10000730 10000760 10000728 10000680 10000739 10000297 10000738 10000591 10000648 10000635 10000260 10001692 10000722 10000231 10000433 10000247 10000233 10000387 10000549 10000590 10000604 10000368 10000344 10000361 10000336 10000231 10000233 10000513 10000694 10000397 10000468 10000425 10000339 10000608 10000410 10000429 10000352 10000523 10000582 10000649 10000341 10000457 10000374 10000443 10000574 10000231 10000454 10000600 10000438 10000600 10000578 10000247 10001697 10000640 10000366 10000589 10000426 10000294 10000459 10000700 10000298 10000615
min_time_thread_terminate_total=10000230
max_time_thread_terminate_total=10003333
first_time_thread_start_by_thread=8 5 5 4 4 4 4 4 4 4 4 5 4 4 4 4 4 4 4 4 4 4 5 4 3 5 5 4 4 4 4 4 4 4 4 5 4 4 4 4 4 4 4 4 4 4 5 4 5 5 5 5 5 5 4 5 4 5 5 4 5 5 4 5 5 5 4 4 5 4 5 5 5 5 5 5 5 5 4 5 4 5 5 4 5 5 4 5 5 5 4 4 5 4 5 5 5 5 5 5 5 4 5 4 5 4 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 4 5 4 5 5 5 5 4 5 5 5 5 5 5 5 5 5
min_time_thread_start_total=3
max_time_thread_start_total=8
sum_duration_all_ops_total=

threads_final_keysum=1000037949610
threads_final_size=1000408
final_keysum=1000037949610
final_size=1000408
validate_result=success
Validation OK.
Structural validation OK.

total_find=23851571
total_rq=0
total_inserts=1325642
total_deletes=1325810
total_updates=2651452
total_queries=23851571
total_ops=26503023
find_throughput=2385157
rq_throughput=0
update_throughput=265145
query_throughput=2385157
total_throughput=2650302


total find                    : 23851571
total rq                      : 0
total inserts                 : 1325642
total deletes                 : 1325810
total updates                 : 2651452
total queries                 : 23851571
total ops                     : 26503023
find throughput               : 2385157
rq throughput                 : 0
update throughput             : 265145
query throughput              : 2385157
total throughput              : 2650302

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=35.5249
PAPI_L3_TCM=9.80722
PAPI_TOT_CYC=136193
PAPI_TOT_INS=3746.31
garbage=10781695251035
total_execution_walltime=21.783s
REALTIME_MAIN_END_PERF_FORMAT=6998618.100003510
RH noREC w/postfix htm system shutdown:
    HTM_ATTEMPT_THRESH=40
[time_cmd_output] time_elapsed_sec=21.97, faults_major=0, faults_minor=219943, mem_maxresident_kb=875924, user_cputime=3030.44, sys_cputime=40.42, percent_cpu=13974%
timeout=false
algorithm=brown_abtree_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