__step=000308 __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 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=data000308.txt __path_data=data/data000308.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6982482.527734583 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=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 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.009s prefilling_size=100034 prefilling_elapsed_millis=1.001s finished prefilling to size 99992 for expected size 100000 keysum=9988271307, performing 26805677 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=99992 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=869 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=6982483.815667661 REALTIME_END_PERF_FORMAT=6982493.815820762 ############################################################################### ################################## 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.038s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4074 7899 13903 19897 21458 16175 8513 2978 727 128 23 3 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 22 249 1895 7909 18336 26741 23837 14048 5229 1326 233 43 6 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8148 15798 27806 39794 42916 32350 17026 5956 1454 256 46 6 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 22 249 1895 7909 18336 26741 23837 14048 5229 1326 233 43 6 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99463 1.96944 1.88005 1.71556 1.53923 1.3769 1.26315 1.17491 1.12206 1.08803 1.08984 1.06522 1 tree_stats_height=25 tree_stats_numInternals=99873 tree_stats_numLeaves=99874 tree_stats_numNodes=199747 tree_stats_numKeys=99874 tree_stats_avgDegreeInternal=2.00001 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.5 tree_stats_avgKeyDepth=17.3349 tree_stats_bytesAtDepth=56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 456288 884688 1557136 2228464 2403296 1811600 953456 333536 81424 14336 2576 336 tree_stats_sizeInBytes=11185832 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=21546 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:48076 2:160574 4:368193 8:312323 16:51059 32:53 64:1 128:94 256:95 [2^00, 2^01]: 48076 (2^01, 2^02]: 160574 (2^02, 2^03]: 368193 (2^03, 2^04]: 312323 (2^04, 2^05]: 51059 (2^05, 2^06]: 53 (2^06, 2^07]: 1 (2^07, 2^08]: 94 (2^08, 2^09]: 95 sum_limbo_reclamation_event_size_total=6732011 count_limbo_reclamation_event_size_by_thread=9808 9802 9812 9801 9791 9764 9754 9791 9817 9793 9787 9802 9795 9798 9797 9789 9807 9809 9783 9802 9812 9772 9806 9798 9807 9766 9841 9809 9799 9812 9781 9819 9816 9796 9810 9821 9806 9799 9826 9789 9783 9757 9776 9782 9810 9774 9778 9794 9809 9793 9795 9844 9788 9786 9806 9750 9816 9812 9779 9807 9769 9798 9814 9801 9808 9791 9803 9796 9831 9792 9783 9790 9780 9800 9798 9802 9743 9811 9777 9786 9802 9808 9793 9782 9800 9832 9788 9811 9797 9773 9762 9818 9819 9788 9792 9804 count_limbo_reclamation_event_size_total=940468 sum_limbo_reclamation_event_count_total=3969840 first_thread_announced_epoch_by_thread=43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 43092 sum_num_inserts_by_thread=95324 96399 97069 96283 95399 94734 96062 95984 97869 97586 96111 95864 95858 96159 97916 97039 97616 95345 95121 96834 96822 97260 95914 94643 95618 95263 96789 96647 97174 95281 94966 96162 97755 97182 95403 95931 95978 96720 97385 96112 96268 94922 94486 95363 96345 96424 95856 95337 95332 95877 96451 97737 95917 95911 95876 96186 97665 97943 96809 96144 95742 96362 96980 96466 96370 94419 94995 96389 96772 96842 96472 94768 94883 95534 97310 97028 95261 95220 95208 95941 97473 97771 95036 95419 95816 96346 97060 97340 96503 94698 93433 96170 97952 97363 97324 96302 sum_num_inserts_total=9235394 sum_num_deletes_by_thread=95241 95946 96426 96301 96130 94889 96139 96518 97618 97500 96046 95375 95511 96807 97178 96920 96714 96257 95084 96142 96960 97163 96245 95731 95181 95464 96601 96669 95750 94911 95264 95725 97603 96909 95741 95705 96335 96676 97310 96441 96324 95449 93659 95364 96052 96182 95893 95068 95487 96366 97120 97116 96659 95581 96348 96536 98009 97690 96713 95527 94979 96507 97552 96472 95760 95184 95380 95593 96472 96934 96582 95557 94758 95647 96466 96666 95317 94914 95075 95052 97496 96927 95100 95887 94972 96381 96750 97286 96505 94701 94285 95490 97520 97988 97760 96522 sum_num_deletes_total=9230706 sum_num_searches_by_thread=18891074 19003168 19193910 19064964 18972371 18781680 18984358 19128090 19373127 19343455 19010034 19006166 18966445 19116302 19320615 19193715 19186325 19012617 18820530 19076820 19176122 19177278 19084315 18865103 18909863 18918690 19140733 19174595 19062792 18860829 18961267 18999979 19286900 19268418 18980022 18910431 18950948 19147266 19294080 19077318 19011742 18855141 18636922 18924716 19107944 19079065 18987051 18777129 18923621 19011989 19203003 19266630 19070164 18988590 19039976 19016262 19410085 19385082 19093982 19050124 18935252 19080548 19218720 19122355 18986952 18753280 18796737 18974538 19194855 19213824 19121928 18887270 18803391 18953809 19166629 19225778 18910199 18816792 18862387 18895623 19301732 19322392 18908608 18967821 18948478 19120688 19254502 19238366 19073255 18737692 18681078 19000180 19331193 19366661 19270224 19060830 sum_num_searches_total=1829036500 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=19081639 19195513 19387405 19257548 19163900 18971303 19176559 19320592 19568614 19538541 19202191 19197405 19157814 19309268 19515709 19387674 19380655 19204219 19010735 19269796 19369904 19371701 19276474 19055477 19100662 19109417 19334123 19367911 19255716 19051021 19151497 19191866 19482258 19462509 19171166 19102067 19143261 19340662 19488775 19269871 19204334 19045512 18825067 19115443 19300341 19271671 19178800 18967534 19114440 19204232 19396574 19461483 19262740 19180082 19232200 19208984 19605759 19580715 19287504 19241795 19125973 19273417 19413252 19315293 19179082 18942883 18987112 19166520 19388099 19407600 19314982 19077595 18993032 19144990 19360405 19419472 19100777 19006926 19052670 19086616 19496701 19517090 19098744 19159127 19139266 19313415 19448312 19432992 19266263 18927091 18868796 19191840 19526665 19562012 19465308 19253654 average_num_operations_total=19244818 stdev_num_operations_total=17775 sum_num_operations_total=1847502600 min_num_operations_total=18825067 max_num_operations_total=19605759 first_time_thread_terminate_by_thread=10000152 10000152 10000153 10000152 10000153 10000152 10000153 10000151 10000152 10000152 10000151 10000151 10000153 10000153 10000153 10000152 10000152 10000151 10000152 10000153 10000152 10000152 10000152 10000152 10000152 10000153 10000153 10000152 10000153 10000152 10000153 10000151 10000152 10000152 10000151 10000151 10000153 10000152 10000153 10000152 10000152 10000151 10000152 10000153 10000152 10000152 10000152 10000152 10000154 10000151 10000152 10000152 10000151 10000151 10000150 10000151 10000153 10000151 10000152 10000150 10000151 10000151 10000151 10000153 10000150 10000150 10000152 10000151 10000151 10000150 10000151 10000150 10000154 10000151 10000152 10000152 10000151 10000152 10000150 10000151 10000153 10000151 10000153 10000150 10000151 10000151 10000151 10000153 10000150 10000150 10000152 10000151 10000151 10000150 10000151 10000150 min_time_thread_terminate_total=10000150 max_time_thread_terminate_total=10000154 first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 4 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=4 sum_duration_all_ops_total= threads_final_keysum=10004485446 threads_final_size=99874 final_keysum=10004485446 final_size=99874 validate_result=success Validation OK. Structural validation OK. total_find=1829036500 total_rq=0 total_inserts=9235394 total_deletes=9230706 total_updates=18466100 total_queries=1829036500 total_ops=1847502600 find_throughput=182903650 rq_throughput=0 update_throughput=1846610 query_throughput=182903650 total_throughput=184750260 total find : 1829036500 total rq : 0 total inserts : 9235394 total deletes : 9230706 total updates : 18466100 total queries : 1829036500 total ops : 1847502600 find throughput : 182903650 rq throughput : 0 update throughput : 1846610 query throughput : 182903650 total throughput : 184750260 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=7.93537 PAPI_L3_TCM=0.0894836 PAPI_TOT_CYC=1447.95 PAPI_TOT_INS=309.801 garbage=91493798233113 total_execution_walltime=11.435s REALTIME_MAIN_END_PERF_FORMAT=6982493.973465611 [time_cmd_output] time_elapsed_sec=11.56, faults_major=0, faults_minor=92401, mem_maxresident_kb=363776, user_cputime=1082.40, sys_cputime=4.81, percent_cpu=9397% 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=2