__step=000649 __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" ./bronson_pext_bst_occ.debra -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000649.txt __path_data=data/data000649.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6986668.806618118 binary=./bronson_pext_bst_occ.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=bronson_pext_bst_occ 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=200000 PREFILL_THREADS=48 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=48 WORK_THREADS=48 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 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 Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.004s prefilling_size=100144 prefilling_elapsed_millis=1.001s finished prefilling to size 100109 for expected size 100000 keysum=10011847795, performing 64414621 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=100109 pref_millis=1102 prefill_elapsed_ms=1121 6node_tIxPvE_object_size=56 6node_tIxPvE_allocated_count=0 6node_tIxPvE_allocated_size=0MB 6node_tIxPvE_get_from_pool=0 6node_tIxPvE_deallocated=0 6node_tIxPvE_limbo_count=0 6node_tIxPvE_limbo_details=0 0 0 global_epoch_counter=2961 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6986670.73776915 REALTIME_END_PERF_FORMAT=6986680.73941308 ############################################################################### ################################## 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.033s tree_stats_numInternalsAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8158 15109 20468 13759 2773 98 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 32 1081 8201 21257 17770 3579 119 tree_stats_numNodesAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8190 16190 28669 35016 20543 3677 119 tree_stats_numKeysAtDepth=0 0 2 3 5 5 12 21 60 130 278 504 1024 2139 4503 10785 23631 32932 20318 3673 119 tree_stats_avgDegreeAtDepth=1 2 2 2 2 2 2 2 2 2 2 2 2 1.99951 1.98071 1.83755 1.50745 1.19371 1.04401 1.00571 1 tree_stats_height=21 tree_stats_numInternals=68557 tree_stats_numLeaves=52039 tree_stats_numNodes=120596 tree_stats_numKeys=100144 tree_stats_avgDegreeInternal=1.75906 tree_stats_avgDegreeLeaves=0.999981 tree_stats_avgDegree=1.43151 tree_stats_avgKeyDepth=16.4862 tree_stats_bytesAtDepth=56 56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458640 906640 1605464 1960896 1150408 205912 6664 tree_stats_sizeInBytes=6753376 6node_tIxPvE_object_size=56 6node_tIxPvE_allocated_count=0 6node_tIxPvE_allocated_size=0MB 6node_tIxPvE_get_from_pool=0 6node_tIxPvE_deallocated=0 6node_tIxPvE_limbo_count=0 6node_tIxPvE_limbo_details=0 0 0 global_epoch_counter=42842 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:1192 2:14616 4:150026 8:296586 16:17290 32:5 [2^00, 2^01]: 1192 (2^01, 2^02]: 14616 (2^02, 2^03]: 150026 (2^03, 2^04]: 296586 (2^04, 2^05]: 17290 (2^05, 2^06]: 5 sum_limbo_reclamation_event_size_total=4327864 count_limbo_reclamation_event_size_by_thread=9994 9994 9996 9992 9993 9994 9993 9993 9997 9998 9995 9994 9994 9991 9992 9994 9995 9995 9995 9993 9993 9995 9991 9992 9993 9991 9994 9993 9996 9997 9994 9994 9997 9994 9996 9992 9993 9995 9997 9994 9996 9997 9993 9994 9990 9994 9995 9993 count_limbo_reclamation_event_size_total=479715 sum_limbo_reclamation_event_count_total=1914284 first_thread_announced_epoch_by_thread=85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 85684 sum_num_inserts_by_thread=909024 909702 915877 930608 910306 914839 919502 920525 935959 924261 920267 913313 910740 918998 926912 929635 917520 919164 897485 912647 919931 928339 905316 909221 910532 918645 925698 924376 904845 895738 915634 909276 921974 932886 919803 898712 901910 909997 924854 930320 917788 903131 906263 913618 917961 920748 904115 900945 sum_num_inserts_total=43949860 sum_num_deletes_by_thread=910569 908354 915721 929820 912288 916185 916793 919931 935833 924623 920195 915695 911105 919030 928735 930959 916209 916753 899150 912296 920672 927955 907777 909653 911254 917378 927136 925524 906666 898137 915150 909065 921744 931768 918231 899656 900948 910645 925944 931247 915717 903943 904753 914811 919841 921200 903453 899839 sum_num_deletes_total=43960351 sum_num_searches_by_thread=16397684 16359618 16487701 16744800 16404798 16467668 16512624 16562957 16823812 16639072 16588570 16457686 16395286 16540774 16688973 16751370 16519859 16512740 16174935 16409416 16566335 16701157 16305790 16361656 16412895 16515226 16659716 16613263 16308581 16142646 16472341 16371258 16592953 16784480 16563323 16190062 16213683 16395480 16649216 16768187 16490763 16257366 16290303 16441985 16544133 16571690 16287444 16202450 sum_num_searches_total=791114725 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=18217277 18177674 18319299 18605228 18227392 18298692 18348919 18403413 18695604 18487956 18429032 18286694 18217131 18378802 18544620 18611964 18353588 18348657 17971570 18234359 18406938 18557451 18118883 18180530 18234681 18351249 18512550 18463163 18120092 17936521 18303125 18189599 18436671 18649134 18401357 17988430 18016541 18216122 18500014 18629754 18324268 18064440 18101319 18270414 18381935 18413638 18095012 18003234 average_num_operations_total=18313019 stdev_num_operations_total=28003 sum_num_operations_total=879024936 min_num_operations_total=17936521 max_num_operations_total=18695604 first_time_thread_terminate_by_thread=10000163 10000165 10000164 10000164 10000163 10000164 10000164 10000164 10000164 10000163 10000163 10000164 10000163 10000164 10000163 10000164 10000163 10000163 10000164 10000164 10000163 10000165 10000164 10000163 10000163 10000164 10000164 10000163 10000163 10000163 10000164 10000164 10000164 10000163 10000163 10000164 10000163 10000163 10000163 10000163 10000164 10000163 10000164 10000164 10000163 10000164 10000164 10000163 min_time_thread_terminate_total=10000163 max_time_thread_terminate_total=10000165 first_time_thread_start_by_thread=2 3 3 3 2 2 3 3 3 2 3 2 2 2 2 2 2 2 3 3 3 3 3 3 2 3 3 3 2 2 3 3 3 2 3 2 2 2 2 2 2 2 3 3 3 3 3 3 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=10017339395 threads_final_size=100144 final_keysum=10017339395 final_size=100144 validate_result=success Validation OK. Structural validation OK. total_find=791114725 total_rq=0 total_inserts=43949860 total_deletes=43960351 total_updates=87910211 total_queries=791114725 total_ops=879024936 find_throughput=79111472 rq_throughput=0 update_throughput=8791021 query_throughput=79111472 total_throughput=87902493 total find : 791114725 total rq : 0 total inserts : 43949860 total deletes : 43960351 total updates : 87910211 total queries : 791114725 total ops : 879024936 find throughput : 79111472 rq throughput : 0 update throughput : 8791021 query throughput : 79111472 total throughput : 87902493 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=7.98631 PAPI_L3_TCM=0.000221524 PAPI_TOT_CYC=1456.81 PAPI_TOT_INS=957.271 garbage=39552308447201 total_execution_walltime=11.392s REALTIME_MAIN_END_PERF_FORMAT=6986680.199299318 [time_cmd_output] time_elapsed_sec=11.51, faults_major=0, faults_minor=77392, mem_maxresident_kb=311352, user_cputime=559.27, sys_cputime=2.27, percent_cpu=4877% timeout=false algorithm=bronson_pext_bst_occ.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=1