__step=000452 __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 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000452.txt __path_data=data/data000452.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=7000246.805421493 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=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.012s prefilling_size=94145 prefilling_elapsed_millis=1.001s prefilling_size=95691 prefilling_elapsed_millis=1.101s prefilling_size=96831 prefilling_elapsed_millis=1.201s prefilling_size=97563 prefilling_elapsed_millis=1.301s prefilling_size=98593 prefilling_elapsed_millis=1.401s finished prefilling to size 98613 for expected size 100000 keysum=9876984756, performing 799643 updates; total_prefilling_elapsed_ms=1503 ms) pref_size=98613 pref_millis=1503 prefill_elapsed_ms=1525 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=10 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=7000248.604708264 REALTIME_END_PERF_FORMAT=7000258.604788809 ############################################################################### ################################## 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 (192 threads)... partitioned into 821 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.032s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 125 236 436 758 1250 1921 2820 3797 4872 5909 6553 6755 6424 5658 4876 3990 3052 2253 1517 954 558 322 186 99 35 12 4 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 3 12 23 63 150 312 539 992 1429 2060 2877 3385 3743 3780 3416 3022 2536 2018 1563 1084 694 423 229 149 86 27 10 4 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 248 459 821 1400 2233 3359 4789 6301 7969 9430 10140 10167 9438 8292 7012 5588 4271 3080 2038 1252 745 415 248 121 39 14 4 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 248 459 821 1400 2233 3359 4789 6301 7969 9430 10140 10167 9438 8292 7012 5588 4271 3080 2038 1252 745 415 248 121 39 14 4 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.96094 1.89919 1.83878 1.78197 1.70214 1.64398 1.58619 1.52286 1.49151 1.44184 1.38038 1.33649 1.29645 1.27908 1.2576 1.2279 1.21815 1.19363 1.16916 1.14622 1.14936 1.12483 1.1494 1.08871 1.03306 1.05128 1 1 tree_stats_height=35 tree_stats_numInternals=65499 tree_stats_numLeaves=34629 tree_stats_numNodes=100128 tree_stats_numKeys=100128 tree_stats_avgDegreeInternal=1.5287 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.34585 tree_stats_avgKeyDepth=18.8229 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=852 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:3 4:360 8:35028 16:45241 32:8 (2^01, 2^02]: 3 (2^02, 2^03]: 360 (2^03, 2^04]: 35028 (2^04, 2^05]: 45241 (2^05, 2^06]: 8 sum_limbo_reclamation_event_size_total=1303674 count_limbo_reclamation_event_size_by_thread=840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 840 count_limbo_reclamation_event_size_total=80640 sum_limbo_reclamation_event_count_total=80832 first_thread_announced_epoch_by_thread=1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 1704 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=49754170 sum_fasthtm_abort_total=105693511 sum_htmpostfix_commit_total=2577832 sum_htmpostfix_abort_total=2936629 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=51963721 sum_stmprefix_commit_total=851 sum_slow_commit_total=19642 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=26610 27109 26885 27707 27528 28230 26959 27319 27285 28204 27865 28360 26480 26853 27139 27923 27456 29127 26998 26984 27439 27276 27438 28453 27206 26918 26882 27810 27518 28231 27097 27116 27342 28456 27903 28293 27120 26744 27196 27774 27209 28317 27308 26843 27239 27332 27741 28818 26544 26699 26381 27002 26480 26534 27261 26778 27309 27385 27002 28255 26988 26988 26575 26657 26535 28078 26603 26357 26950 26653 27034 28583 26643 26630 26712 26984 26626 26887 27021 27519 27257 27913 26924 28189 26898 26668 26544 26576 26652 28043 26594 26497 27466 26722 26641 28725 sum_num_inserts_total=2617002 sum_num_deletes_by_thread=27382 26894 27092 27736 27379 28281 26623 27251 27354 28389 27588 28358 26862 27010 27125 27884 27193 28669 27440 26995 27375 26947 27473 28537 27082 27003 27051 27971 27700 27776 27083 26945 27457 28002 27945 28759 26850 26919 26796 27753 27185 28796 27341 26724 27123 27119 27665 28568 26589 26482 26197 27378 26434 26511 27349 27089 26911 27794 26684 28675 26918 26986 26540 26961 26625 28402 26749 26407 27099 26413 27104 28738 26637 26543 26725 27249 26728 26795 27274 26745 27306 27788 27036 28169 27047 26478 26728 26642 26621 28196 27157 26478 27305 26668 27034 28358 sum_num_deletes_total=2618192 sum_num_searches_by_thread=484704 484149 487506 496556 493750 510967 480285 488309 494443 510972 498517 509574 476629 483369 486786 505958 488408 513454 491539 486327 491839 488542 495527 510390 488187 485650 486207 500461 499382 503989 487794 488107 495316 511217 503982 513177 487565 486558 483786 501099 492834 514381 493681 483711 489804 487004 499466 515310 479526 477537 474376 490089 480684 477557 488846 480955 486153 497394 479630 512213 487796 487173 481747 481194 479401 509447 479961 475433 489368 478827 483555 516272 477589 476405 480137 487865 480603 485671 488096 486901 490746 505043 485932 509150 486734 479255 476452 480544 480690 505018 483511 473652 493032 480241 482778 508954 sum_num_searches_total=47117301 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=538696 538152 541483 551999 548657 567478 533867 542879 549082 567565 553970 566292 529971 537232 541050 561765 543057 571250 545977 540306 546653 542765 550438 567380 542475 539571 540140 556242 554600 559996 541974 542168 550115 567675 559830 570229 541535 540221 537778 556626 547228 571494 548330 537278 544166 541455 554872 572696 532659 530718 526954 544469 533598 530602 543456 534822 540373 552573 533316 569143 541702 541147 534862 534812 532561 565927 533313 528197 543417 531893 537693 573593 530869 529578 533574 542098 533957 539353 542391 541165 545309 560744 539892 565508 540679 532401 529724 533762 533963 561257 537262 526627 547803 533631 536453 566037 average_num_operations_total=545338 stdev_num_operations_total=1293 sum_num_operations_total=52352495 min_num_operations_total=526627 max_num_operations_total=573593 first_time_thread_terminate_by_thread=10000305 10000324 10000308 10000086 10000314 10000335 10000181 10000279 10000094 10000328 10000291 10000141 10000259 10000340 10000144 10000344 10000316 10000092 10000079 10000192 10000238 10000288 10000295 10000080 10000167 10000156 10000312 10000206 10000231 10000318 10000268 10000096 10000345 10000254 10000088 10000246 10000188 10000326 10000348 10000134 10000092 10000342 10000079 10000080 10000150 10000163 10000263 10000132 10000301 10000215 10000095 10000223 10000299 10000218 10000167 10000241 10000280 10000309 10000266 10000329 10000296 10000161 10000215 10000270 10000273 10000340 10000341 10000332 10000084 10000147 10000192 10000293 10000217 10000197 10000184 10000290 10000161 10000270 10000237 10000186 10000226 10000243 10000319 10000304 10000183 10000198 10000245 10000346 10000225 10000140 10000257 10000348 10000267 10000200 10000084 10000337 min_time_thread_terminate_total=10000079 max_time_thread_terminate_total=10000348 first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 min_time_thread_start_total=3 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=10010076001 threads_final_size=100128 final_keysum=10010076001 final_size=100128 validate_result=success Validation OK. Structural validation OK. total_find=47117301 total_rq=0 total_inserts=2617002 total_deletes=2618192 total_updates=5235194 total_queries=47117301 total_ops=52352495 find_throughput=4711730 rq_throughput=0 update_throughput=523519 query_throughput=4711730 total_throughput=5235249 total find : 47117301 total rq : 0 total inserts : 2617002 total deletes : 2618192 total updates : 5235194 total queries : 47117301 total ops : 52352495 find throughput : 4711730 rq throughput : 0 update throughput : 523519 query throughput : 4711730 total throughput : 5235249 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=20.1666 PAPI_L3_TCM=4.34418 PAPI_TOT_CYC=46431 PAPI_TOT_INS=3105.33 garbage=2354684145330 total_execution_walltime=11.975s REALTIME_MAIN_END_PERF_FORMAT=7000258.795667969 RH noREC w/postfix htm system shutdown: HTM_ATTEMPT_THRESH=40 [time_cmd_output] time_elapsed_sec=12.13, faults_major=0, faults_minor=94897, mem_maxresident_kb=377632, user_cputime=1115.55, sys_cputime=18.32, percent_cpu=9345% 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