__step=000046 __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" ./guerraoui_ext_bst_ticket.debra -nwork 144 -nprefill 144 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000046.txt __path_data=data/data000046.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6979305.822840996 binary=./guerraoui_ext_bst_ticket.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=guerraoui_ext_bst_ticket 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=0.5 DEL_FRAC=0.5 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=0.5 0.5 PREFILL_TYPE=PREFILL_HYBRID PREFILL_HYBRID_MIN_MS=1000 PREFILL_HYBRID_MAX_MS=5000 sizes: node=40 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.04s prefilling_size=9106074 prefilling_elapsed_millis=1s prefilling_size=9256164 prefilling_elapsed_millis=1.101s prefilling_size=9377277 prefilling_elapsed_millis=1.201s prefilling_size=9477870 prefilling_elapsed_millis=1.301s prefilling_size=9560326 prefilling_elapsed_millis=1.401s prefilling_size=9632769 prefilling_elapsed_millis=1.501s prefilling_size=9691201 prefilling_elapsed_millis=1.602s prefilling_size=9739728 prefilling_elapsed_millis=1.702s prefilling_size=9779170 prefilling_elapsed_millis=1.802s prefilling_size=9814457 prefilling_elapsed_millis=1.902s finished prefilling to size 9814503 for expected size 10000000 keysum=98153510274527, performing 82842954 updates; total_prefilling_elapsed_ms=2005 ms) pref_size=9814503 pref_millis=2005 prefill_elapsed_ms=2032 6node_tIxPvE_object_size=40 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=505 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6979308.58438926 REALTIME_END_PERF_FORMAT=6979318.58574799 ############################################################################### ################################## 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.217s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 503 993 1908 3634 6793 12267 21524 36646 59830 93979 140823 201881 277021 362226 452469 541575 622591 685861 726380 743107 732995 698580 642740 571964 494062 413987 337392 266822 204533 153816 112403 79799 55593 37838 25367 16578 10406 6385 3820 2187 1217 644 342 163 86 40 16 3 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 9 13 78 182 475 1319 3010 6402 13462 25681 47135 79765 126741 191816 271983 363363 460559 559321 645342 709653 753219 767410 754420 713516 649866 574137 490582 407962 329111 255250 195229 145007 104005 73348 50309 34156 22750 14427 8950 5453 3157 1790 946 521 240 132 64 29 6 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1006 1986 3816 7268 13586 24534 43048 73292 119660 187958 281646 403762 554042 724452 904938 1083150 1245182 1371722 1452760 1486214 1465990 1397160 1285480 1143928 988124 827974 674784 533644 409066 307632 224806 159598 111186 75676 50734 33156 20812 12770 7640 4374 2434 1288 684 326 172 80 32 6 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 9 13 77 182 475 1319 3010 6402 13462 25681 47135 79765 126741 191816 271983 363363 460559 559321 645342 709653 753219 767410 754420 713516 649866 574137 490582 407962 329111 255250 195229 145007 104005 73348 50309 34156 22750 14427 8950 5453 3157 1790 946 521 240 132 64 29 6 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 1.98242 1.98708 1.96022 1.95231 1.93465 1.90291 1.87731 1.85128 1.81632 1.78538 1.74923 1.71679 1.6861 1.65379 1.62457 1.59847 1.5748 1.55081 1.52954 1.51151 1.4932 1.47652 1.46003 1.44494 1.4319 1.41896 1.40749 1.39542 1.38328 1.37602 1.36538 1.35497 1.34833 1.34031 1.33521 1.32676 1.31385 1.30679 1.29914 1.28626 1.27824 1.26459 1.26553 1.2383 1.2638 1.23256 1.2 1.09375 1 tree_stats_height=58 tree_stats_numInternals=9862300 tree_stats_numLeaves=9862301 tree_stats_numNodes=19724601 tree_stats_numKeys=9862300 tree_stats_avgDegreeInternal=2 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.5 tree_stats_avgKeyDepth=30.57 tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10240 20480 40240 79440 152640 290720 543440 981360 1721920 2931680 4786400 7518320 11265840 16150480 22161680 28978080 36197520 43326000 49807280 54868880 58110400 59448560 58639600 55886400 51419200 45757120 39524960 33118960 26991360 21345760 16362640 12305280 8992240 6383920 4447440 3027040 2029360 1326240 832480 510800 305600 174960 97360 51520 27360 13040 6880 3200 1280 240 tree_stats_sizeInBytes=788984040 6node_tIxPvE_object_size=40 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=3760 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:50788 4:190286 8:200801 16:11844 (2^01, 2^02]: 50788 (2^02, 2^03]: 190286 (2^03, 2^04]: 200801 (2^04, 2^05]: 11844 sum_limbo_reclamation_event_size_total=3239246 count_limbo_reclamation_event_size_by_thread=3148 3149 3136 3141 3153 3149 3153 3140 3153 3143 3137 3147 3154 3155 3156 3165 3144 3154 3161 3139 3154 3150 3142 3148 3145 3150 3167 3157 3141 3159 3154 3146 3175 3166 3154 3138 3146 3150 3154 3156 3175 3133 3144 3150 3161 3168 3151 3152 3160 3138 3149 3148 3148 3155 3145 3148 3165 3136 3181 3142 3158 3152 3148 3155 3149 3138 3141 3134 3142 3160 3137 3131 3155 3135 3161 3148 3163 3141 3168 3160 3140 3160 3155 3150 3159 3153 3150 3135 3142 3159 3148 3152 3158 3150 3151 3130 3143 3140 3152 3152 3143 3151 3159 3161 3159 3171 3161 3140 3175 3159 3160 3145 3144 3130 3130 3161 3143 3155 3151 3142 3162 3143 3151 3160 3145 3159 3154 3153 3166 3153 3159 3140 3166 3135 3156 3138 3154 3154 3145 3153 3156 3136 3148 3160 count_limbo_reclamation_event_size_total=453719 sum_limbo_reclamation_event_count_total=468720 first_thread_announced_epoch_by_thread=7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 7520 sum_num_inserts_by_thread=22674 22625 23040 22870 23039 22752 22677 22935 22937 22767 22830 22712 22780 22678 23099 23111 22601 22886 22899 22585 22812 22990 22771 22580 22528 22629 22901 23115 22881 22655 22861 22508 23365 23076 22626 22588 22818 22704 23308 22742 23064 22638 22753 22841 22704 23107 22781 22727 22784 23101 22984 22822 22624 22858 22875 23044 23007 22961 22864 22893 22909 22883 23107 23053 23083 22587 22536 22839 23224 22938 22833 22569 22786 22797 23166 23066 22802 22457 22872 22899 22949 22910 22981 22952 22668 22668 22989 22614 23231 22522 22449 22878 23003 23028 22708 22673 22797 22748 23074 23005 22960 22772 22647 22904 23229 23408 22845 22178 22726 22982 22843 23134 22673 22521 22710 22796 22944 23050 22640 22643 22700 23034 22928 22672 23042 22626 22568 22819 23286 23274 22858 22777 22904 22981 23225 23198 22788 22418 22373 22877 22689 23192 22672 22610 sum_num_inserts_total=3289756 sum_num_deletes_by_thread=22851 22785 22845 22952 22918 22719 22595 22705 23189 23301 23123 22559 22799 22965 23297 22789 22884 22852 22742 22891 22763 23149 22706 22212 22391 22713 23023 23076 22733 22700 22972 22633 23084 23137 22861 22575 22628 23034 23187 23077 22874 22627 22968 22649 23022 23217 22821 22604 22928 22891 22986 22905 22513 22721 22579 22532 23277 23012 22856 22606 22912 22695 23215 23344 23227 22707 22516 22981 22879 23075 22689 22614 22873 22867 22934 23008 23144 22716 22810 22865 23317 23149 22976 22652 22582 23088 23167 22787 22614 22449 22574 22949 23126 22761 22888 22567 22672 22783 22770 23221 22939 22482 22577 23099 23046 23225 22832 22766 22840 22910 23068 23092 22736 22393 22460 22657 22869 22932 22739 22671 22543 22725 22934 23117 22940 22590 22970 23086 23012 23168 23068 22672 22787 22957 23228 23090 22961 22409 22698 22884 22758 22898 22841 22404 sum_num_deletes_total=3291239 sum_num_searches_by_thread=4495040 4516598 4552825 4556392 4533088 4483553 4506832 4529582 4576064 4574442 4516966 4486576 4513297 4537377 4572156 4564955 4529557 4497841 4481671 4506581 4530175 4550021 4494437 4464619 4487777 4515306 4558623 4556502 4527818 4482936 4504190 4516965 4566530 4568331 4517713 4488694 4516543 4541617 4569241 4564653 4526307 4504899 4478344 4503760 4523020 4551550 4501217 4462023 4505126 4528221 4565276 4557862 4524076 4495618 4501444 4516604 4564587 4564304 4528752 4502459 4512883 4538318 4569600 4574763 4541854 4479852 4463644 4499023 4555753 4557917 4517532 4483125 4505455 4526429 4569442 4558457 4516955 4490637 4495975 4515992 4579952 4579987 4541869 4506905 4519473 4540580 4571242 4558858 4527087 4467960 4458689 4486545 4549328 4551592 4510055 4475453 4484916 4508592 4550230 4554666 4531794 4487895 4500281 4525924 4560465 4569972 4524165 4479908 4515945 4545056 4568617 4574548 4507360 4447844 4478670 4495863 4523644 4553831 4511083 4445013 4489828 4510590 4555351 4541628 4522456 4479386 4505593 4524034 4570425 4577380 4518504 4478271 4502163 4543713 4570759 4568127 4526138 4460518 4491844 4506208 4543194 4553554 4509280 4457947 sum_num_searches_total=651311887 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=4540565 4562008 4598710 4602214 4579045 4529024 4552104 4575222 4622190 4620510 4562919 4531847 4558876 4583020 4618552 4610855 4575042 4543579 4527312 4552057 4575750 4596160 4539914 4509411 4532696 4560648 4604547 4602693 4573432 4528291 4550023 4562106 4612979 4614544 4563200 4533857 4561989 4587355 4615736 4610472 4572245 4550164 4524065 4549250 4568746 4597874 4546819 4507354 4550838 4574213 4611246 4603589 4569213 4541197 4546898 4562180 4610871 4610277 4574472 4547958 4558704 4583896 4615922 4621160 4588164 4525146 4508696 4544843 4601856 4603930 4563054 4528308 4551114 4572093 4615542 4604531 4562901 4535810 4541657 4561756 4626218 4626046 4587826 4552509 4564723 4586336 4617398 4604259 4572932 4512931 4503712 4532372 4595457 4597381 4555651 4520693 4530385 4554123 4596074 4600892 4577693 4533149 4545505 4571927 4606740 4616605 4569842 4524852 4561511 4590948 4614528 4620774 4552769 4492758 4523840 4541316 4569457 4599813 4556462 4490327 4535071 4556349 4601213 4587417 4568438 4524602 4551131 4569939 4616723 4623822 4564430 4523720 4547854 4589651 4617212 4614415 4571887 4505345 4536915 4551969 4588641 4599644 4554793 4502961 average_num_operations_total=4568700 stdev_num_operations_total=2820 sum_num_operations_total=657892882 min_num_operations_total=4490327 max_num_operations_total=4626218 first_time_thread_terminate_by_thread=10000138 10000139 10000136 10000136 10000140 10000136 10000136 10000136 10000136 10000139 10000139 10000136 10000136 10000136 10000137 10000136 10000136 10000138 10000139 10000142 10000140 10000138 10000136 10000138 10000138 10000136 10000136 10000136 10000140 10000136 10000136 10000136 10000136 10000139 10000139 10000139 10000136 10000136 10000137 10000136 10000136 10000138 10000139 10000140 10000139 10000136 10000136 10000136 10000138 10000138 10000139 10000138 10000140 10000137 10000140 10000139 10000137 10000137 10000139 10000141 10000137 10000141 10000139 10000139 10000139 10000139 10000140 10000138 10000138 10000139 10000140 10000137 10000138 10000138 10000139 10000138 10000137 10000139 10000138 10000139 10000140 10000137 10000139 10000141 10000139 10000141 10000139 10000139 10000139 10000140 10000140 10000140 10000139 10000137 10000138 10000137 10000137 10000136 10000136 10000136 10000136 10000137 10000136 10000137 10000137 10000137 10000137 10000136 10000136 10000136 10000136 10000136 10000136 10000137 10000137 10000136 10000136 10000137 10000136 10000136 10000137 10000136 10000136 10000137 10000136 10000137 10000136 10000137 10000137 10000137 10000137 10000136 10000136 10000136 10000136 10000136 10000136 10000137 10000137 10000136 10000136 10000137 10000136 10000136 min_time_thread_terminate_total=10000136 max_time_thread_terminate_total=10000142 first_time_thread_start_by_thread=4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 5 5 4 5 5 4 4 5 5 4 5 4 4 5 4 5 4 5 4 4 4 5 5 5 5 5 4 5 5 4 4 5 5 4 5 4 4 5 4 5 4 5 4 4 4 5 5 5 5 4 4 4 5 4 4 5 5 5 4 5 4 5 5 4 5 5 5 5 5 5 4 5 5 4 4 4 5 4 4 5 5 5 4 5 4 5 5 4 5 5 5 5 5 5 4 5 min_time_thread_start_total=4 max_time_thread_start_total=5 sum_duration_all_ops_total= threads_final_keysum=98634142201485 threads_final_size=9862300 final_keysum=98634142201485 final_size=9862300 validate_result=success Validation OK. Structural validation OK. total_find=651311887 total_rq=0 total_inserts=3289756 total_deletes=3291239 total_updates=6580995 total_queries=651311887 total_ops=657892882 find_throughput=65131188 rq_throughput=0 update_throughput=658099 query_throughput=65131188 total_throughput=65789288 total find : 651311887 total rq : 0 total inserts : 3289756 total deletes : 3291239 total updates : 6580995 total queries : 651311887 total ops : 657892882 find throughput : 65131188 rq throughput : 0 update throughput : 658099 query throughput : 65131188 total throughput : 65789288 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=38.0859 PAPI_L3_TCM=15.2692 PAPI_TOT_CYC=6089 PAPI_TOT_INS=340.911 garbage=3208140857954842 total_execution_walltime=12.644s REALTIME_MAIN_END_PERF_FORMAT=6979318.468167335 [time_cmd_output] time_elapsed_sec=12.83, faults_major=0, faults_minor=314978, mem_maxresident_kb=1253976, user_cputime=1752.73, sys_cputime=6.06, percent_cpu=13698% timeout=false algorithm=guerraoui_ext_bst_ticket.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=2