__step=000510 __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 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=data000510.txt __path_data=data/data000510.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6985040.134066 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=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=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.016s prefilling_size=1001659 prefilling_elapsed_millis=1.001s finished prefilling to size 1001632 for expected size 1000000 keysum=1001669942397, performing 67269999 updates; total_prefilling_elapsed_ms=1103 ms) pref_size=1001632 pref_millis=1103 prefill_elapsed_ms=1125 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=410 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6985041.373881573 REALTIME_END_PERF_FORMAT=6985051.374015862 ############################################################################### ################################## 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 950 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.035s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 252 485 918 1714 3053 5122 8118 12385 17979 24864 32244 39866 46859 52222 55238 55742 53752 49635 43715 36968 30509 24461 18767 13792 9666 6329 4088 2459 1475 791 393 186 92 25 11 4 1 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 3 10 32 66 200 554 1135 2118 3715 5998 9431 13248 17737 22205 26060 28852 30734 30460 29190 26432 22718 19231 15850 12429 9290 6739 4442 2941 1755 1124 610 299 143 79 19 8 4 1 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 255 495 950 1780 3253 5676 9253 14503 21694 30862 41675 53114 64596 74427 81298 84594 84486 80095 72905 63400 53227 43692 34617 26221 18956 13068 8530 5400 3230 1915 1003 485 235 104 30 12 5 1 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 255 495 950 1780 3253 5676 9253 14503 21694 30862 41675 53114 64596 74427 81298 84594 84486 80095 72905 63400 53227 43692 34617 26221 18956 13068 8530 5400 3230 1915 1003 485 235 104 30 12 5 1 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.99219 1.95294 1.93939 1.90737 1.86461 1.80633 1.7278 1.69005 1.64187 1.59385 1.54472 1.50078 1.4656 1.42678 1.39066 1.36109 1.33979 1.3118 1.29053 1.27001 1.25645 1.24768 1.23245 1.21533 1.19694 1.17947 1.16843 1.15381 1.14278 1.13622 1.1107 1.09172 1.10103 1.05106 1.04808 1.03333 1.08333 1 1 tree_stats_height=46 tree_stats_numInternals=654435 tree_stats_numLeaves=345862 tree_stats_numNodes=1000297 tree_stats_numKeys=1000297 tree_stats_avgDegreeInternal=1.52849 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.34576 tree_stats_avgKeyDepth=23.733 tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24576 48960 95040 182400 341760 624576 1089792 1776576 2784576 4165248 5925504 8001600 10197888 12402432 14289984 15609216 16242048 16221312 15378240 13997760 12172800 10219584 8388864 6646464 5034432 3639552 2509056 1637760 1036800 620160 367680 192576 93120 45120 19968 5760 2304 960 192 tree_stats_sizeInBytes=192057024 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=7136 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:110 16:281469 32:686672 64:5 (2^03, 2^04]: 110 (2^04, 2^05]: 281469 (2^05, 2^06]: 686672 (2^06, 2^07]: 5 sum_limbo_reclamation_event_size_total=33665259 count_limbo_reclamation_event_size_by_thread=6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 6724 count_limbo_reclamation_event_size_total=968256 sum_limbo_reclamation_event_count_total=968544 first_thread_announced_epoch_by_thread=14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 14272 sum_num_inserts_by_thread=465711 464099 472125 472903 466370 465656 463936 464958 472205 473833 466566 464517 467465 466501 475716 471287 468203 469457 466461 469147 473474 474010 466209 466581 460196 468497 468661 472944 470698 462126 466228 469276 476038 474910 466424 464292 468820 471764 475895 471695 467746 466598 459860 463466 472419 469774 470536 466174 463082 469754 475555 473639 469323 464256 468555 466552 471785 472596 468416 466499 468508 468581 475276 475487 466461 461086 461759 467549 471193 474259 467275 466216 460744 468976 468930 474526 469695 464324 467992 465618 473223 476929 468337 466693 464129 469080 474594 470651 465032 464760 458317 463956 470016 469961 470906 463095 458642 461169 467134 469924 467699 466079 462450 465189 470197 474773 465557 461208 467094 467231 472868 470363 464445 461670 461352 466433 467633 467796 463740 462894 457749 462895 467979 463719 470513 466363 466240 464742 468543 470506 465759 459078 460744 469318 473906 474173 461936 458530 461739 466136 473132 473958 469412 458839 sum_num_inserts_total=67346022 sum_num_deletes_by_thread=464230 464440 472921 472782 467391 464969 463814 466362 472542 473406 467568 465808 467113 465579 474816 471483 469200 468683 465417 467047 473402 474873 464803 464177 459809 468787 468634 474291 472180 463185 465734 470436 475557 476400 465624 463862 468305 471926 475817 470640 468797 465814 461400 465717 473333 471898 469022 465505 462502 470071 475126 473940 469908 464739 469521 467035 473163 473190 468108 467274 467705 467243 474336 475332 467330 460502 459362 468440 470037 474428 466385 467652 462515 469749 471181 472237 469747 465877 468197 467953 474165 477367 469111 465245 467042 468701 474095 470903 465305 464370 459212 463245 469388 469596 468805 463920 459278 463227 465751 469517 468575 467571 463109 465786 470384 475201 465884 461529 467613 466887 472931 469270 463554 461537 460578 465238 468289 467857 464765 460724 457979 463302 468349 466064 470349 467311 466376 464778 470799 470910 464432 458210 462826 470153 472209 472676 461379 460324 460709 465149 473852 474723 469875 458453 sum_num_deletes_total=67362996 sum_num_searches_by_thread=8363707 8338941 8506904 8512537 8407233 8373625 8348552 8397346 8479497 8512927 8402712 8357232 8425070 8406879 8560517 8483328 8442434 8452588 8383019 8438590 8517069 8543257 8370456 8381719 8286748 8421998 8435059 8529267 8488788 8305826 8396743 8469241 8557596 8569533 8392793 8337228 8437182 8488573 8563356 8481101 8440151 8383807 8296574 8358164 8513393 8473540 8457313 8383553 8342124 8444998 8537265 8512918 8451140 8371717 8433665 8409642 8517198 8514597 8427429 8405108 8438656 8417997 8541753 8552983 8410908 8288848 8290522 8407982 8477003 8529192 8406693 8409933 8300227 8435011 8461076 8540178 8462794 8379592 8443779 8416565 8528067 8597768 8447482 8370515 8377269 8426187 8541727 8478889 8386686 8357706 8269095 8325118 8465780 8456253 8463847 8330287 8262367 8319018 8401867 8464849 8435024 8398150 8332930 8377910 8465570 8539337 8374582 8299168 8421638 8416203 8522002 8459979 8359191 8314999 8291698 8374655 8413156 8442423 8352542 8314569 8248158 8353849 8417402 8374962 8463602 8381954 8385845 8356810 8464379 8465360 8369761 8271222 8316152 8454713 8496406 8495453 8324194 8262189 8310712 8368345 8525708 8542796 8462448 8271977 sum_num_searches_total=1212414059 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=9293648 9267480 9451950 9458222 9340994 9304250 9276302 9328666 9424244 9460166 9336846 9287557 9359648 9338959 9511049 9426098 9379837 9390728 9314897 9374784 9463945 9492140 9301468 9312477 9206753 9359282 9372354 9476502 9431666 9231137 9328705 9408953 9509191 9520843 9324841 9265382 9374307 9432263 9515068 9423436 9376694 9316219 9217834 9287347 9459145 9415212 9396871 9315232 9267708 9384823 9487946 9460497 9390371 9300712 9371741 9343229 9462146 9460383 9363953 9338881 9374869 9353821 9491365 9503802 9344699 9210436 9211643 9343971 9418233 9477879 9340353 9343801 9223486 9373736 9401187 9486941 9402236 9309793 9379968 9350136 9475455 9552064 9384930 9302453 9308440 9363968 9490416 9420443 9317023 9286836 9186624 9252319 9405184 9395810 9403558 9257302 9180287 9243414 9334752 9404290 9371298 9331800 9258489 9308885 9406151 9489311 9306023 9221905 9356345 9350321 9467801 9399612 9287190 9238206 9213628 9306326 9349078 9378076 9281047 9238187 9163886 9280046 9353730 9304745 9404464 9315628 9318461 9286330 9403721 9406776 9299952 9188510 9239722 9394184 9442521 9442302 9247509 9181043 9233160 9299630 9472692 9491477 9401735 9189269 average_num_operations_total=9355021 stdev_num_operations_total=7338 sum_num_operations_total=1347123077 min_num_operations_total=9163886 max_num_operations_total=9552064 first_time_thread_terminate_by_thread=10000136 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000135 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000136 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000136 10000135 10000134 10000134 10000137 10000136 10000135 10000135 10000137 10000137 10000134 10000134 10000134 10000136 10000134 10000134 10000136 10000134 10000134 10000134 10000134 10000134 10000136 10000134 10000136 10000135 10000134 10000134 10000137 10000136 10000135 10000135 10000137 10000137 10000134 10000134 10000134 10000136 10000134 10000134 10000136 10000134 10000137 10000137 10000134 10000134 10000137 10000134 10000135 10000137 10000136 10000136 10000136 10000136 10000136 10000135 10000135 10000137 10000135 10000135 10000136 10000135 10000135 10000135 10000135 10000136 10000135 10000135 10000135 10000136 10000136 10000136 10000135 10000137 10000136 10000136 10000136 10000136 10000136 10000135 10000137 10000135 10000135 10000135 10000136 10000135 10000135 10000135 10000135 10000136 10000135 10000135 10000135 10000136 10000136 10000136 min_time_thread_terminate_total=10000134 max_time_thread_terminate_total=10000137 first_time_thread_start_by_thread=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 4 3 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 4 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=1000760036297 threads_final_size=1000297 final_keysum=1000760036297 final_size=1000297 validate_result=success Validation OK. Structural validation OK. total_find=1212414059 total_rq=0 total_inserts=67346022 total_deletes=67362996 total_updates=134709018 total_queries=1212414059 total_ops=1347123077 find_throughput=121241405 rq_throughput=0 update_throughput=13470901 query_throughput=121241405 total_throughput=134712307 total find : 1212414059 total rq : 0 total inserts : 67346022 total deletes : 67362996 total updates : 134709018 total queries : 1212414059 total ops : 1347123077 find throughput : 121241405 rq throughput : 0 update throughput : 13470901 query throughput : 121241405 total throughput : 134712307 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=13.4423 PAPI_L3_TCM=2.50157 PAPI_TOT_CYC=2976.04 PAPI_TOT_INS=371.268 garbage=606181857110770 total_execution_walltime=11.561s REALTIME_MAIN_END_PERF_FORMAT=6985051.561841270 [time_cmd_output] time_elapsed_sec=11.70, faults_major=0, faults_minor=135484, mem_maxresident_kb=535048, user_cputime=1623.71, sys_cputime=5.13, percent_cpu=13918% 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=2