__step=000004 __cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 60 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_ext_abtree_lf.debra -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000004.txt __path_data=data/data000004.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6978738.258441784 binary=./brown_ext_abtree_lf.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=brown_ext_abtree_lf 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=0.5 DEL_FRAC=0.5 RQ=0 RQSIZE=0 MAXKEY=20000000 PREFILL_THREADS=96 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=96 WORK_THREADS=96 RQ_THREADS=0 distribution=0 INS_DEL_FRAC=0.5 0.5 PREFILL_TYPE=PREFILL_HYBRID PREFILL_HYBRID_MIN_MS=1000 PREFILL_HYBRID_MAX_MS=5000 size_node=208 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 Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.011s prefilling_size=8745794 prefilling_elapsed_millis=1.001s prefilling_size=9002441 prefilling_elapsed_millis=1.101s prefilling_size=9206972 prefilling_elapsed_millis=1.201s prefilling_size=9372337 prefilling_elapsed_millis=1.301s prefilling_size=9500821 prefilling_elapsed_millis=1.402s prefilling_size=9598971 prefilling_elapsed_millis=1.502s prefilling_size=9680260 prefilling_elapsed_millis=1.602s prefilling_size=9747253 prefilling_elapsed_millis=1.702s prefilling_size=9796851 prefilling_elapsed_millis=1.802s prefilling_size=9839417 prefilling_elapsed_millis=1.903s finished prefilling to size 9839392 for expected size 10000000 keysum=98390102503984, performing 84867817 updates; total_prefilling_elapsed_ms=2004 ms) pref_size=9839392 pref_millis=2004 prefill_elapsed_ms=2026 N9abtree_ns4NodeILi11ExEE_object_size=208 N9abtree_ns4NodeILi11ExEE_allocated_count=0 N9abtree_ns4NodeILi11ExEE_allocated_size=0MB N9abtree_ns4NodeILi11ExEE_get_from_pool=0 N9abtree_ns4NodeILi11ExEE_deallocated=0 N9abtree_ns4NodeILi11ExEE_limbo_count=0 N9abtree_ns4NodeILi11ExEE_limbo_details=0 0 0 global_epoch_counter=1530 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6978740.512992329 REALTIME_END_PERF_FORMAT=6978750.513130043 ############################################################################### ################################## TIME IS UP ################################# ############################################################################### joining threads... ############################################################################### ################################# END RUNNING ################################# ############################################################################### 10s PRODUCING OUTPUT computing tree_stats in PARALLEL... bounded depth BFS to partition into subtrees for parallel computation (192 threads)... partitioned into 3589 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.064s tree_stats_numInternalsAtDepth=1 1 8 65 486 3589 26827 209345 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1651003 tree_stats_numNodesAtDepth=1 1 8 65 486 3589 26827 209345 1651003 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9908667 tree_stats_avgDegreeAtDepth=1 8 8.125 7.47692 7.38477 7.47478 7.80352 7.88652 6.0016 tree_stats_height=9 tree_stats_numInternals=240322 tree_stats_numLeaves=1651003 tree_stats_numNodes=1891325 tree_stats_numKeys=9908667 tree_stats_avgDegreeInternal=7.86996 tree_stats_avgDegreeLeaves=6.0016 tree_stats_avgDegree=6.23901 tree_stats_avgKeyDepth=8 tree_stats_bytesAtDepth=208 208 1664 13520 101088 746512 5580016 43543760 343408624 tree_stats_sizeInBytes=393395600 N9abtree_ns4NodeILi11ExEE_object_size=208 N9abtree_ns4NodeILi11ExEE_allocated_count=0 N9abtree_ns4NodeILi11ExEE_allocated_size=0MB N9abtree_ns4NodeILi11ExEE_get_from_pool=0 N9abtree_ns4NodeILi11ExEE_deallocated=0 N9abtree_ns4NodeILi11ExEE_limbo_count=0 N9abtree_ns4NodeILi11ExEE_limbo_details=0 0 0 global_epoch_counter=14970 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:41485 2:245310 4:548707 8:115077 16:382 32:105 [2^00, 2^01]: 41485 (2^01, 2^02]: 245310 (2^02, 2^03]: 548707 (2^03, 2^04]: 115077 (2^04, 2^05]: 382 (2^05, 2^06]: 105 sum_limbo_reclamation_event_size_total=4603105 count_limbo_reclamation_event_size_by_thread=9918 9899 9904 9893 9902 9888 9904 9911 9912 9903 9922 9899 9932 9894 9900 9922 9907 9909 9898 9904 9885 9906 9909 9926 9903 9909 9926 9898 9904 9913 9892 9902 9917 9893 9909 9908 9932 9907 9922 9914 9902 9910 9905 9896 9903 9906 9905 9901 9912 9920 9911 9897 9897 9889 9887 9931 9911 9900 9914 9899 9910 9898 9914 9908 9914 9906 9913 9908 9924 9922 9907 9899 9900 9892 9910 9911 9886 9902 9903 9912 9911 9898 9916 9913 9904 9897 9897 9899 9930 9907 9894 9906 9919 9907 9916 9921 count_limbo_reclamation_event_size_total=951066 sum_limbo_reclamation_event_count_total=1290240 first_thread_announced_epoch_by_thread=29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 29940 sum_num_inserts_by_thread=61620 62744 62691 62855 63131 61348 61689 62319 63129 62727 62115 61614 62782 62758 62618 62773 62447 61364 61425 61592 62881 62950 61932 61980 61168 61571 62855 62604 62515 61664 61536 62575 63093 62757 62531 62113 62194 62431 63124 62343 62679 61637 61468 62119 62693 62856 61520 61507 62841 62439 63282 63038 62725 62448 61911 62663 63339 63689 62184 62497 62594 62420 62266 63675 62800 61994 62317 63112 63278 63456 62307 62622 62083 62490 63401 62730 62891 62327 61603 62838 62955 63047 62874 62979 62882 62459 62809 63299 62658 61982 62362 62352 63628 63211 63032 62857 sum_num_inserts_total=6000683 sum_num_deletes_by_thread=62246 62599 62632 63009 63012 61862 61876 62390 63053 62822 62269 61977 62248 62850 62614 63110 62804 61641 61360 61729 62302 62436 61818 61952 61777 61915 62957 62752 62502 61972 61306 62133 62832 62984 62142 62366 62285 62506 62806 63054 63144 62108 61291 62037 62395 62734 61348 61418 62468 62345 63296 63396 62090 62044 62027 62463 63275 63473 61968 61832 62596 62745 62298 63738 62830 62629 61980 62819 63463 63736 62359 62885 61881 62134 62947 63191 62685 62169 61782 62928 63277 63156 62706 62742 61962 62418 62721 63209 62644 62177 61699 62687 63594 63785 63206 63179 sum_num_deletes_total=6001009 sum_num_searches_by_thread=12269523 12362437 12421542 12494166 12444533 12223174 12265957 12350291 12515805 12466638 12294517 12235062 12381960 12415010 12413734 12450775 12416555 12224214 12110372 12264334 12408207 12448365 12241316 12178010 12237167 12261343 12380782 12430451 12436215 12252868 12231417 12349243 12536326 12461968 12293388 12299647 12327256 12337516 12445462 12454476 12427180 12232855 12203683 12240585 12380356 12428248 12204421 12106765 12390314 12333173 12512661 12519000 12377750 12331286 12259042 12415058 12562501 12579690 12304011 12362913 12393748 12369143 12417745 12605959 12432744 12327910 12308889 12467780 12553249 12568327 12389205 12421220 12339538 12314166 12507285 12527460 12409123 12337268 12218569 12489814 12552747 12484676 12395459 12407671 12337271 12398753 12413637 12564199 12420169 12263146 12211785 12386718 12549217 12598589 12451077 12498522 sum_num_searches_total=1188536292 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=12393389 12487780 12546865 12620030 12570676 12346384 12389522 12475000 12641987 12592187 12418901 12358653 12506990 12540618 12538966 12576658 12541806 12347219 12233157 12387655 12533390 12573751 12365066 12301942 12360112 12384829 12506594 12555807 12561232 12376504 12354259 12473951 12662251 12587709 12418061 12424126 12451735 12462453 12571392 12579873 12553003 12356600 12326442 12364741 12505444 12553838 12327289 12229690 12515623 12457957 12639239 12645434 12502565 12455778 12382980 12540184 12689115 12706852 12428163 12487242 12518938 12494308 12542309 12733372 12558374 12452533 12433186 12593711 12679990 12695519 12513871 12546727 12463502 12438790 12633633 12653381 12534699 12461764 12341954 12615580 12678979 12610879 12521039 12533392 12462115 12523630 12539167 12690707 12545471 12387305 12335846 12511757 12676439 12725585 12577315 12624558 average_num_operations_total=12505604 stdev_num_operations_total=11678 sum_num_operations_total=1200537984 min_num_operations_total=12229690 max_num_operations_total=12733372 first_time_thread_terminate_by_thread=10000137 10000138 10000138 10000138 10000137 10000137 10000137 10000137 10000137 10000138 10000137 10000137 10000138 10000138 10000137 10000138 10000138 10000138 10000138 10000137 10000137 10000137 10000138 10000137 10000138 10000138 10000138 10000138 10000137 10000137 10000137 10000138 10000137 10000138 10000137 10000137 10000138 10000138 10000137 10000138 10000138 10000138 10000138 10000137 10000137 10000137 10000138 10000137 10000138 10000136 10000137 10000136 10000138 10000136 10000136 10000137 10000137 10000136 10000136 10000136 10000137 10000136 10000136 10000137 10000137 10000136 10000136 10000136 10000136 10000136 10000136 10000138 10000138 10000136 10000137 10000136 10000138 10000136 10000137 10000137 10000137 10000137 10000136 10000136 10000137 10000136 10000136 10000137 10000138 10000136 10000136 10000136 10000136 10000136 10000136 10000138 min_time_thread_terminate_total=10000136 max_time_thread_terminate_total=10000138 first_time_thread_start_by_thread=3 3 4 4 4 4 4 3 4 4 3 3 4 4 3 3 3 4 3 3 4 4 3 3 3 3 4 4 4 4 4 3 4 4 3 3 4 4 3 3 3 4 3 3 4 4 3 3 4 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 min_time_thread_start_total=3 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=99096441738084 threads_final_size=9908667 final_keysum=99096441738084 final_size=9908667 validate_result=success Validation OK. Structural validation OK. total_find=1188536292 total_rq=0 total_inserts=6000683 total_deletes=6001009 total_updates=12001692 total_queries=1188536292 total_ops=1200537984 find_throughput=118853629 rq_throughput=0 update_throughput=1200169 query_throughput=118853629 total_throughput=120053798 total find : 1188536292 total rq : 0 total inserts : 6000683 total deletes : 6001009 total updates : 12001692 total queries : 1188536292 total ops : 1200537984 find throughput : 118853629 rq throughput : 0 update throughput : 1200169 query throughput : 118853629 total throughput : 120053798 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=17.248 PAPI_L3_TCM=5.72692 PAPI_TOT_CYC=2214.59 PAPI_TOT_INS=382.034 garbage=5872790904910609 total_execution_walltime=12.427s REALTIME_MAIN_END_PERF_FORMAT=6978750.696081657 [time_cmd_output] time_elapsed_sec=12.59, faults_major=0, faults_minor=185254, mem_maxresident_kb=738212, user_cputime=1179.56, sys_cputime=3.06, percent_cpu=9392% timeout=false algorithm=brown_ext_abtree_lf.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=2