__step=000236
__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 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000236.txt
__path_data=data/data000236.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6997368.636135655
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=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.013s
prefilling_size=225775 prefilling_elapsed_millis=1.001s
prefilling_size=245129 prefilling_elapsed_millis=1.101s
prefilling_size=264217 prefilling_elapsed_millis=1.201s
prefilling_size=282800 prefilling_elapsed_millis=1.301s
prefilling_size=300834 prefilling_elapsed_millis=1.401s
prefilling_size=318236 prefilling_elapsed_millis=1.502s
prefilling_size=335287 prefilling_elapsed_millis=1.602s
prefilling_size=351803 prefilling_elapsed_millis=1.702s
prefilling_size=367920 prefilling_elapsed_millis=1.802s
prefilling_size=383726 prefilling_elapsed_millis=1.902s
prefilling_size=399377 prefilling_elapsed_millis=2.003s
prefilling_size=414431 prefilling_elapsed_millis=2.103s
prefilling_size=428940 prefilling_elapsed_millis=2.203s
prefilling_size=443213 prefilling_elapsed_millis=2.303s
prefilling_size=457023 prefilling_elapsed_millis=2.403s
prefilling_size=470627 prefilling_elapsed_millis=2.504s
prefilling_size=483680 prefilling_elapsed_millis=2.604s
prefilling_size=496297 prefilling_elapsed_millis=2.704s
prefilling_size=508815 prefilling_elapsed_millis=2.804s
prefilling_size=520914 prefilling_elapsed_millis=2.904s
prefilling_size=533116 prefilling_elapsed_millis=3.005s
prefilling_size=544554 prefilling_elapsed_millis=3.105s
prefilling_size=555816 prefilling_elapsed_millis=3.205s
prefilling_size=566788 prefilling_elapsed_millis=3.305s
prefilling_size=577570 prefilling_elapsed_millis=3.405s
prefilling_size=587882 prefilling_elapsed_millis=3.506s
prefilling_size=598118 prefilling_elapsed_millis=3.606s
prefilling_size=608117 prefilling_elapsed_millis=3.706s
prefilling_size=617548 prefilling_elapsed_millis=3.806s
prefilling_size=626856 prefilling_elapsed_millis=3.906s
prefilling_size=636167 prefilling_elapsed_millis=4.007s
prefilling_size=645113 prefilling_elapsed_millis=4.107s
prefilling_size=654073 prefilling_elapsed_millis=4.207s
prefilling_size=663015 prefilling_elapsed_millis=4.307s
prefilling_size=671261 prefilling_elapsed_millis=4.407s
prefilling_size=679207 prefilling_elapsed_millis=4.508s
prefilling_size=687239 prefilling_elapsed_millis=4.608s
prefilling_size=694927 prefilling_elapsed_millis=4.708s
prefilling_size=702360 prefilling_elapsed_millis=4.808s
prefilling_size=709554 prefilling_elapsed_millis=4.908s
prefilling_size=716732 prefilling_elapsed_millis=5.009s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 283209 keys with 96 threads...
tid=0 thread_prefill_amount=8332 percent_done_estimate=282.4 elapsed_s=6 est_remaining_s=-8 / -2
timing_elapsed 1.07528s
prefilling_size=1000000 prefilling_elapsed_millis=1.077s
finished prefilling to size 1000000 for expected size 1000000 keysum=999507815816, performing 3053140 updates; total_prefilling_elapsed_ms=1077 ms)
pref_size=1000000
pref_millis=1077
prefill_elapsed_ms=1078
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=40

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6997375.56154723
REALTIME_END_PERF_FORMAT=6997385.56311425

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

tree_stats_computeWalltime=0.015s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 63 125 245 463 848 1529 2654 4366 6907 10387 14925 20650 27127 34009 40552 46463 51104 54102 54936 53092 48780 42995 36155 29282 22759 17008 12344 8471 5426 3381 1960 1126 594 282 140 59 21 4 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 1 0 3 16 45 91 229 500 951 1913 3159 4919 7573 10725 14597 18362 22175 25364 28000 29990 30168 28497 26085 22455 18620 14928 11175 8382 5976 3844 2463 1435 826 466 211 111 48 19 4 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 125 248 479 893 1620 2883 4866 7858 12300 18084 25569 34700 44734 55149 64825 73279 79466 82936 83082 78948 71492 62240 51737 41379 31936 23519 16853 11402 7225 4423 2561 1420 748 351 170 69 23 5 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 125 248 479 893 1620 2883 4866 7858 12300 18084 25569 34700 44734 55149 64825 73279 79466 82936 83082 78948 71492 62240 51737 41379 31936 23519 16853 11402 7225 4423 2561 1420 748 351 170 69 23 5 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.96875 1.984 1.94355 1.8977 1.8645 1.8358 1.76726 1.71763 1.68631 1.62577 1.58859 1.54949 1.50741 1.47257 1.44013 1.41367 1.38704 1.36285 1.33937 1.31121 1.28768 1.26919 1.25035 1.23382 1.22178 1.20388 1.19172 1.17392 1.15778 1.14422 1.13588 1.1148 1.10845 1.09225 1.08547 1.05882 1.02899 1.04348 1 1

tree_stats_height=46
tree_stats_numInternals=655398
tree_stats_numLeaves=344327
tree_stats_numNodes=999725
tree_stats_numKeys=999725

tree_stats_avgDegreeInternal=1.52537
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34442
tree_stats_avgKeyDepth=24.3729

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:32 2:39 4:497 8:29983 16:40278 32:7
    [2^00, 2^01]: 32
    (2^01, 2^02]: 39
    (2^02, 2^03]: 497
    (2^03, 2^04]: 29983
    (2^04, 2^05]: 40278
    (2^05, 2^06]: 7
sum_limbo_reclamation_event_size_total=1149411
count_limbo_reclamation_event_size_by_thread=738 738 738 738 737 738 738 738 737 738 738 738 738 738 738 738 738 738 738 738 737 738 738 738 738 738 737 738 738 738 738 738 738 738 738 738 737 738 737 738 738 738 738 738 738 738 738 738 738 738 738 738 738 738 738 738 738 738 738 738 738 738 738 738 738 738 737 738 738 738 738 737 737 738 738 738 738 738 738 738 738 738 737 738 738 738 738 738 738 737 738 738 738 738 737 738
count_limbo_reclamation_event_size_total=70836
sum_limbo_reclamation_event_count_total=71126
first_thread_announced_epoch_by_thread=1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560 1560
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=43912659
sum_fasthtm_abort_total=96694963
sum_htmpostfix_commit_total=2284220
sum_htmpostfix_abort_total=2368059
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=47339438
sum_stmprefix_commit_total=2069
sum_slow_commit_total=19170
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=23937 23562 23816 24352 20352 25337 23982 24142 24738 23965 20703 25407 24052 23683 24698 24178 20629 25762 24171 24288 23935 24135 20411 25403 24303 24671 23882 23922 20346 24920 24532 24247 24352 24615 20995 26072 24296 23974 24461 24610 20802 25357 24259 23979 23909 23980 20706 25894 25713 25142 25228 25136 20300 20191 25667 24981 25035 25260 20596 26669 25543 25540 25061 25102 20055 26155 24820 24954 25726 24856 20582 26477 25063 24790 24993 25084 20380 20300 25173 25336 25910 25184 20480 26415 25442 25025 25148 25149 19732 26227 24829 24630 25209 24735 20515 26162
sum_num_inserts_total=2309422
sum_num_deletes_by_thread=23622 23482 24118 24399 20464 24931 24426 23954 24539 23878 20842 25565 24127 24039 24248 23843 20733 25500 24099 24027 24244 24323 20429 25248 24128 24292 23731 23898 20388 25076 24230 24515 24447 24909 20808 26106 23864 23906 24636 24651 20703 25531 24048 24166 24393 24293 20319 26014 25702 25105 25265 25206 20364 20277 25374 24894 25578 25045 20274 26815 25455 25485 25147 25032 20207 26121 24667 24727 25617 24882 20486 26283 25260 24931 25357 25258 20584 20238 25264 24794 25703 25169 20377 26772 25521 25015 24888 25057 19839 26108 24814 24578 25480 24884 20756 26225
sum_num_deletes_total=2309012
sum_num_searches_by_thread=425996 421894 431147 441511 365894 451226 434147 434819 443654 433544 377346 461221 434641 427283 440441 435163 373005 464823 436446 438543 437341 439481 368548 456217 437604 440445 428006 431991 366612 448301 438443 436873 440361 444990 377174 470863 433075 430131 437616 442216 373698 453655 436321 432009 431419 432286 370148 465960 460414 452908 455830 455786 364303 367211 461302 450828 451530 456561 368863 482522 461006 457349 452128 451954 363643 470276 450098 445994 459672 445368 371226 471113 452844 451668 454980 454010 369140 364895 453536 451607 465052 453130 367134 477153 462147 450424 449943 450837 355381 470624 449904 444393 457144 448430 371451 471444
sum_num_searches_total=41599684
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=473555 468938 479081 490262 406710 501494 482555 482915 492931 481387 418891 512193 482820 475005 489387 483184 414367 516085 484716 486858 485520 487939 409388 506868 486035 489408 475619 479811 407346 498297 487205 485635 489160 494514 418977 523041 481235 478011 486713 491477 415203 504543 484628 480154 479721 480559 411173 517868 511829 503155 506323 506128 404967 407679 512343 500703 502143 506866 409733 536006 512004 508374 502336 502088 403905 522552 499585 495675 511015 495106 412294 523873 503167 501389 505330 504352 410104 405433 503973 501737 516665 503483 407991 530340 513110 500464 499979 501043 394952 522959 499547 493601 507833 498049 412722 523831
average_num_operations_total=481438
stdev_num_operations_total=3817
sum_num_operations_total=46218118
min_num_operations_total=394952
max_num_operations_total=536006
first_time_thread_terminate_by_thread=10000370 10000390 10000343 10000155 10000394 10000155 10000398 10000342 10000403 10000157 10000389 10000188 10000218 10000402 10000302 10000377 10000226 10000359 10000221 10000391 10000384 10000157 10000155 10000239 10000353 10000209 10000189 10000311 10000369 10000331 10000218 10000334 10000401 10000351 10000272 10000395 10000316 10000288 10000155 10000396 10000309 10000163 10000336 10000397 10000388 10000157 10000386 10000264 10000373 10000312 10000355 10000368 10000378 10000301 10000199 10000242 10000298 10000376 10000321 10000205 10000154 10000381 10000329 10000154 10000370 10000364 10000235 10000211 10000205 10000274 10000301 10000393 10000343 10000183 10000179 10000343 10000157 10000399 10000195 10000380 10000178 10000155 10000301 10000280 10000273 10000177 10000154 10000158 10000319 10000246 10000227 10000248 10000234 10000266 10000153 10000179
min_time_thread_terminate_total=10000153
max_time_thread_terminate_total=10000403
first_time_thread_start_by_thread=9 6 5 5 5 5 6 5 5 5 5 5 6 5 5 5 5 5 5 5 5 5 5 5 4 6 5 5 5 5 6 5 5 5 5 5 6 5 5 5 5 5 5 5 5 5 5 5 6 6 6 6 6 5 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 5 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6
min_time_thread_start_total=4
max_time_thread_start_total=9
sum_duration_all_ops_total=

threads_final_keysum=999273270849
threads_final_size=999725
final_keysum=999273270849
final_size=999725
validate_result=success
Validation OK.
Structural validation OK.

total_find=41599684
total_rq=0
total_inserts=2309422
total_deletes=2309012
total_updates=4618434
total_queries=41599684
total_ops=46218118
find_throughput=4159968
rq_throughput=0
update_throughput=461843
query_throughput=4159968
total_throughput=4621811


total find                    : 41599684
total rq                      : 0
total inserts                 : 2309422
total deletes                 : 2309012
total updates                 : 4618434
total queries                 : 41599684
total ops                     : 46218118
find throughput               : 4159968
rq throughput                 : 0
update throughput             : 461843
query throughput              : 4159968
total throughput              : 4621811

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=27.2774
PAPI_L3_TCM=6.2418
PAPI_TOT_CYC=53048.6
PAPI_TOT_INS=3791.25
garbage=20790439192107
total_execution_walltime=16.553s
REALTIME_MAIN_END_PERF_FORMAT=6997385.190665749
RH noREC w/postfix htm system shutdown:
    HTM_ATTEMPT_THRESH=40
[time_cmd_output] time_elapsed_sec=16.70, faults_major=0, faults_minor=114925, mem_maxresident_kb=458244, user_cputime=1541.73, sys_cputime=22.15, percent_cpu=9359%
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