__step=000733 __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" ./drachsler_pext_bst_lock.debra -nwork 144 -nprefill 144 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000733.txt __path_data=data/data000733.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6987759.284130582 binary=./drachsler_pext_bst_lock.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=drachsler_pext_bst_lock 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=50 DEL_FRAC=50 RQ=0 RQSIZE=0 MAXKEY=20000000 PREFILL_THREADS=144 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=144 WORK_THREADS=144 RQ_THREADS=0 distribution=0 INS_DEL_FRAC=50.0 50.0 PREFILL_TYPE=PREFILL_HYBRID PREFILL_HYBRID_MIN_MS=1000 PREFILL_HYBRID_MAX_MS=5000 sizes: node=192 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.02s prefilling_size=9290629 prefilling_elapsed_millis=1.001s prefilling_size=9440193 prefilling_elapsed_millis=1.101s prefilling_size=9552868 prefilling_elapsed_millis=1.201s prefilling_size=9646174 prefilling_elapsed_millis=1.301s prefilling_size=9719955 prefilling_elapsed_millis=1.402s prefilling_size=9779227 prefilling_elapsed_millis=1.502s prefilling_size=9824577 prefilling_elapsed_millis=1.602s finished prefilling to size 9824516 for expected size 10000000 keysum=98250439245043, performing 81176930 updates; total_prefilling_elapsed_ms=1704 ms) pref_size=9824516 pref_millis=1704 prefill_elapsed_ms=1728 6node_tIxPvE_object_size=192 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=441 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6987761.261410218 REALTIME_END_PERF_FORMAT=6987771.261547769 ############################################################################### ################################## 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 1006 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.135s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 255 508 999 1916 3563 6471 11446 19404 31429 48612 71466 100701 136658 178424 225522 275809 328175 379278 424525 458943 478938 482221 468596 439440 397815 348079 295363 242964 193320 149077 110820 79799 55121 36593 23539 14925 9169 5415 2963 1600 873 453 224 130 83 41 22 11 7 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1 1 7 44 153 368 857 1944 4089 7771 14056 22875 35036 51137 70169 93882 119517 147819 177835 207428 233087 251613 261668 262346 253097 235198 210254 182101 153141 124004 97652 73728 54211 38153 25735 16669 10677 6644 4070 2252 1204 675 350 159 85 70 31 16 7 9 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 509 1006 1960 3716 6839 12303 21348 35518 56383 85522 123576 171694 229561 295691 369691 447692 527097 602360 666371 712025 733834 730264 701786 650912 583277 505617 425065 346461 273081 208472 153527 109332 74746 49274 31594 19846 12059 7033 3852 2077 1128 574 289 168 111 53 27 14 9 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 509 1006 1960 3716 6839 12303 21348 35518 56383 85522 123576 171694 229561 295691 369691 447692 527097 602360 666371 712025 733834 730264 701786 650912 583277 505617 425065 346461 273081 208472 153527 109332 74746 49274 31594 19846 12059 7033 3852 2077 1128 574 289 168 111 53 27 14 9 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99219 1.97839 1.95527 1.91837 1.88159 1.85276 1.80484 1.75482 1.70257 1.65463 1.60932 1.57449 1.5411 1.51083 1.48757 1.46494 1.44433 1.42323 1.4015 1.37979 1.35799 1.33801 1.31932 1.30133 1.28493 1.27009 1.25652 1.24349 1.23022 1.2175 1.20486 1.19236 1.1795 1.16965 1.16347 1.15576 1.14562 1.13417 1.1264 1.12383 1.12277 1.10727 1.11324 1.13149 1.16667 1.10811 1.09434 1.11111 1.14286 1 tree_stats_height=58 tree_stats_numInternals=6541960 tree_stats_numLeaves=3453895 tree_stats_numNodes=9995855 tree_stats_numKeys=9995855 tree_stats_avgDegreeInternal=1.52796 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.34553 tree_stats_avgKeyDepth=29.3558 tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24576 49152 97728 193152 376320 713472 1313088 2362176 4098816 6819456 10825536 16420224 23726592 32965248 44075712 56772672 70980672 85956864 101202624 115653120 127943232 136708800 140896128 140210688 134742912 124975104 111989184 97078464 81612480 66520512 52431552 40026624 29477184 20991744 14351232 9460608 6066048 3810432 2315328 1350336 739584 398784 216576 110208 55488 32256 21312 10176 5184 2688 1728 tree_stats_sizeInBytes=1919204160 6node_tIxPvE_object_size=192 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=3028 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:0 16:0 32:0 64:2 128:41732 256:330506 (2^06, 2^07]: 2 (2^07, 2^08]: 41732 (2^08, 2^09]: 330506 sum_limbo_reclamation_event_size_total=112807275 count_limbo_reclamation_event_size_by_thread=2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 2585 count_limbo_reclamation_event_size_total=372240 sum_limbo_reclamation_event_count_total=372528 first_thread_announced_epoch_by_thread=6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 6056 sum_num_inserts_by_thread=1562366 1550943 1591775 1559879 1553447 1563106 1551713 1555590 1571720 1573787 1576024 1585075 1550697 1600105 1565559 1590644 1564566 1589883 1543252 1547580 1601474 1568412 1553356 1580183 1538608 1549311 1565646 1581301 1553918 1538067 1572554 1578341 1573608 1598937 1558512 1583900 1574512 1598901 1589429 1567383 1583258 1591010 1542078 1550657 1598529 1570284 1551228 1578849 1545858 1587866 1561187 1560936 1568462 1563464 1565088 1547482 1565164 1565856 1559081 1546636 1594651 1561903 1568071 1562666 1553259 1561891 1577812 1544341 1563966 1587864 1552601 1539594 1563566 1593210 1580234 1564137 1551437 1544670 1543321 1550139 1568150 1593956 1575156 1546126 1591867 1578707 1587776 1563296 1555552 1540654 1580900 1564396 1583715 1565992 1553706 1543734 1577893 1545376 1568199 1559773 1569515 1572764 1587267 1583694 1611321 1597429 1552599 1578251 1553005 1599168 1565386 1592376 1590576 1545478 1569316 1573379 1586925 1607195 1555385 1548347 1580473 1574444 1568081 1589236 1568447 1544957 1587632 1561297 1611009 1570462 1584712 1585612 1560019 1603450 1595038 1569558 1597783 1546936 1543214 1552551 1567618 1604935 1584529 1550319 sum_num_inserts_total=226022982 sum_num_deletes_by_thread=1564682 1551163 1591562 1560130 1556313 1565600 1551789 1553542 1570628 1575077 1576607 1586322 1551901 1600941 1565041 1591946 1563431 1590274 1541915 1549199 1601991 1568206 1549814 1580531 1540646 1551362 1565101 1582361 1553619 1538190 1573235 1579790 1572483 1598599 1557507 1586147 1573258 1597468 1588424 1566740 1582210 1590710 1539418 1550863 1602886 1570443 1553170 1579650 1543422 1588770 1562288 1559997 1570272 1565387 1566400 1547702 1565842 1568204 1558207 1543399 1596343 1558529 1569239 1563346 1553126 1558841 1579950 1541675 1565894 1588191 1549048 1539087 1561324 1589568 1584725 1567270 1551979 1544695 1541356 1548692 1566668 1590661 1575159 1545235 1591223 1581668 1593330 1561975 1554739 1541761 1581136 1562906 1582438 1566329 1551163 1544008 1577419 1545813 1568881 1560293 1569377 1570440 1589217 1584726 1609244 1597191 1554411 1576803 1550929 1598939 1568158 1595265 1592373 1545006 1569014 1573637 1588637 1607799 1557818 1545984 1580574 1577502 1568651 1591083 1567134 1542498 1588931 1558945 1609984 1571144 1582928 1584392 1561811 1603487 1596599 1571333 1596074 1546509 1546988 1549846 1566642 1608704 1582743 1548664 sum_num_deletes_total=226036592 sum_num_searches_by_thread= sum_num_searches_total= sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=3127048 3102106 3183337 3120009 3109760 3128706 3103502 3109132 3142348 3148864 3152631 3171397 3102598 3201046 3130600 3182590 3127997 3180157 3085167 3096779 3203465 3136618 3103170 3160714 3079254 3100673 3130747 3163662 3107537 3076257 3145789 3158131 3146091 3197536 3116019 3170047 3147770 3196369 3177853 3134123 3165468 3181720 3081496 3101520 3201415 3140727 3104398 3158499 3089280 3176636 3123475 3120933 3138734 3128851 3131488 3095184 3131006 3134060 3117288 3090035 3190994 3120432 3137310 3126012 3106385 3120732 3157762 3086016 3129860 3176055 3101649 3078681 3124890 3182778 3164959 3131407 3103416 3089365 3084677 3098831 3134818 3184617 3150315 3091361 3183090 3160375 3181106 3125271 3110291 3082415 3162036 3127302 3166153 3132321 3104869 3087742 3155312 3091189 3137080 3120066 3138892 3143204 3176484 3168420 3220565 3194620 3107010 3155054 3103934 3198107 3133544 3187641 3182949 3090484 3138330 3147016 3175562 3214994 3113203 3094331 3161047 3151946 3136732 3180319 3135581 3087455 3176563 3120242 3220993 3141606 3167640 3170004 3121830 3206937 3191637 3140891 3193857 3093445 3090202 3102397 3134260 3213639 3167272 3098983 average_num_operations_total=3139302 stdev_num_operations_total=3062 sum_num_operations_total=452059574 min_num_operations_total=3076257 max_num_operations_total=3220993 first_time_thread_terminate_by_thread=10000136 10000139 10000140 10000136 10000135 10000136 10000137 10000139 10000136 10000137 10000136 10000140 10000136 10000136 10000139 10000138 10000138 10000136 10000135 10000138 10000137 10000136 10000138 10000141 10000137 10000139 10000142 10000137 10000138 10000137 10000136 10000137 10000136 10000137 10000136 10000140 10000137 10000136 10000137 10000139 10000138 10000136 10000139 10000137 10000137 10000136 10000137 10000140 10000136 10000142 10000136 10000136 10000136 10000136 10000141 10000139 10000140 10000139 10000136 10000136 10000138 10000136 10000137 10000142 10000140 10000138 10000137 10000136 10000136 10000138 10000139 10000140 10000136 10000141 10000141 10000136 10000136 10000136 10000141 10000138 10000141 10000139 10000136 10000136 10000138 10000137 10000138 10000140 10000140 10000156 10000137 10000140 10000140 10000138 10000140 10000140 10000139 10000142 10000140 10000142 10000139 10000137 10000141 10000142 10000141 10000142 10000138 10000142 10000139 10000140 10000139 10000142 10000141 10000142 10000140 10000141 10000142 10000140 10000138 10000141 10000139 10000142 10000140 10000141 10000136 10000139 10000136 10000142 10000137 10000142 10000138 10000142 10000138 10000142 10000139 10000142 10000141 10000141 10000136 10000141 10000141 10000140 10000136 10000141 min_time_thread_terminate_total=10000135 max_time_thread_terminate_total=10000156 first_time_thread_start_by_thread=4 3 4 4 4 4 3 4 4 3 4 3 3 4 4 4 4 4 4 4 4 4 3 3 4 3 4 4 4 4 3 4 4 3 4 3 3 4 4 4 4 4 4 4 4 4 3 3 4 4 4 4 4 4 4 4 4 4 3 4 3 4 3 3 4 4 4 3 4 3 4 4 4 4 4 4 4 4 4 4 4 4 3 4 3 4 3 3 4 4 4 3 4 3 4 4 3 4 4 4 3 3 3 4 3 3 4 4 3 4 3 4 3 3 4 3 3 3 4 3 3 4 4 4 3 3 3 4 3 3 4 4 3 4 3 4 3 3 4 3 3 3 4 3 min_time_thread_start_total=3 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=99964455662903 threads_final_size=9995855 final_keysum=99964455662903 final_size=9995855 validate_result=success Validation OK. Structural validation OK. total_find=0 total_rq=0 total_inserts=226022982 total_deletes=226036592 total_updates=452059574 total_queries=0 total_ops=452059574 find_throughput=0 rq_throughput=0 update_throughput=45205957 query_throughput=0 total_throughput=45205957 total find : 0 total rq : 0 total inserts : 226022982 total deletes : 226036592 total updates : 452059574 total queries : 0 total ops : 452059574 find throughput : 0 rq throughput : 0 update throughput : 45205957 query throughput : 0 total throughput : 45205957 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=40.5266 PAPI_L3_TCM=13.2962 PAPI_TOT_CYC=8861.35 PAPI_TOT_INS=714.104 garbage=0 total_execution_walltime=12.185s REALTIME_MAIN_END_PERF_FORMAT=6987771.470327619 [time_cmd_output] time_elapsed_sec=12.46, faults_major=0, faults_minor=579525, mem_maxresident_kb=2296644, user_cputime=1698.07, sys_cputime=8.23, percent_cpu=13688% timeout=false algorithm=drachsler_pext_bst_lock.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=1