__step=000755 __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_chromatic_lf.debra -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000755.txt __path_data=data/data000755.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6988050.880626269 binary=./brown_ext_chromatic_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_chromatic_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=50 DEL_FRAC=50 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=50.0 50.0 PREFILL_TYPE=PREFILL_HYBRID PREFILL_HYBRID_MIN_MS=1000 PREFILL_HYBRID_MAX_MS=5000 sizes: node=56 descriptor=128 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.01s prefilling_size=6242995 prefilling_elapsed_millis=1.001s prefilling_size=6553550 prefilling_elapsed_millis=1.101s prefilling_size=6828194 prefilling_elapsed_millis=1.201s prefilling_size=7081521 prefilling_elapsed_millis=1.301s prefilling_size=7313615 prefilling_elapsed_millis=1.402s prefilling_size=7521135 prefilling_elapsed_millis=1.502s prefilling_size=7717965 prefilling_elapsed_millis=1.602s prefilling_size=7894484 prefilling_elapsed_millis=1.702s prefilling_size=8050606 prefilling_elapsed_millis=1.803s prefilling_size=8198945 prefilling_elapsed_millis=1.903s prefilling_size=8338472 prefilling_elapsed_millis=2.003s prefilling_size=8466825 prefilling_elapsed_millis=2.103s prefilling_size=8584403 prefilling_elapsed_millis=2.203s prefilling_size=8691252 prefilling_elapsed_millis=2.304s prefilling_size=8787821 prefilling_elapsed_millis=2.404s prefilling_size=8876700 prefilling_elapsed_millis=2.504s prefilling_size=8959865 prefilling_elapsed_millis=2.604s prefilling_size=9038103 prefilling_elapsed_millis=2.704s prefilling_size=9109217 prefilling_elapsed_millis=2.805s prefilling_size=9172474 prefilling_elapsed_millis=2.905s prefilling_size=9232355 prefilling_elapsed_millis=3.005s prefilling_size=9288350 prefilling_elapsed_millis=3.105s prefilling_size=9338646 prefilling_elapsed_millis=3.205s prefilling_size=9385429 prefilling_elapsed_millis=3.306s prefilling_size=9429166 prefilling_elapsed_millis=3.406s prefilling_size=9469782 prefilling_elapsed_millis=3.506s prefilling_size=9508997 prefilling_elapsed_millis=3.606s prefilling_size=9543868 prefilling_elapsed_millis=3.707s prefilling_size=9576231 prefilling_elapsed_millis=3.807s prefilling_size=9605217 prefilling_elapsed_millis=3.907s prefilling_size=9632155 prefilling_elapsed_millis=4.007s prefilling_size=9658699 prefilling_elapsed_millis=4.107s prefilling_size=9682315 prefilling_elapsed_millis=4.208s prefilling_size=9704706 prefilling_elapsed_millis=4.308s prefilling_size=9725979 prefilling_elapsed_millis=4.408s prefilling_size=9745036 prefilling_elapsed_millis=4.508s prefilling_size=9763391 prefilling_elapsed_millis=4.608s prefilling_size=9781126 prefilling_elapsed_millis=4.709s prefilling_size=9798526 prefilling_elapsed_millis=4.809s prefilling_size=9813890 prefilling_elapsed_millis=4.909s finished prefilling to size 9813910 for expected size 10000000 keysum=98147765345768, performing 79586418 updates; total_prefilling_elapsed_ms=5011 ms) pref_size=9813910 pref_millis=5011 prefill_elapsed_ms=5035 4NodeIxPvE_object_size=56 4NodeIxPvE_allocated_count=0 4NodeIxPvE_allocated_size=0MB 4NodeIxPvE_get_from_pool=0 4NodeIxPvE_deallocated=0 4NodeIxPvE_limbo_count=0 4NodeIxPvE_limbo_details=0 0 0 global_epoch_counter=1591 9SCXRecordIxPvE_object_size=128 9SCXRecordIxPvE_allocated_count=0 9SCXRecordIxPvE_allocated_size=0MB 9SCXRecordIxPvE_get_from_pool=0 9SCXRecordIxPvE_deallocated=0 9SCXRecordIxPvE_limbo_count=0 9SCXRecordIxPvE_limbo_details=0 0 0 global_epoch_counter=0 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6988056.132785362 REALTIME_END_PERF_FORMAT=6988066.132922924 ############################################################################### ################################## 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 1024 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.058s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32767 65517 130779 258400 492605 866275 1335546 1728283 1818083 1519392 987140 488602 180674 48958 9626 1346 110 9 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 17 255 3158 24195 118935 397004 942809 1638483 2116774 2051644 1485678 796530 312390 88290 17906 2582 211 18 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65534 131034 261558 516800 985210 1732550 2671092 3456566 3636166 3038784 1974280 977204 361348 97916 19252 2692 220 18 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 17 255 3158 24195 118935 397004 942809 1638483 2116774 2051644 1485678 796530 312390 88290 17906 2582 211 18 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99997 1.99974 1.99805 1.98793 1.95318 1.87928 1.77086 1.64703 1.52598 1.41786 1.32485 1.24748 1.18489 1.13549 1.09831 1.06991 1.04086 1.04091 1 tree_stats_height=34 tree_stats_numInternals=9996879 tree_stats_numLeaves=9996880 tree_stats_numNodes=19993759 tree_stats_numKeys=9996880 tree_stats_avgDegreeInternal=2 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.5 tree_stats_avgKeyDepth=24.3899 tree_stats_bytesAtDepth=56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917504 1835008 3669904 7337904 14647248 28940800 55171760 97022800 149581152 193567696 203625296 170171904 110559680 54723424 20235488 5483296 1078112 150752 12320 1008 tree_stats_sizeInBytes=1119650504 4NodeIxPvE_object_size=56 4NodeIxPvE_allocated_count=0 4NodeIxPvE_allocated_size=0MB 4NodeIxPvE_get_from_pool=0 4NodeIxPvE_deallocated=0 4NodeIxPvE_limbo_count=0 4NodeIxPvE_limbo_details=0 0 0 global_epoch_counter=4663 9SCXRecordIxPvE_object_size=128 9SCXRecordIxPvE_allocated_count=0 9SCXRecordIxPvE_allocated_size=0MB 9SCXRecordIxPvE_get_from_pool=0 9SCXRecordIxPvE_deallocated=0 9SCXRecordIxPvE_limbo_count=0 9SCXRecordIxPvE_limbo_details=0 0 0 global_epoch_counter=0 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:15398 2:10490 4:1673 8:3351 16:7380 32:23298 64:48770 128:91524 256:207330 512:147862 1024:352 2048:59 [2^00, 2^01]: 15398 (2^01, 2^02]: 10490 (2^02, 2^03]: 1673 (2^03, 2^04]: 3351 (2^04, 2^05]: 7380 (2^05, 2^06]: 23298 (2^06, 2^07]: 48770 (2^07, 2^08]: 91524 (2^08, 2^09]: 207330 (2^09, 2^10]: 147862 (2^10, 2^11]: 352 (2^11, 2^12]: 59 sum_limbo_reclamation_event_size_total=220280417 count_limbo_reclamation_event_size_by_thread=5790 5796 5819 5785 5828 5861 5851 5746 5786 5787 5779 5813 5801 5825 5786 5844 5855 5808 5799 5816 5801 5827 5899 5769 5795 5791 5852 5837 5864 5842 5815 5810 5786 5733 5845 5828 5842 5805 5853 5751 5756 5821 5832 5833 5798 5833 5794 5841 5797 5837 5777 5779 5789 5817 5805 5848 5762 5761 5758 5892 5837 5873 5805 5791 5826 5830 5845 5852 5815 5729 5816 5816 5808 5800 5751 5670 5773 5837 5826 5846 5753 5773 5802 5750 5845 5786 5817 5814 5761 5818 5849 5837 5768 5759 5783 5776 count_limbo_reclamation_event_size_total=557487 sum_limbo_reclamation_event_count_total=589684 first_thread_announced_epoch_by_thread=9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 9326 sum_num_inserts_by_thread=764136 768812 771777 763266 769011 759706 766243 760961 766337 770418 763848 759324 764694 771242 772141 767040 771589 757512 760133 764198 768165 770818 767957 751114 756046 759667 774311 768006 769482 759793 764440 768504 767742 767180 767851 760912 758720 770166 770049 765633 763924 769460 758887 765974 765670 770903 756603 760117 759940 764336 764895 762319 762077 760302 762145 767818 764187 764519 760285 772658 767807 768996 765052 762324 762287 756766 763747 763647 767062 756919 759928 762892 760461 766101 764748 757004 762873 757469 765684 775381 763203 769142 766329 763268 767185 769112 772085 767996 760546 761112 758760 764353 765609 763036 759492 754378 sum_num_inserts_total=73388717 sum_num_deletes_by_thread=764541 767781 772334 762855 769248 759874 766215 759240 766621 768970 764092 760368 767378 771555 769937 765238 771155 759594 758683 765653 767164 770771 767097 753005 758296 760318 772687 768108 769615 761430 763931 768044 767194 766884 766683 762571 758103 769135 769657 764580 761879 770950 758676 764301 765413 770141 757089 759282 759689 763461 764672 762609 762248 759046 764692 769233 764924 764337 761345 773896 767080 770071 765065 764860 761766 757344 764284 761473 767269 756598 759075 762830 759900 765394 764288 756424 761750 760307 762771 775393 762440 767490 768159 760106 767226 770656 772739 767781 761471 760184 759860 763391 766534 763028 758573 753481 sum_num_deletes_total=73381549 sum_num_searches_by_thread= sum_num_searches_total= sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=1528677 1536593 1544111 1526121 1538259 1519580 1532458 1520201 1532958 1539388 1527940 1519692 1532072 1542797 1542078 1532278 1542744 1517106 1518816 1529851 1535329 1541589 1535054 1504119 1514342 1519985 1546998 1536114 1539097 1521223 1528371 1536548 1534936 1534064 1534534 1523483 1516823 1539301 1539706 1530213 1525803 1540410 1517563 1530275 1531083 1541044 1513692 1519399 1519629 1527797 1529567 1524928 1524325 1519348 1526837 1537051 1529111 1528856 1521630 1546554 1534887 1539067 1530117 1527184 1524053 1514110 1528031 1525120 1534331 1513517 1519003 1525722 1520361 1531495 1529036 1513428 1524623 1517776 1528455 1550774 1525643 1536632 1534488 1523374 1534411 1539768 1544824 1535777 1522017 1521296 1518620 1527744 1532143 1526064 1518065 1507859 average_num_operations_total=1528856 stdev_num_operations_total=960 sum_num_operations_total=146770266 min_num_operations_total=1504119 max_num_operations_total=1550774 first_time_thread_terminate_by_thread=10000137 10000191 10000136 10000208 10000752 10000137 10000136 10000781 10000226 10000146 10000139 10000136 10000136 10000659 10000634 10000567 10000757 10000136 10000761 10000831 10000409 10000155 10000136 10000384 10000304 10000155 10000136 10000344 10000794 10000135 10000172 10000628 10000136 10000136 10000136 10000136 10000670 10000741 10000137 10000136 10000138 10000668 10000642 10000788 10000789 10000157 10000214 10000136 10000139 10000142 10000137 10000351 10000137 10000157 10000156 10000772 10000165 10000138 10000136 10000150 10000390 10000753 10000397 10000386 10000225 10000506 10000147 10000471 10000136 10000399 10000529 10000153 10000755 10000137 10000138 10000137 10000779 10000426 10000500 10000726 10000136 10000320 10000349 10000136 10000557 10000841 10000136 10000750 10000522 10000729 10000136 10000136 10000136 10000469 10000139 10000140 min_time_thread_terminate_total=10000135 max_time_thread_terminate_total=10000841 first_time_thread_start_by_thread=3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 4 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 4 3 3 3 3 3 4 4 3 3 3 4 3 3 3 3 3 3 4 4 4 4 3 3 3 3 4 3 3 3 4 4 3 3 3 4 3 3 3 3 3 3 3 4 4 4 3 3 3 3 4 min_time_thread_start_total=3 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=99946208362541 threads_final_size=9996880 final_keysum=99946208362541 final_size=9996880 validate_result=success Validation OK. Structural validation OK. total_find=0 total_rq=0 total_inserts=73388717 total_deletes=73381549 total_updates=146770266 total_queries=0 total_ops=146770266 find_throughput=0 rq_throughput=0 update_throughput=14677026 query_throughput=0 total_throughput=14677026 total find : 0 total rq : 0 total inserts : 73388717 total deletes : 73381549 total updates : 146770266 total queries : 0 total ops : 146770266 find throughput : 0 rq throughput : 0 update throughput : 14677026 query throughput : 0 total throughput : 14677026 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=79.746 PAPI_L3_TCM=35.1674 PAPI_TOT_CYC=17520.2 PAPI_TOT_INS=2454.27 garbage=0 total_execution_walltime=15.503s REALTIME_MAIN_END_PERF_FORMAT=6988066.385228164 [time_cmd_output] time_elapsed_sec=15.78, faults_major=0, faults_minor=614697, mem_maxresident_kb=2455544, user_cputime=1418.15, sys_cputime=14.94, percent_cpu=9076% timeout=false algorithm=brown_ext_chromatic_lf.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=1