__step=000501 __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 144 -nprefill 144 -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=data000501.txt __path_data=data/data000501.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6984934.611731018 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=2000000 PREFILL_THREADS=144 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=144 WORK_THREADS=144 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,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.017s prefilling_size=1000763 prefilling_elapsed_millis=1.001s finished prefilling to size 1000761 for expected size 1000000 keysum=1000775044299, performing 50174798 updates; total_prefilling_elapsed_ms=1103 ms) pref_size=1000761 pref_millis=1103 prefill_elapsed_ms=1126 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=491 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6984935.969637849 REALTIME_END_PERF_FORMAT=6984945.969776208 ############################################################################### ################################## 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 1012 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 506 982 1860 3416 6030 10022 15830 23551 32966 43597 54629 64994 74003 80317 83365 82791 78290 71639 62828 53056 43242 34052 25689 18547 12574 8263 5106 2994 1687 901 467 215 95 41 11 3 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 6 30 104 304 802 2038 4214 8109 14136 22335 32565 44264 55985 67689 77269 83939 87292 84941 80450 72600 62870 52432 42415 32831 24520 16885 11420 7218 4301 2473 1335 719 335 149 71 19 6 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1012 1964 3720 6832 12060 20044 31660 47102 65932 87194 109258 129988 148006 160634 166730 165582 156580 143278 125656 106112 86484 68104 51378 37094 25148 16526 10212 5988 3374 1802 934 430 190 82 22 6 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 6 30 104 304 802 2038 4214 8109 14136 22335 32565 44264 55985 67689 77269 83939 87292 84941 80450 72600 62870 52432 42415 32831 24520 16885 11420 7218 4301 2473 1335 719 335 149 71 19 6 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 1.98828 1.97036 1.94705 1.91828 1.88261 1.83101 1.78976 1.74387 1.69989 1.66124 1.62652 1.59487 1.56931 1.54266 1.51897 1.49656 1.47282 1.45752 1.4385 1.42223 1.40751 1.39374 1.3772 1.36099 1.33898 1.32857 1.30897 1.29318 1.28173 1.26704 1.25916 1.23019 1.22093 1.21579 1.13415 1.13636 1 tree_stats_height=46 tree_stats_numInternals=999070 tree_stats_numLeaves=999071 tree_stats_numNodes=1998141 tree_stats_numKeys=999071 tree_stats_avgDegreeInternal=2 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.5 tree_stats_avgKeyDepth=25.622 tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8192 16384 32384 62848 119040 218624 385920 641408 1013120 1507264 2109824 2790208 3496256 4159616 4736192 5140288 5335360 5298624 5010560 4584896 4020992 3395584 2767488 2179328 1644096 1187008 804736 528832 326784 191616 107968 57664 29888 13760 6080 2624 704 192 tree_stats_sizeInBytes=63940512 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=7979 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:9 4:26 8:38 16:216 32:312820 64:764210 128:281 256:286 (2^01, 2^02]: 9 (2^02, 2^03]: 26 (2^03, 2^04]: 38 (2^04, 2^05]: 216 (2^05, 2^06]: 312820 (2^06, 2^07]: 764210 (2^07, 2^08]: 281 (2^08, 2^09]: 286 sum_limbo_reclamation_event_size_total=75093856 count_limbo_reclamation_event_size_by_thread=7486 7486 7486 7485 7486 7486 7485 7486 7485 7486 7485 7485 7485 7484 7486 7485 7485 7485 7485 7485 7485 7484 7486 7486 7486 7485 7485 7486 7485 7486 7485 7486 7486 7485 7485 7484 7486 7484 7486 7485 7485 7484 7485 7485 7484 7485 7485 7486 7486 7484 7486 7486 7486 7486 7485 7485 7486 7486 7486 7485 7486 7486 7486 7486 7484 7485 7486 7485 7486 7485 7486 7485 7485 7484 7486 7485 7485 7486 7486 7485 7485 7486 7486 7486 7486 7486 7486 7486 7484 7485 7485 7485 7486 7485 7486 7486 7485 7486 7485 7485 7485 7485 7485 7484 7485 7486 7485 7484 7486 7486 7486 7485 7485 7485 7485 7486 7486 7485 7484 7486 7484 7485 7486 7486 7486 7486 7485 7484 7484 7486 7485 7486 7485 7485 7484 7485 7486 7485 7485 7485 7486 7486 7485 7485 count_limbo_reclamation_event_size_total=1077886 sum_limbo_reclamation_event_count_total=1078272 first_thread_announced_epoch_by_thread=15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 15958 sum_num_inserts_by_thread=517621 522028 526261 525459 523176 516732 519580 522241 530817 530183 525259 521278 522470 524809 528234 529775 527429 523122 518847 521561 526455 528474 521214 518390 516990 520990 524101 525034 521285 513708 517958 521870 529546 529821 521700 516036 520902 523930 527462 528810 526164 521088 517152 519862 523480 528194 520418 514608 522037 522658 527772 527520 522701 522952 522181 524244 532075 531316 525919 520723 521869 527471 528816 531453 526785 517864 516928 519905 528119 528581 523336 519186 519368 522938 529971 528472 525355 523094 521327 523986 531246 532448 527178 522436 524059 524211 529878 529595 522744 517214 517302 519100 527480 528958 522515 518368 511131 514219 521327 519140 520064 514359 514762 516465 523043 522854 518937 512101 517782 522235 524160 523538 516403 507941 509350 513072 520477 521713 515407 508682 508496 513800 519292 520122 518195 514026 514995 517464 522428 524720 519658 511486 513664 520613 522742 520626 516188 507920 515157 518462 522784 525339 518365 514127 sum_num_inserts_total=75114009 sum_num_deletes_by_thread=516375 522285 525969 524488 523048 517734 518675 523021 530992 531638 525221 521570 521612 523439 528533 530008 526499 522495 517258 521983 527280 527997 522012 517793 517200 522582 525483 525451 521174 516586 517719 520824 529562 529531 522813 516101 519917 525197 527548 528821 526401 522130 517838 520461 527184 528614 519695 514917 520687 523317 526676 526565 524057 523000 522053 523985 531054 531598 526082 520974 520406 526546 530209 530430 527218 517800 518326 519950 527633 528777 524022 518871 520008 521204 530662 528741 525017 523569 521203 524413 531921 533230 526562 522738 523805 525251 528530 529648 523789 516820 516574 519316 527113 528227 522133 518235 511728 515891 521539 517213 521513 514863 514163 517277 523623 524765 518553 512160 516215 521114 526029 524136 515550 507583 507889 512392 518553 521028 516580 508562 510447 512534 519220 519091 518510 513407 515379 516584 523663 524570 518454 512819 515070 518064 522614 520110 515141 508549 513412 517510 524131 525057 518857 514020 sum_num_deletes_total=75116751 sum_num_searches_by_thread=9300577 9394778 9471045 9461141 9433643 9294573 9357385 9406024 9560550 9558171 9450263 9377006 9398048 9455016 9506997 9536518 9485651 9405643 9325270 9391688 9480758 9510555 9385395 9313464 9319185 9384059 9447839 9465977 9398095 9267871 9324253 9384706 9538318 9528104 9408761 9280775 9369872 9446151 9505154 9514109 9473480 9385572 9312087 9355562 9449825 9509464 9369257 9275150 9386956 9425835 9493858 9484806 9396461 9404274 9399169 9432322 9581096 9565617 9465521 9369367 9385935 9489366 9545280 9542681 9474140 9333471 9301847 9353021 9509557 9512132 9443109 9344728 9352482 9410699 9532413 9523062 9436203 9419192 9394043 9441134 9580088 9585408 9491847 9398433 9435860 9456033 9517671 9524568 9425992 9312519 9295676 9345935 9463197 9522672 9394470 9344528 9200974 9248148 9375048 9337321 9367484 9261585 9263938 9306461 9423338 9431885 9335746 9229474 9290598 9378415 9438738 9423490 9289038 9124782 9148866 9230563 9354455 9381099 9298798 9165141 9162317 9233321 9363186 9341725 9337437 9245771 9271132 9300860 9414140 9450781 9346755 9211745 9275732 9348931 9404123 9381237 9301520 9155033 9253880 9330630 9416596 9454932 9347210 9231679 sum_num_searches_total=1352104517 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=10334573 10439091 10523275 10511088 10479867 10329039 10395640 10451286 10622359 10619992 10500743 10419854 10442130 10503264 10563764 10596301 10539579 10451260 10361375 10435232 10534493 10567026 10428621 10349647 10353375 10427631 10497423 10516462 10440554 10298165 10359930 10427400 10597426 10587456 10453274 10312912 10410691 10495278 10560164 10571740 10526045 10428790 10347077 10395885 10500489 10566272 10409370 10304675 10429680 10471810 10548306 10538891 10443219 10450226 10443403 10480551 10644225 10628531 10517522 10411064 10428210 10543383 10604305 10604564 10528143 10369135 10337101 10392876 10565309 10569490 10490467 10382785 10391858 10454841 10593046 10580275 10486575 10465855 10436573 10489533 10643255 10651086 10545587 10443607 10483724 10505495 10576079 10583811 10472525 10346553 10329552 10384351 10517790 10579857 10439118 10381131 10223833 10278258 10417914 10373674 10409061 10290807 10292863 10340203 10470004 10479504 10373236 10253735 10324595 10421764 10488927 10471164 10320991 10140306 10166105 10256027 10393485 10423840 10330785 10182385 10181260 10259655 10401698 10380938 10374142 10273204 10301506 10334908 10460231 10500071 10384867 10236050 10304466 10387608 10449479 10421973 10332849 10171502 10282449 10366602 10463511 10505328 10384432 10259826 average_num_operations_total=10432883 stdev_num_operations_total=9263 sum_num_operations_total=1502335277 min_num_operations_total=10140306 max_num_operations_total=10651086 first_time_thread_terminate_by_thread=10000138 10000141 10000141 10000138 10000140 10000138 10000139 10000138 10000138 10000137 10000138 10000138 10000139 10000138 10000138 10000140 10000139 10000138 10000138 10000138 10000138 10000141 10000141 10000139 10000138 10000141 10000141 10000141 10000140 10000138 10000139 10000138 10000138 10000137 10000138 10000138 10000139 10000138 10000138 10000140 10000139 10000138 10000138 10000138 10000138 10000141 10000141 10000139 10000139 10000138 10000141 10000141 10000140 10000140 10000141 10000138 10000140 10000138 10000138 10000141 10000137 10000141 10000140 10000138 10000138 10000140 10000140 10000140 10000137 10000138 10000139 10000139 10000139 10000138 10000141 10000141 10000138 10000140 10000141 10000138 10000140 10000138 10000138 10000138 10000137 10000137 10000140 10000138 10000138 10000140 10000138 10000140 10000138 10000138 10000139 10000139 10000137 10000139 10000137 10000140 10000139 10000137 10000139 10000140 10000138 10000138 10000137 10000137 10000137 10000139 10000139 10000137 10000137 10000137 10000140 10000138 10000139 10000138 10000140 10000137 10000137 10000139 10000137 10000140 10000139 10000137 10000139 10000140 10000138 10000138 10000137 10000137 10000137 10000139 10000139 10000137 10000137 10000137 10000140 10000138 10000139 10000138 10000139 10000137 min_time_thread_terminate_total=10000137 max_time_thread_terminate_total=10000141 first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 4 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 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 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 3 3 3 3 min_time_thread_start_total=3 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=998377083836 threads_final_size=999071 final_keysum=998377083836 final_size=999071 validate_result=success Validation OK. Structural validation OK. total_find=1352104517 total_rq=0 total_inserts=75114009 total_deletes=75116751 total_updates=150230760 total_queries=1352104517 total_ops=1502335277 find_throughput=135210451 rq_throughput=0 update_throughput=15023076 query_throughput=135210451 total_throughput=150233527 total find : 1352104517 total rq : 0 total inserts : 75114009 total deletes : 75116751 total updates : 150230760 total queries : 1352104517 total ops : 1502335277 find throughput : 135210451 rq throughput : 0 update throughput : 15023076 query throughput : 135210451 total throughput : 150233527 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=12.9028 PAPI_L3_TCM=2.23941 PAPI_TOT_CYC=2661.81 PAPI_TOT_INS=375.523 garbage=675935230859583 total_execution_walltime=11.516s REALTIME_MAIN_END_PERF_FORMAT=6984946.144302725 [time_cmd_output] time_elapsed_sec=11.66, faults_major=0, faults_minor=99463, mem_maxresident_kb=391776, user_cputime=1611.83, sys_cputime=3.40, percent_cpu=13843% 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=1