__step=000237
__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 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=data000237.txt
__path_data=data/data000237.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6997385.396284207
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=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=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,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.042s
prefilling_size=166483 prefilling_elapsed_millis=1.001s
prefilling_size=181601 prefilling_elapsed_millis=1.101s
prefilling_size=196683 prefilling_elapsed_millis=1.202s
prefilling_size=211038 prefilling_elapsed_millis=1.302s
prefilling_size=225085 prefilling_elapsed_millis=1.403s
prefilling_size=238832 prefilling_elapsed_millis=1.503s
prefilling_size=252733 prefilling_elapsed_millis=1.604s
prefilling_size=266047 prefilling_elapsed_millis=1.704s
prefilling_size=279084 prefilling_elapsed_millis=1.805s
prefilling_size=292020 prefilling_elapsed_millis=1.905s
prefilling_size=304623 prefilling_elapsed_millis=2.006s
prefilling_size=316945 prefilling_elapsed_millis=2.106s
prefilling_size=329117 prefilling_elapsed_millis=2.207s
prefilling_size=341228 prefilling_elapsed_millis=2.307s
prefilling_size=353122 prefilling_elapsed_millis=2.407s
prefilling_size=364578 prefilling_elapsed_millis=2.508s
prefilling_size=375978 prefilling_elapsed_millis=2.608s
prefilling_size=387153 prefilling_elapsed_millis=2.709s
prefilling_size=398117 prefilling_elapsed_millis=2.81s
prefilling_size=409064 prefilling_elapsed_millis=2.91s
prefilling_size=419545 prefilling_elapsed_millis=3.011s
prefilling_size=429607 prefilling_elapsed_millis=3.111s
prefilling_size=439729 prefilling_elapsed_millis=3.212s
prefilling_size=449778 prefilling_elapsed_millis=3.312s
prefilling_size=459599 prefilling_elapsed_millis=3.413s
prefilling_size=469080 prefilling_elapsed_millis=3.513s
prefilling_size=478395 prefilling_elapsed_millis=3.614s
prefilling_size=487517 prefilling_elapsed_millis=3.714s
prefilling_size=497066 prefilling_elapsed_millis=3.815s
prefilling_size=505900 prefilling_elapsed_millis=3.916s
prefilling_size=514755 prefilling_elapsed_millis=4.016s
prefilling_size=523389 prefilling_elapsed_millis=4.117s
prefilling_size=532000 prefilling_elapsed_millis=4.217s
prefilling_size=540587 prefilling_elapsed_millis=4.318s
prefilling_size=548799 prefilling_elapsed_millis=4.418s
prefilling_size=556944 prefilling_elapsed_millis=4.519s
prefilling_size=564471 prefilling_elapsed_millis=4.619s
prefilling_size=572456 prefilling_elapsed_millis=4.72s
prefilling_size=580458 prefilling_elapsed_millis=4.82s
prefilling_size=587983 prefilling_elapsed_millis=4.921s
prefilling_size=595505 prefilling_elapsed_millis=5.022s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 404423 keys with 144 threads...
tid=0 thread_prefill_amount=5552 percent_done_estimate=197.7 elapsed_s=5 est_remaining_s=-6 / -1
tid=0 thread_prefill_amount=6940 percent_done_estimate=247.1 elapsed_s=6 est_remaining_s=-8 / -2
timing_elapsed 2.04838s
prefilling_size=1000000 prefilling_elapsed_millis=2.053s
finished prefilling to size 1000000 for expected size 1000000 keysum=1000100787234, performing 2491233 updates; total_prefilling_elapsed_ms=2053 ms)
pref_size=1000000
pref_millis=2053
prefill_elapsed_ms=2053
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=17

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6997392.853895551
REALTIME_END_PERF_FORMAT=6997402.854066927

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

tree_stats_computeWalltime=0.025s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 126 242 453 819 1428 2360 3745 5649 8100 11355 15370 20118 25368 31306 37348 42757 47050 49425 49669 48539 45404 41042 35731 30314 25144 20316 15952 12176 9040 6785 4783 3251 2081 1289 776 413 251 147 75 34 18 10 3 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 5 16 49 113 251 539 984 1733 2567 3837 5630 7858 10336 13277 16887 20179 23575 25757 26363 27015 25933 23997 21334 18375 15420 12786 10214 7972 5775 4512 3244 2304 1441 897 594 293 188 116 63 25 12 9 3 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 127 247 469 868 1541 2611 4284 6633 9833 13922 19207 25748 33226 41642 50625 59644 67229 73000 75426 74902 72419 66975 59728 51648 43519 35736 28738 22390 17012 12560 9295 6495 4385 2730 1673 1007 544 335 191 97 43 22 12 4 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 127 247 469 868 1541 2611 4284 6633 9833 13922 19207 25748 33226 41642 50625 59644 67229 73000 75426 74902 72419 66975 59728 51648 43519 35736 28738 22390 17012 12560 9295 6495 4385 2730 1673 1007 544 335 191 97 43 22 12 4 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.98438 1.95276 1.91903 1.88486 1.8318 1.76768 1.73688 1.67414 1.63079 1.59209 1.564 1.54032 1.50909 1.4898 1.46393 1.44041 1.4103 1.38599 1.35618 1.33454 1.31882 1.29786 1.279 1.26649 1.25567 1.24339 1.23567 1.22402 1.21599 1.20691 1.19984 1.18419 1.1746 1.148 1.14066 1.13808 1.13009 1.15441 1.13134 1.11518 1.09278 1.09302 1.09091 1.08333 1 1

tree_stats_height=52
tree_stats_numInternals=656390
tree_stats_numLeaves=342480
tree_stats_numNodes=998870
tree_stats_numKeys=998870

tree_stats_avgDegreeInternal=1.52176
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34287
tree_stats_avgKeyDepth=25.7723

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:3 8:819 16:34214 32:3988
    (2^02, 2^03]: 3
    (2^03, 2^04]: 819
    (2^04, 2^05]: 34214
    (2^05, 2^06]: 3988
sum_limbo_reclamation_event_size_total=983875
count_limbo_reclamation_event_size_by_thread=271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271 271
count_limbo_reclamation_event_size_total=39024
sum_limbo_reclamation_event_count_total=39449
first_thread_announced_epoch_by_thread=580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580 580
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=37701099
sum_fasthtm_abort_total=86494958
sum_htmpostfix_commit_total=1968751
sum_htmpostfix_abort_total=1389965
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=45841279
sum_stmprefix_commit_total=2049
sum_slow_commit_total=10801
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=13562 11370 13437 13332 13442 13508 14110 11412 13536 13490 13101 13017 13876 11443 13812 13406 12986 13299 14043 10949 13586 13431 13266 13060 14029 11250 13377 13428 13529 13246 14186 11517 13395 13506 13043 13266 14033 11355 13822 13498 13117 13306 13879 10830 13314 13367 13155 13146 14602 11362 14202 13892 13943 13631 14570 11622 14333 13987 14093 14021 14730 11697 13962 13942 13698 13629 14573 11234 14034 13947 13722 13938 14835 11332 14118 13775 13722 13259 14514 11599 14344 13762 13937 14047 14754 11599 14045 13930 13717 13565 14641 11414 14229 13957 13764 13932 15854 12438 14731 14713 14810 14518 15645 12512 15065 15121 15182 14591 15820 12610 14856 15094 14586 14448 15666 12375 14920 14903 14778 14627 15742 12435 14775 14804 14918 14511 15690 12728 14983 15183 14886 14733 15992 12227 14980 15184 14586 14372 15622 12405 14859 14608 14753 14641
sum_num_inserts_total=1982703
sum_num_deletes_by_thread=13813 11422 13442 13345 13567 13401 14292 11466 13357 13666 13231 13310 13986 11466 13887 13567 13423 13182 13957 10973 13320 13532 12992 12930 14022 11335 13552 13451 13621 13340 14290 11498 13337 13615 13312 13511 14095 11346 13426 13434 13307 13302 13948 10902 13344 13314 13189 13073 14741 11537 14207 14132 13977 13593 14602 11555 14055 14237 13957 13918 14772 11617 13861 13985 13653 13996 14473 11308 13815 13919 13660 14113 14853 11320 14037 13826 13674 13562 14606 11607 13986 14029 13928 14101 14834 11519 14107 13723 13588 13506 14396 11325 14068 14066 13563 14129 15630 12164 14868 14599 15044 14590 15549 12726 15151 15087 14842 14383 15814 12481 14790 14761 14649 14410 15947 12254 14855 14867 14598 14635 15832 11981 14759 14737 14919 14336 15790 12540 14894 14960 15094 14762 16261 12483 14641 15183 14641 14489 15546 12619 14782 14851 14656 14568
sum_num_deletes_total=1983145
sum_num_searches_by_thread=247510 205983 238672 241660 240254 242553 255553 208149 242406 241390 237683 238440 249974 205436 252369 241561 239501 236660 248856 193816 240115 240975 235998 232590 254116 203842 240495 242396 243514 242754 256620 205903 240545 245147 237188 240752 251884 204243 244584 240648 236949 240404 248418 195179 242460 241104 233948 236831 266401 205521 257553 254461 251376 246005 262097 207964 253912 254579 252983 250010 267435 210314 251320 251178 245567 247629 264652 200768 251889 251307 247348 253585 269169 203640 251665 249379 244891 242276 259931 206875 255576 250819 249122 253135 267923 206605 255156 247022 248701 248793 260523 204960 258268 254425 247091 256373 283462 222164 266462 265715 271456 261011 283569 228187 275184 273068 271258 262674 282612 226364 264970 268808 263465 262136 284725 221782 270214 266605 267429 261852 285830 218553 266239 265922 266345 260486 281818 227232 267936 273366 270946 265035 292495 221651 268974 269532 263975 258317 280254 222906 263793 265273 264941 263661
sum_num_searches_total=35716852
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=274885 228775 265551 268337 267263 269462 283955 231027 269299 268546 264015 264767 277836 228345 280068 268534 265910 263141 276856 215738 267021 267938 262256 258580 282167 226427 267424 269275 270664 269340 285096 228918 267277 272268 263543 267529 280012 226944 271832 267580 263373 267012 276245 216911 269118 267785 260292 263050 295744 228420 285962 282485 279296 273229 291269 231141 282300 282803 281033 277949 296937 233628 279143 279105 272918 275254 293698 223310 279738 279173 274730 281636 298857 226292 279820 276980 272287 269097 289051 230081 283906 278610 276987 281283 297511 229723 283308 274675 276006 275864 289560 227699 286565 282448 274418 284434 314946 246766 296061 295027 301310 290119 314763 253425 305400 303276 301282 291648 314246 251455 294616 298663 292700 290994 316338 246411 299989 296375 296805 291114 317404 242969 295773 295463 296182 289333 313298 252500 297813 303509 300926 294530 324748 246361 298595 299899 293202 287178 311422 247930 293434 294732 294350 292870
average_num_operations_total=275574
stdev_num_operations_total=1950
sum_num_operations_total=39682700
min_num_operations_total=215738
max_num_operations_total=324748
first_time_thread_terminate_by_thread=10000482 10000407 10000330 10000218 10000235 10000171 10000305 10000169 10000256 10000355 10000353 10000366 10000399 10000185 10000171 10000234 10000452 10000400 10000346 10000472 10000212 10000474 10000211 10000170 10000171 10000477 10000400 10000296 10000410 10000409 10000390 10000249 10000305 10000216 10000302 10000425 10000302 10000344 10000216 10000243 10000364 10000205 10000206 10000499 10000407 10000404 10000267 10000402 10000476 10000471 10000289 10000381 10000484 10000390 10000349 10000353 10000267 10000467 10000418 10000364 10000450 10000465 10000308 10000217 10000286 10000418 10000461 10000472 10000398 10000380 10000356 10000181 10000349 10000449 10000233 10000393 10000177 10000323 10000322 10000346 10000234 10000254 10000425 10000330 10000416 10000342 10000306 10000305 10000348 10000384 10000465 10000470 10000174 10000295 10000290 10000342 10000188 10000491 10000188 10000496 10000308 10000244 10000486 10000413 10000483 10000174 10000446 10000495 10000391 10000487 10000380 10000214 10000468 10000396 10000278 10000479 10000459 10000478 10000400 10000483 10000366 10000492 10000437 10000497 10000423 10000327 10000490 10000186 10000421 10000422 10000187 10000477 10000494 10000488 10000348 10000186 10000442 10000268 10000468 10000266 10000435 10000450 10000360 10000460
min_time_thread_terminate_total=10000169
max_time_thread_terminate_total=10000499
first_time_thread_start_by_thread=9 5 4 5 5 5 5 5 4 4 5 5 5 4 4 4 5 4 5 5 4 5 4 5 4 5 4 5 5 5 5 5 4 4 5 5 5 4 4 4 5 4 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 6 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 6 5 5
min_time_thread_start_total=4
max_time_thread_start_total=9
sum_duration_all_ops_total=

threads_final_keysum=998679318786
threads_final_size=998870
final_keysum=998679318786
final_size=998870
validate_result=success
Validation OK.
Structural validation OK.

total_find=35716852
total_rq=0
total_inserts=1982703
total_deletes=1983145
total_updates=3965848
total_queries=35716852
total_ops=39682700
find_throughput=3571685
rq_throughput=0
update_throughput=396584
query_throughput=3571685
total_throughput=3968270


total find                    : 35716852
total rq                      : 0
total inserts                 : 1982703
total deletes                 : 1983145
total updates                 : 3965848
total queries                 : 35716852
total ops                     : 39682700
find throughput               : 3571685
rq throughput                 : 0
update throughput             : 396584
query throughput              : 3571685
total throughput              : 3968270

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=28.6783
PAPI_L3_TCM=7.30956
PAPI_TOT_CYC=93287
PAPI_TOT_INS=3985.55
garbage=17716297634770
total_execution_walltime=17.589s
REALTIME_MAIN_END_PERF_FORMAT=6997403.2295785
RH noREC w/postfix htm system shutdown:
    HTM_ATTEMPT_THRESH=40
[time_cmd_output] time_elapsed_sec=17.74, faults_major=0, faults_minor=113803, mem_maxresident_kb=451612, user_cputime=2456.32, sys_cputime=24.82, percent_cpu=13980%
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