__step=000531 __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 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=data000531.txt __path_data=data/data000531.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6985286.51040625 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=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=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.025s prefilling_size=1000879 prefilling_elapsed_millis=1.001s finished prefilling to size 1000817 for expected size 1000000 keysum=1000632650774, performing 22010984 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=1000817 pref_millis=1102 prefill_elapsed_ms=1137 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=490 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=6985287.416401190 REALTIME_END_PERF_FORMAT=6985297.416494617 ############################################################################### ################################## 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 1024 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.04s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16377 32526 62582 110593 166999 201328 183626 122992 59387 20389 5080 917 105 11 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 7 228 2470 14571 54187 132670 219030 244260 186597 98385 35698 9243 1729 199 22 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32754 65052 125164 221186 333998 402656 367252 245984 118774 40778 10160 1834 210 22 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 7 228 2470 14571 54187 132670 219030 244260 186597 98385 35698 9243 1729 199 22 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99957 1.99304 1.96203 1.88358 1.75502 1.60278 1.45604 1.3349 1.24143 1.17166 1.12458 1.09026 1.05725 1.05238 1 tree_stats_height=29 tree_stats_numInternals=999295 tree_stats_numLeaves=999296 tree_stats_numNodes=1998591 tree_stats_numKeys=999296 tree_stats_avgDegreeInternal=2 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.5 tree_stats_avgKeyDepth=20.8183 tree_stats_bytesAtDepth=56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917504 1834224 3642912 7009184 12386416 18703888 22548736 20566112 13775104 6651344 2283568 568960 102704 11760 1232 tree_stats_sizeInBytes=111921096 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=9324 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:0 2:0 4:0 8:5 16:17236 32:462982 64:475533 128:3828 (2^03, 2^04]: 5 (2^04, 2^05]: 17236 (2^05, 2^06]: 462982 (2^06, 2^07]: 475533 (2^07, 2^08]: 3828 sum_limbo_reclamation_event_size_total=65788424 count_limbo_reclamation_event_size_by_thread=9994 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9994 9994 9996 9996 9994 9994 9994 9996 9996 9994 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9994 9996 9996 9996 9996 9996 9996 9994 9996 9996 9996 9996 9996 9996 9996 9996 9996 9994 9996 9996 9996 9994 9996 9996 9996 9996 9994 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9994 9996 9996 9996 9994 9996 9994 9996 9994 count_limbo_reclamation_event_size_total=959584 sum_limbo_reclamation_event_count_total=1696160 first_thread_announced_epoch_by_thread=18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 18648 sum_num_inserts_by_thread=397961 401034 405119 404168 401753 398772 400291 404091 407388 408887 403886 402169 402328 404015 406328 407021 403896 400589 399432 402461 404818 405083 400478 397619 398575 402630 406821 405002 402755 398636 399810 401582 407219 406548 403941 401391 402985 404610 407270 408345 404333 402330 400428 401154 403699 405772 400352 398549 402036 403141 405441 405744 402344 400799 401238 402922 408663 408290 403655 401044 400777 404382 408177 404996 404255 398293 397655 401249 405663 406890 402737 401415 399742 402306 407363 406561 404013 402245 400269 401737 406875 406670 404573 402353 402432 404204 406255 406408 405078 399476 398695 401673 405961 407280 405122 401678 sum_num_inserts_total=38715099 sum_num_deletes_by_thread=399347 401565 405079 404818 402677 398473 400365 403714 408444 409382 403923 401741 402963 405025 405589 407185 404364 401745 400237 401603 403975 405231 400619 396757 397479 399938 406217 405741 401898 398074 399182 401913 407047 406846 402667 400584 402639 404873 406444 407212 404404 402520 400189 400798 404142 406291 401018 398855 401274 402572 404789 405470 402227 400596 401466 403132 407964 407773 403359 400300 402961 404496 406388 406019 403740 398715 398891 400594 405404 406217 403312 402417 399587 403353 406834 407562 403186 401222 400133 401240 407404 408636 403746 401537 402619 404664 406507 407005 403606 398876 399748 401275 408653 408142 404387 402978 sum_num_deletes_total=38714768 sum_num_searches_by_thread=7186304 7226757 7298023 7284072 7256607 7174103 7194542 7262433 7333924 7351683 7282401 7233674 7241440 7272326 7317191 7315539 7267779 7227765 7185997 7230899 7277805 7295705 7207916 7152053 7173055 7214436 7289019 7297849 7250657 7175919 7208894 7240473 7318642 7330796 7253735 7211560 7245753 7276880 7334702 7335804 7286138 7238527 7177071 7226628 7276276 7315290 7228892 7173477 7230289 7242518 7309121 7297612 7230612 7216249 7211031 7255534 7343078 7345522 7273758 7217185 7226178 7272470 7317180 7311675 7272660 7196355 7177537 7217308 7313141 7309072 7250165 7226955 7203758 7256714 7337279 7328920 7262364 7227080 7222976 7240524 7322479 7337906 7277237 7234127 7240840 7283857 7323407 7323938 7270119 7187435 7176069 7223121 7337059 7339301 7279009 7230842 sum_num_searches_total=696886977 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=7983612 8029356 8108221 8093058 8061037 7971348 7995198 8070238 8149756 8169952 8090210 8037584 8046731 8081366 8129108 8129745 8076039 8030099 7985666 8034963 8086598 8106019 8009013 7946429 7969109 8017004 8102057 8108592 8055310 7972629 8007886 8043968 8132908 8144190 8060343 8013535 8051377 8086363 8148416 8151361 8094875 8043377 7977688 8028580 8084117 8127353 8030262 7970881 8033599 8048231 8119351 8108826 8035183 8017644 8013735 8061588 8159705 8161585 8080772 8018529 8029916 8081348 8131745 8122690 8080655 7993363 7974083 8019151 8124208 8122179 8056214 8030787 8003087 8062373 8151476 8143043 8069563 8030547 8023378 8043501 8136758 8153212 8085556 8038017 8045891 8092725 8136169 8137351 8078803 7985787 7974512 8026069 8151673 8154723 8088518 8035498 average_num_operations_total=8065800 stdev_num_operations_total=5823 sum_num_operations_total=774316844 min_num_operations_total=7946429 max_num_operations_total=8169952 first_time_thread_terminate_by_thread=10000093 10000095 10000093 10000093 10000093 10000094 10000095 10000093 10000093 10000095 10000094 10000095 10000093 10000095 10000095 10000093 10000095 10000093 10000095 10000095 10000093 10000093 10000094 10000093 10000093 10000095 10000093 10000093 10000093 10000094 10000095 10000093 10000093 10000093 10000094 10000095 10000093 10000095 10000095 10000093 10000095 10000093 10000095 10000095 10000095 10000093 10000094 10000093 10000094 10000093 10000094 10000095 10000095 10000093 10000093 10000092 10000093 10000094 10000094 10000093 10000094 10000094 10000093 10000094 10000094 10000094 10000093 10000094 10000093 10000094 10000094 10000094 10000094 10000093 10000093 10000095 10000095 10000093 10000093 10000094 10000093 10000094 10000094 10000093 10000094 10000094 10000093 10000094 10000094 10000094 10000093 10000094 10000093 10000093 10000094 10000094 min_time_thread_terminate_total=10000092 max_time_thread_terminate_total=10000095 first_time_thread_start_by_thread=5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 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 4 5 5 5 5 5 5 5 5 min_time_thread_start_total=4 max_time_thread_start_total=5 sum_duration_all_ops_total= threads_final_keysum=999334918019 threads_final_size=999296 final_keysum=999334918019 final_size=999296 validate_result=success Validation OK. Structural validation OK. total_find=696886977 total_rq=0 total_inserts=38715099 total_deletes=38714768 total_updates=77429867 total_queries=696886977 total_ops=774316844 find_throughput=69688697 rq_throughput=0 update_throughput=7742986 query_throughput=69688697 total_throughput=77431684 total find : 696886977 total rq : 0 total inserts : 38715099 total deletes : 38714768 total updates : 77429867 total queries : 696886977 total ops : 774316844 find throughput : 69688697 rq throughput : 0 update throughput : 7742986 query throughput : 69688697 total throughput : 77431684 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=19.8411 PAPI_L3_TCM=5.42881 PAPI_TOT_CYC=3451.92 PAPI_TOT_INS=421.754 garbage=348428174451737 total_execution_walltime=11.52s REALTIME_MAIN_END_PERF_FORMAT=6985297.585007166 [time_cmd_output] time_elapsed_sec=11.66, faults_major=0, faults_minor=138764, mem_maxresident_kb=548612, user_cputime=1090.50, sys_cputime=3.61, percent_cpu=9377% 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