__step=000612 __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" ./natarajan_ext_bst_lf.debra -nwork 96 -nprefill 96 -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=data000612.txt __path_data=data/data000612.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6986235.212141072 binary=./natarajan_ext_bst_lf.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=natarajan_ext_bst_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=200000 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=32 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.04s prefilling_size=100055 prefilling_elapsed_millis=1s finished prefilling to size 99980 for expected size 100000 keysum=9980967621, performing 51271098 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=99980 pref_millis=1102 prefill_elapsed_ms=1120 6node_tIxPvE_object_size=32 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=1127 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6986236.557087758 REALTIME_END_PERF_FORMAT=6986246.557243925 ############################################################################### ################################## 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 868 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.029s tree_stats_numInternalsAtDepth=1 2 4 8 16 30 57 112 224 434 796 1396 2262 3538 5225 7021 8600 9741 10436 10215 9191 7905 6526 5210 3909 2786 1854 1188 653 345 141 50 18 2 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 2 3 2 0 14 72 196 530 986 1851 3429 5442 7459 9046 10657 11239 10477 9284 7842 6511 5032 3718 2520 1723 961 549 232 82 34 4 tree_stats_numNodesAtDepth=1 2 4 8 16 32 60 114 224 448 868 1592 2792 4524 7076 10450 14042 17200 19482 20872 20430 18382 15810 13052 10420 7818 5572 3708 2376 1306 690 282 100 36 4 tree_stats_numKeysAtDepth=0 0 0 0 0 2 3 2 0 14 72 196 530 986 1851 3429 5442 7459 9046 10657 11239 10477 9284 7842 6511 5032 3718 2520 1723 961 549 232 82 34 4 tree_stats_avgDegreeAtDepth=2 2 2 2 2 1.9375 1.95 1.98246 2 1.96875 1.91705 1.87688 1.81017 1.78205 1.73841 1.67187 1.61245 1.56634 1.53567 1.48941 1.44988 1.43004 1.41278 1.39917 1.37514 1.35636 1.33274 1.32039 1.27483 1.26417 1.20435 1.1773 1.18 1.05556 1 tree_stats_height=35 tree_stats_numInternals=99896 tree_stats_numLeaves=99897 tree_stats_numNodes=199793 tree_stats_numKeys=99897 tree_stats_avgDegreeInternal=2.00001 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.5 tree_stats_avgKeyDepth=20.6072 tree_stats_bytesAtDepth=32 64 128 256 512 1024 1920 3648 7168 14336 27776 50944 89344 144768 226432 334400 449344 550400 623424 667904 653760 588224 505920 417664 333440 250176 178304 118656 76032 41792 22080 9024 3200 1152 128 tree_stats_sizeInBytes=6393376 6node_tIxPvE_object_size=32 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=21680 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:6 8:143 16:44931 32:877874 64:36758 128:47 256:48 (2^02, 2^03]: 6 (2^03, 2^04]: 143 (2^04, 2^05]: 44931 (2^05, 2^06]: 877874 (2^06, 2^07]: 36758 (2^07, 2^08]: 47 (2^08, 2^09]: 48 sum_limbo_reclamation_event_size_total=44184346 count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 count_limbo_reclamation_event_size_total=959807 sum_limbo_reclamation_event_count_total=1973088 first_thread_announced_epoch_by_thread=43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 43360 sum_num_inserts_by_thread=930649 942544 953260 949902 944445 937697 939278 944984 949504 956734 946700 937614 907593 944442 950406 953049 947645 943139 933309 938831 945581 950052 933854 931824 928061 940245 948226 945271 947092 936316 936935 944770 949029 953839 941625 935747 934813 939220 948655 949757 946781 940768 927758 927630 939834 944186 933641 928780 940829 946872 954550 955999 948729 944854 935934 947139 955074 957923 951741 949848 944939 961192 958151 961334 949668 943194 942991 951328 955766 956104 946005 943194 937371 941486 953712 952378 943895 943385 935333 943459 950625 959148 946534 949172 946074 947945 947048 952899 941889 941699 944054 950083 964280 968369 958122 954241 sum_num_inserts_total=90758574 sum_num_deletes_by_thread=931798 941534 955064 949309 943469 936623 938832 945644 952624 957076 946223 935529 908442 944113 951151 953854 947640 943491 931913 937402 944537 949062 935923 929558 927473 940078 948873 945678 945839 935385 935805 942627 950579 953666 942142 936974 934632 939563 950485 949261 945225 940139 928395 929683 941799 945088 932494 927779 939776 944255 953421 956135 947252 942960 937489 948247 954640 957593 953376 949194 945446 961455 959036 961219 950675 944775 944355 950747 954064 955774 946701 941146 936160 941714 952898 951682 944285 942156 934773 942883 951936 957968 947985 949679 944250 947018 945612 953138 943295 941768 943265 949839 963942 969334 958253 953963 sum_num_deletes_total=90748000 sum_num_searches_by_thread=16782367 16948188 17118936 17091639 16991847 16836077 16904790 17008912 17126775 17224885 17024232 16842218 16344047 16992673 17104155 17142405 17064624 16969172 16781600 16885998 17013808 17075729 16826357 16777969 16692686 16905685 17093511 17016862 17021455 16831529 16868591 16995630 17089249 17183721 16959835 16855913 16843891 16927642 17090763 17078621 16997139 16915395 16689156 16726268 16942903 16999688 16810471 16709386 16919580 17004071 17187865 17216137 17061469 16968104 16871411 17058751 17191785 17229575 17125737 17071428 17037989 17305695 17238505 17310959 17089808 16997674 16994913 17117384 17189573 17215070 17043948 16974312 16867086 16972044 17161173 17143025 16996303 16960102 16826294 16989562 17142725 17226123 17080458 17077526 17027901 17047665 17054258 17136601 16960866 16955351 16981101 17097905 17375832 17447975 17257742 17159267 sum_num_searches_total=1633492021 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=18644814 18832266 19027260 18990850 18879761 18710397 18782900 18899540 19028903 19138695 18917155 18715361 18160082 18881228 19005712 19049308 18959909 18855802 18646822 18762231 18903926 18974843 18696134 18639351 18548220 18786008 18990610 18907811 18914386 18703230 18741331 18883027 18988857 19091226 18843602 18728634 18713336 18806425 18989903 18977639 18889145 18796302 18545309 18583581 18824536 18888962 18676606 18565945 18800185 18895198 19095836 19128271 18957450 18855918 18744834 18954137 19101499 19145091 19030854 18970470 18928374 19228342 19155692 19233512 18990151 18885643 18882259 19019459 19099403 19126948 18936654 18858652 18740617 18855244 19067783 19047085 18884483 18845643 18696400 18875904 19045286 19143239 18974977 18976377 18918225 18942628 18946918 19042638 18846050 18838818 18868420 18997827 19304054 19385678 19174117 19067471 average_num_operations_total=18906235 stdev_num_operations_total=18824 sum_num_operations_total=1814998595 min_num_operations_total=18160082 max_num_operations_total=19385678 first_time_thread_terminate_by_thread=10000155 10000156 10000155 10000155 10000155 10000156 10000155 10000156 10000156 10000155 10000155 10000155 10000155 10000155 10000155 10000155 10000155 10000156 10000155 10000155 10000156 10000156 10000155 10000155 10000155 10000156 10000155 10000155 10000155 10000156 10000155 10000156 10000156 10000155 10000155 10000155 10000155 10000155 10000155 10000155 10000155 10000156 10000155 10000155 10000156 10000156 10000155 10000155 10000158 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000158 10000157 10000157 10000157 10000155 10000157 10000157 10000157 10000157 10000157 10000157 10000156 10000157 10000157 10000157 10000158 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000155 10000157 10000157 10000157 10000157 10000157 10000157 10000156 10000157 10000157 10000157 min_time_thread_terminate_total=10000155 max_time_thread_terminate_total=10000158 first_time_thread_start_by_thread=5 5 5 5 6 6 5 5 5 5 5 5 5 6 5 5 5 5 5 6 6 5 5 5 5 5 5 5 6 6 5 5 5 5 5 5 5 6 5 5 5 5 5 5 6 5 5 5 5 5 5 6 5 5 5 6 5 6 5 5 5 5 5 5 6 5 5 5 6 5 5 6 5 5 5 6 5 5 5 6 5 6 5 5 5 5 5 5 6 5 5 5 6 5 5 6 min_time_thread_start_total=5 max_time_thread_start_total=6 sum_duration_all_ops_total= threads_final_keysum=9974571594 threads_final_size=99897 final_keysum=9974571594 final_size=99897 validate_result=success Validation OK. Structural validation OK. total_find=1633492021 total_rq=0 total_inserts=90758574 total_deletes=90748000 total_updates=181506574 total_queries=1633492021 total_ops=1814998595 find_throughput=163349202 rq_throughput=0 update_throughput=18150657 query_throughput=163349202 total_throughput=181499859 total find : 1633492021 total rq : 0 total inserts : 90758574 total deletes : 90748000 total updates : 181506574 total queries : 1633492021 total ops : 1814998595 find throughput : 163349202 rq throughput : 0 update throughput : 18150657 query throughput : 163349202 total throughput : 181499859 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=5.2837 PAPI_L3_TCM=0.272226 PAPI_TOT_CYC=1467.25 PAPI_TOT_INS=335.781 garbage=81700603162987 total_execution_walltime=11.524s REALTIME_MAIN_END_PERF_FORMAT=6986246.737703103 [time_cmd_output] time_elapsed_sec=11.63, faults_major=0, faults_minor=80357, mem_maxresident_kb=315832, user_cputime=1084.98, sys_cputime=2.78, percent_cpu=9345% timeout=false algorithm=natarajan_ext_bst_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