__step=000235
__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=data000235.txt
__path_data=data/data000235.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6997351.588371402
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.018s
prefilling_size=204659 prefilling_elapsed_millis=1.001s
prefilling_size=222679 prefilling_elapsed_millis=1.101s
prefilling_size=240425 prefilling_elapsed_millis=1.201s
prefilling_size=257723 prefilling_elapsed_millis=1.301s
prefilling_size=274854 prefilling_elapsed_millis=1.402s
prefilling_size=291283 prefilling_elapsed_millis=1.502s
prefilling_size=307300 prefilling_elapsed_millis=1.602s
prefilling_size=322893 prefilling_elapsed_millis=1.702s
prefilling_size=338241 prefilling_elapsed_millis=1.802s
prefilling_size=353395 prefilling_elapsed_millis=1.903s
prefilling_size=368000 prefilling_elapsed_millis=2.003s
prefilling_size=382303 prefilling_elapsed_millis=2.103s
prefilling_size=396461 prefilling_elapsed_millis=2.203s
prefilling_size=409864 prefilling_elapsed_millis=2.303s
prefilling_size=423054 prefilling_elapsed_millis=2.404s
prefilling_size=436016 prefilling_elapsed_millis=2.504s
prefilling_size=448824 prefilling_elapsed_millis=2.604s
prefilling_size=461317 prefilling_elapsed_millis=2.704s
prefilling_size=473534 prefilling_elapsed_millis=2.804s
prefilling_size=485754 prefilling_elapsed_millis=2.905s
prefilling_size=497277 prefilling_elapsed_millis=3.005s
prefilling_size=508813 prefilling_elapsed_millis=3.105s
prefilling_size=519788 prefilling_elapsed_millis=3.205s
prefilling_size=530423 prefilling_elapsed_millis=3.305s
prefilling_size=541165 prefilling_elapsed_millis=3.406s
prefilling_size=551395 prefilling_elapsed_millis=3.506s
prefilling_size=561675 prefilling_elapsed_millis=3.606s
prefilling_size=571720 prefilling_elapsed_millis=3.706s
prefilling_size=581239 prefilling_elapsed_millis=3.806s
prefilling_size=590881 prefilling_elapsed_millis=3.907s
prefilling_size=600110 prefilling_elapsed_millis=4.007s
prefilling_size=609250 prefilling_elapsed_millis=4.107s
prefilling_size=618131 prefilling_elapsed_millis=4.207s
prefilling_size=626676 prefilling_elapsed_millis=4.307s
prefilling_size=635142 prefilling_elapsed_millis=4.408s
prefilling_size=643246 prefilling_elapsed_millis=4.508s
prefilling_size=651373 prefilling_elapsed_millis=4.608s
prefilling_size=659405 prefilling_elapsed_millis=4.708s
prefilling_size=666998 prefilling_elapsed_millis=4.809s
prefilling_size=674658 prefilling_elapsed_millis=4.909s
prefilling_size=682020 prefilling_elapsed_millis=5.009s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 317931 keys with 96 threads...
tid=0 thread_prefill_amount=8332 percent_done_estimate=251.6 elapsed_s=5 est_remaining_s=-7 / -2
tid=0 thread_prefill_amount=10415 percent_done_estimate=314.5 elapsed_s=6 est_remaining_s=-10 / -3
timing_elapsed 1.34853s
prefilling_size=1000000 prefilling_elapsed_millis=1.351s
finished prefilling to size 1000000 for expected size 1000000 keysum=1000280997197, performing 2849495 updates; total_prefilling_elapsed_ms=1351 ms)
pref_size=1000000
pref_millis=1351
prefill_elapsed_ms=1351
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=38

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6997358.272156610
REALTIME_END_PERF_FORMAT=6997368.272329483

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

tree_stats_computeWalltime=0.026s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 119 228 435 776 1370 2293 3597 5457 7952 11113 15152 19912 25275 30908 36285 40876 44644 47328 48495 48234 46119 42570 38180 32841 27381 22060 16968 12717 9105 6434 4395 2793 1749 1045 602 331 165 71 22 9 4 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 5 8 9 57 98 251 526 944 1601 2596 3767 5603 7728 10448 13491 16640 19480 22206 24311 25510 26257 26035 24446 22788 19905 17178 14069 10960 8440 6093 4358 3137 1968 1280 771 443 257 138 61 16 5 3 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 124 236 444 833 1468 2544 4123 6401 9553 13709 18919 25515 33003 41356 49776 57516 64124 69534 72806 73744 72376 68605 62626 55629 47286 39238 31037 23677 17545 12527 8753 5930 3717 2325 1373 774 422 209 83 25 9 4 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 124 236 444 833 1468 2544 4123 6401 9553 13709 18919 25515 33003 41356 49776 57516 64124 69534 72806 73744 72376 68605 62626 55629 47286 39238 31037 23677 17545 12527 8753 5930 3717 2325 1373 774 422 209 83 25 9 4 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.9375 1.94355 1.91525 1.8964 1.83073 1.79973 1.71934 1.68009 1.6399 1.60264 1.56941 1.54776 1.51307 1.48726 1.45623 1.42653 1.4042 1.38815 1.36641 1.3468 1.32738 1.31068 1.29234 1.27862 1.25967 1.25075 1.22878 1.21616 1.20391 1.19504 1.18512 1.17537 1.15582 1.15496 1.14108 1.12527 1.11757 1.10427 1.05742 1.03614 1 1 1 1

tree_stats_height=50
tree_stats_numInternals=656138
tree_stats_numLeaves=343888
tree_stats_numNodes=1000026
tree_stats_numKeys=1000026

tree_stats_avgDegreeInternal=1.52411
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34388
tree_stats_avgKeyDepth=25.8792

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:20 2:41 4:448 8:27427 16:37041 32:8
    [2^00, 2^01]: 20
    (2^01, 2^02]: 41
    (2^02, 2^03]: 448
    (2^03, 2^04]: 27427
    (2^04, 2^05]: 37041
    (2^05, 2^06]: 8
sum_limbo_reclamation_event_size_total=1056364
count_limbo_reclamation_event_size_by_thread=677 677 677 677 676 677 677 677 677 677 677 677 676 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 676 677 677 677 677 676 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 677 676 676 677 677 677 677 677 677 677 676 677 677 677 677 677
count_limbo_reclamation_event_size_total=64985
sum_limbo_reclamation_event_count_total=65272
first_thread_announced_epoch_by_thread=1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434 1434
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=40270398
sum_fasthtm_abort_total=90612523
sum_htmpostfix_commit_total=2101163
sum_htmpostfix_abort_total=2095999
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=43253178
sum_stmprefix_commit_total=5816
sum_slow_commit_total=17437
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=22428 18067 21613 21536 21658 21027 23300 18174 22108 22129 22294 22319 23189 18185 22042 21983 21721 22417 23033 18071 22226 21890 22043 21765 22446 18178 21756 21249 21532 21213 23578 17808 22498 22745 22081 22092 23382 18215 21923 22023 21855 21875 22757 18252 22179 21753 22043 21949 24116 18649 23143 22931 22635 22914 24816 19829 23213 23191 23306 23332 24500 19854 22820 23088 22869 22219 24324 19044 23438 24057 23585 23251 23853 18820 23038 22665 23033 23054 24493 19624 23450 22999 22999 23056 24950 19933 23280 23207 22706 22902 24304 18970 23363 22798 23636 23192
sum_num_inserts_total=2120049
sum_num_deletes_by_thread=22385 17816 21821 21372 21622 21456 23394 18280 22102 22186 22316 22053 23109 18032 22289 21852 21945 22456 23154 18023 22268 21853 22135 21719 22541 18079 21814 21358 21774 21547 23473 18007 22447 22787 21983 22030 23380 18371 21952 22215 21862 21834 23387 18218 22228 21755 22368 22082 24035 18638 22795 23148 22560 22865 24916 19858 23524 23111 23060 22977 24685 19912 23173 23212 22688 22339 24661 19126 23169 24111 23119 23169 24100 18723 23245 22743 23012 22812 24419 19597 23324 23181 22982 23037 24540 19860 23104 22875 22484 22765 24033 19295 23104 22711 23393 23257
sum_num_deletes_total=2120577
sum_num_searches_by_thread=406725 322435 390498 385502 388919 382960 423838 329182 401621 398380 396944 395844 414601 324989 399810 395679 390549 405970 413372 326989 403328 392925 395567 388534 405727 322432 392808 383502 388955 381442 420182 323498 405241 411611 396776 397370 420422 329279 393523 401467 393935 393856 413482 329764 400093 388488 400646 397258 430446 336628 413752 415635 406583 413543 444597 358711 418484 414784 417485 416545 440078 356599 410558 420500 411057 398814 442655 345085 419358 437822 419838 416078 434851 341265 417529 411282 411731 411429 442165 351760 421079 413728 415157 417643 445101 356138 416341 415183 404147 410917 437834 345745 415129 407134 421351 416996
sum_num_searches_total=38154188
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=451538 358318 433932 428410 432199 425443 470532 365636 445831 442695 441554 440216 460899 361206 444141 439514 434215 450843 459559 363083 447822 436668 439745 432018 450714 358689 436378 426109 432261 424202 467233 359313 450186 457143 440840 441492 467184 365865 437398 445705 437652 437565 459626 366234 444500 431996 445057 441289 478597 373915 459690 461714 451778 459322 494329 398398 465221 461086 463851 462854 489263 396365 456551 466800 456614 443372 491640 383255 465965 485990 466542 462498 482804 378808 463812 456690 457776 457295 491077 390981 467853 459908 461138 463736 494591 395931 462725 461265 449337 456584 486171 384010 461596 452643 468380 463445
average_num_operations_total=441612
stdev_num_operations_total=3509
sum_num_operations_total=42394814
min_num_operations_total=358318
max_num_operations_total=494591
first_time_thread_terminate_by_thread=10000401 10000271 10000406 10000209 10000456 10000455 10000361 10000270 10000378 10000333 10000454 10000173 10000246 10000420 10000301 10000177 10000327 10000375 10000383 10000193 10000300 10000446 10000174 10000359 10000337 10000282 10000415 10000447 10000172 10000392 10000354 10000455 10000250 10000201 10000385 10000174 10000389 10000437 10000220 10000451 10000246 10000261 10000275 10000213 10000439 10000425 10000259 10000443 10000425 10000203 10000334 10000362 10000396 10000174 10000188 10000287 10000406 10000296 10000411 10000436 10000415 10000319 10000174 10000173 10000228 10000447 10000276 10000421 10000318 10000431 10000176 10000434 10000289 10000325 10000311 10000440 10000174 10000299 10000286 10000449 10000387 10000273 10000249 10000368 10000429 10000254 10000347 10000419 10000453 10000398 10000324 10000332 10000227 10000370 10000411 10000348
min_time_thread_terminate_total=10000172
max_time_thread_terminate_total=10000456
first_time_thread_start_by_thread=10 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 6 5 6 5 5 5 5 5 5 6 5 5 5 5 5 5 5 6 5 5 5 5 5 5 6 5 6 5 5 5 5 5 5 6 5 5 5 5 5 5 5 6 5 5 5 5 5
min_time_thread_start_total=4
max_time_thread_start_total=10
sum_duration_all_ops_total=

threads_final_keysum=1000337401148
threads_final_size=1000026
final_keysum=1000337401148
final_size=1000026
validate_result=success
Validation OK.
Structural validation OK.

total_find=38154188
total_rq=0
total_inserts=2120049
total_deletes=2120577
total_updates=4240626
total_queries=38154188
total_ops=42394814
find_throughput=3815418
rq_throughput=0
update_throughput=424062
query_throughput=3815418
total_throughput=4239481


total find                    : 38154188
total rq                      : 0
total inserts                 : 2120049
total deletes                 : 2120577
total updates                 : 4240626
total queries                 : 38154188
total ops                     : 42394814
find throughput               : 3815418
rq throughput                 : 0
update throughput             : 424062
query throughput              : 3815418
total throughput              : 4239481

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=26.7102
PAPI_L3_TCM=6.04075
PAPI_TOT_CYC=58043.6
PAPI_TOT_INS=3991.88
garbage=19081106599883
total_execution_walltime=16.828s
REALTIME_MAIN_END_PERF_FORMAT=6997368.417792040
RH noREC w/postfix htm system shutdown:
    HTM_ATTEMPT_THRESH=40
[time_cmd_output] time_elapsed_sec=16.96, faults_major=0, faults_minor=113784, mem_maxresident_kb=453884, user_cputime=1569.62, sys_cputime=21.00, percent_cpu=9373%
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