__step=000309 __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 144 -nprefill 144 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000309.txt __path_data=data/data000309.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6982494.165498244 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=0.5 DEL_FRAC=0.5 RQ=0 RQSIZE=0 MAXKEY=200000 PREFILL_THREADS=144 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=144 WORK_THREADS=144 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 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,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,64,65,66,67,68,69,70,71,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167 Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.041s prefilling_size=100058 prefilling_elapsed_millis=1s finished prefilling to size 100003 for expected size 100000 keysum=9983336023, performing 28281064 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=100003 pref_millis=1102 prefill_elapsed_ms=1124 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=576 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=6982495.564153703 REALTIME_END_PERF_FORMAT=6982505.564229102 ############################################################################### ################################## 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.033s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4080 7944 14129 20490 21709 16053 8119 2837 642 107 11 1 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 16 216 1759 7768 19271 27365 23987 13401 5032 1177 203 21 2 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8160 15888 28258 40980 43418 32106 16238 5674 1284 214 22 2 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 16 216 1759 7768 19271 27365 23987 13401 5032 1177 203 21 2 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99609 1.97353 1.88929 1.7251 1.52975 1.36973 1.25288 1.17471 1.11315 1.08333 1.0514 1.04545 1 tree_stats_height=25 tree_stats_numInternals=100217 tree_stats_numLeaves=100218 tree_stats_numNodes=200435 tree_stats_numKeys=100218 tree_stats_avgDegreeInternal=2.00001 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.5 tree_stats_avgKeyDepth=17.3065 tree_stats_bytesAtDepth=56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 456960 889728 1582448 2294880 2431408 1797936 909328 317744 71904 11984 1232 112 tree_stats_sizeInBytes=11224360 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=13462 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:16652 2:95531 4:406079 8:638502 16:274901 32:3457 [2^00, 2^01]: 16652 (2^01, 2^02]: 95531 (2^02, 2^03]: 406079 (2^03, 2^04]: 638502 (2^04, 2^05]: 274901 (2^05, 2^06]: 3457 sum_limbo_reclamation_event_size_total=15102364 count_limbo_reclamation_event_size_by_thread=9967 9969 9972 9966 9971 9955 9961 9962 9974 9973 9963 9962 9964 9977 9969 9957 9962 9969 9955 9962 9973 9973 9957 9960 9950 9974 9966 9972 9960 9975 9978 9958 9964 9969 9964 9968 9966 9972 9967 9977 9970 9960 9962 9966 9967 9960 9959 9965 9960 9939 9971 9958 9973 9974 9964 9959 9959 9975 9959 9963 9969 9967 9971 9969 9960 9961 9972 9982 9963 9966 9970 9981 9964 9966 9969 9972 9964 9970 9967 9968 9965 9965 9962 9979 9965 9972 9961 9971 9967 9969 9968 9963 9974 9970 9975 9977 9973 9968 9973 9962 9962 9970 9960 9965 9971 9970 9958 9966 9951 9972 9965 9968 9956 9956 9969 9957 9967 9965 9968 9965 9974 9967 9967 9973 9962 9965 9951 9957 9954 9972 9964 9969 9966 9968 9975 9972 9971 9968 9970 9963 9962 9967 9962 9956 count_limbo_reclamation_event_size_total=1435122 sum_limbo_reclamation_event_count_total=3711140 first_thread_announced_epoch_by_thread=26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 26924 sum_num_inserts_by_thread=89551 89949 91390 90892 90847 89238 90065 89409 91316 91996 90885 90210 90922 90304 91012 90965 90887 90225 89255 89759 91686 91343 90529 88920 88838 89886 91289 91144 90067 89380 89722 89715 91897 91326 90812 90630 90051 90274 91518 91439 91249 89868 89024 89909 90000 91357 90505 88946 89400 90032 90803 91161 90558 89870 89565 90145 92272 92142 90717 90476 90017 90192 90626 91113 89931 89549 89248 89922 91098 91766 90174 89445 89142 89291 91109 91414 90225 89875 89393 90126 90892 91289 91127 90117 89662 90112 90839 91516 90398 89525 89107 89796 91250 90818 90650 89129 88640 88850 89930 90442 89988 88791 88570 88956 90133 90348 89253 88836 88887 89523 90193 90326 89286 88000 87942 88410 89877 88822 88872 87489 88244 88782 89318 89829 90110 88632 89119 88833 91233 90705 89674 88989 88768 88895 89556 90067 88822 87155 88462 89542 90273 90255 89578 88017 sum_num_inserts_total=12960647 sum_num_deletes_by_thread=89110 90396 91000 91381 90366 88628 88486 89145 91492 91494 90263 90143 90428 90350 91337 91290 90966 90371 89214 90844 91421 90894 90583 89060 88558 90017 90642 91496 90309 88523 89869 89874 90696 91540 90663 90006 89884 90778 91135 91668 91335 90181 88792 89792 89983 90328 90855 88454 89092 89772 91589 91614 90748 90380 90187 90312 92221 92309 90743 90888 89940 90420 91361 91088 90750 90067 89581 90287 91520 91585 89982 90021 89658 89417 91014 91278 90387 89550 89067 89647 91457 91069 90831 90301 89398 90378 91463 91233 90233 89532 88951 90472 91102 91451 90758 88732 88623 88805 90366 90218 89503 88939 88409 88588 89790 91096 88867 88967 88340 89669 90066 89924 89106 87877 86826 88651 89108 90010 88734 87591 88023 88522 89444 90229 89329 88834 88980 89227 90394 89881 88840 88902 88323 88732 89424 89566 88689 87754 88952 89158 90455 90426 89468 88326 sum_num_deletes_total=12955827 sum_num_searches_by_thread=17702781 17841544 18019141 18032799 17943885 17634593 17748241 17780821 18089058 18131029 17968423 17864560 17859833 17900209 18061027 18060202 17980544 17847750 17650544 17849046 18008208 17990897 17925021 17623044 17601868 17750271 18040911 18042828 17922506 17628179 17751926 17800060 18061748 18101385 17900919 17827242 17773813 17898648 18080645 18079655 17985859 17819499 17602848 17784685 17876386 18030981 17822700 17545680 17695770 17809541 18071481 18084057 17895658 17857827 17796260 17859796 18150368 18205883 18059488 17923959 17811163 17924376 18057208 18083668 17950836 17756604 17674186 17822985 18071989 18096243 17868689 17736374 17695163 17738258 18046610 18053999 17866911 17792813 17665643 17787164 18041716 18058938 17956877 17839306 17757470 17800559 18032464 18027696 17871689 17758949 17678583 17811485 18087228 18034526 17873242 17648063 17513480 17617341 17810459 17870674 17769871 17628390 17512203 17595917 17835616 17924277 17639201 17570508 17527027 17723657 17832294 17837017 17650835 17409139 17315167 17544658 17712323 17722675 17614400 17398259 17403959 17581331 17748404 17838533 17805139 17608794 17588060 17647462 17911041 17911235 17697375 17560627 17559752 17627756 17723435 17701090 17621269 17376335 17520085 17678908 17862361 17877717 17739406 17502594 sum_num_searches_total=2565102259 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=17881442 18021889 18201531 18215072 18125098 17812459 17926792 17959375 18271866 18314519 18149571 18044913 18041183 18080863 18243376 18242457 18162397 18028346 17829013 18029649 18191315 18173134 18106133 17801024 17779264 17930174 18222842 18225468 18102882 17806082 17931517 17979649 18244341 18284251 18082394 18007878 17953748 18079700 18263298 18262762 18168443 17999548 17780664 17964386 18056369 18212666 18004060 17723080 17874262 17989345 18253873 18266832 18076964 18038077 17976012 18040253 18334861 18390334 18240948 18105323 17991120 18104988 18239195 18265869 18131517 17936220 17853015 18003194 18254607 18279594 18048845 17915840 17873963 17916966 18228733 18236691 18047523 17972238 17844103 17966937 18224065 18241296 18138835 18019724 17936530 17981049 18214766 18210445 18052320 17938006 17856641 17991753 18269580 18216795 18054650 17825924 17690743 17794996 17990755 18051334 17949362 17806120 17689182 17773461 18015539 18105721 17817321 17748311 17704254 17902849 18012553 18017267 17829227 17585016 17489935 17721719 17891308 17901507 17792006 17573339 17580226 17758635 17927166 18018591 17984578 17786260 17766159 17825522 18092668 18091821 17875889 17738518 17736843 17805383 17902415 17880723 17798780 17551244 17697499 17857608 18043089 18058398 17918452 17678937 average_num_operations_total=17993185 stdev_num_operations_total=15851 sum_num_operations_total=2591018733 min_num_operations_total=17489935 max_num_operations_total=18390334 first_time_thread_terminate_by_thread=10000079 10000078 10000076 10000077 10000077 10000076 10000077 10000076 10000076 10000079 10000077 10000078 10000077 10000077 10000077 10000076 10000076 10000076 10000076 10000076 10000075 10000076 10000079 10000077 10000079 10000078 10000076 10000077 10000077 10000077 10000077 10000076 10000076 10000079 10000077 10000078 10000077 10000077 10000077 10000076 10000076 10000076 10000076 10000076 10000075 10000076 10000079 10000077 10000079 10000078 10000079 10000080 10000076 10000079 10000077 10000076 10000076 10000079 10000079 10000076 10000077 10000076 10000079 10000079 10000080 10000076 10000076 10000078 10000078 10000078 10000079 10000076 10000077 10000078 10000079 10000076 10000076 10000079 10000076 10000076 10000076 10000079 10000080 10000076 10000077 10000076 10000079 10000079 10000080 10000076 10000080 10000078 10000078 10000078 10000079 10000076 10000078 10000078 10000075 10000075 10000077 10000080 10000080 10000075 10000078 10000078 10000077 10000080 10000075 10000075 10000075 10000075 10000145 10000078 10000080 10000078 10000075 10000075 10000078 10000078 10000075 10000078 10000075 10000078 10000077 10000080 10000080 10000075 10000078 10000078 10000077 10000080 10000075 10000075 10000075 10000075 10000075 10000078 10000080 10000078 10000075 10000075 10000078 10000078 min_time_thread_terminate_total=10000075 max_time_thread_terminate_total=10000145 first_time_thread_start_by_thread=5 5 5 4 5 4 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 4 5 4 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 4 4 4 4 4 4 4 5 4 5 4 5 4 4 5 4 5 4 4 4 4 4 4 4 4 4 4 4 4 4 4 5 4 5 4 5 4 4 5 4 5 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 9 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 min_time_thread_start_total=3 max_time_thread_start_total=9 sum_duration_all_ops_total= threads_final_keysum=10030587223 threads_final_size=100218 final_keysum=10030587223 final_size=100218 validate_result=success Validation OK. Structural validation OK. total_find=2565102259 total_rq=0 total_inserts=12960647 total_deletes=12955827 total_updates=25916474 total_queries=2565102259 total_ops=2591018733 find_throughput=256510225 rq_throughput=0 update_throughput=2591647 query_throughput=256510225 total_throughput=259101873 total find : 2565102259 total rq : 0 total inserts : 12960647 total deletes : 12955827 total updates : 25916474 total queries : 2565102259 total ops : 2591018733 find throughput : 256510225 rq throughput : 0 update throughput : 2591647 query throughput : 256510225 total throughput : 259101873 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=8.53498 PAPI_L3_TCM=0.127729 PAPI_TOT_CYC=1548.24 PAPI_TOT_INS=309.541 garbage=128243630742553 total_execution_walltime=11.659s REALTIME_MAIN_END_PERF_FORMAT=6982505.825258051 [time_cmd_output] time_elapsed_sec=11.79, faults_major=0, faults_minor=106382, mem_maxresident_kb=405728, user_cputime=1606.64, sys_cputime=6.69, percent_cpu=13683% 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