__step=000374 __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" ./ellen_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 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000374.txt __path_data=data/data000374.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6983320.16387114 binary=./ellen_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=ellen_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=20000000 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=40 descriptor=64 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.041s prefilling_size=7951555 prefilling_elapsed_millis=1s prefilling_size=8225243 prefilling_elapsed_millis=1.1s prefilling_size=8450430 prefilling_elapsed_millis=1.201s prefilling_size=8659600 prefilling_elapsed_millis=1.301s prefilling_size=8832416 prefilling_elapsed_millis=1.401s prefilling_size=8983861 prefilling_elapsed_millis=1.501s prefilling_size=9116483 prefilling_elapsed_millis=1.601s prefilling_size=9228539 prefilling_elapsed_millis=1.702s prefilling_size=9326004 prefilling_elapsed_millis=1.802s prefilling_size=9409883 prefilling_elapsed_millis=1.902s prefilling_size=9486099 prefilling_elapsed_millis=2.002s prefilling_size=9554371 prefilling_elapsed_millis=2.102s prefilling_size=9612898 prefilling_elapsed_millis=2.203s prefilling_size=9661594 prefilling_elapsed_millis=2.303s prefilling_size=9706311 prefilling_elapsed_millis=2.403s prefilling_size=9744320 prefilling_elapsed_millis=2.503s prefilling_size=9778114 prefilling_elapsed_millis=2.604s prefilling_size=9807140 prefilling_elapsed_millis=2.704s finished prefilling to size 9807209 for expected size 10000000 keysum=98039811616143, performing 78759651 updates; total_prefilling_elapsed_ms=2806 ms) pref_size=9807209 pref_millis=2806 prefill_elapsed_ms=2820 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=630 6info_tIxPvE_object_size=64 6info_tIxPvE_allocated_count=0 6info_tIxPvE_allocated_size=0MB 6info_tIxPvE_get_from_pool=0 6info_tIxPvE_deallocated=0 6info_tIxPvE_limbo_count=0 6info_tIxPvE_limbo_details=0 0 0 global_epoch_counter=0 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6983323.126458852 REALTIME_END_PERF_FORMAT=6983333.126597534 ############################################################################### ################################## 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 1000 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.127s tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 254 500 968 1879 3484 6344 11106 18867 31063 49248 75322 110611 156991 215337 285568 366883 454407 542430 623683 692124 737400 757248 749270 714611 658450 585199 502795 416503 332992 257619 192831 140016 99906 69011 46727 31023 19869 12455 7693 4603 2677 1438 728 307 142 57 20 10 4 3 0 tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 2 8 32 57 274 624 1582 3345 6671 12878 23174 40033 64231 98645 145106 204253 279359 366384 461177 555242 646848 717552 765226 783929 770772 731701 667603 589087 500014 408365 322407 245646 180126 130801 91295 62431 42177 27283 17217 10783 6529 3916 2148 1149 472 227 94 30 16 5 6 tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 508 1000 1936 3758 6968 12688 22212 37734 62126 98496 150644 221222 313982 430674 571136 733766 908814 1084860 1247366 1384248 1474800 1514496 1498540 1429222 1316900 1170398 1005590 833006 665984 515238 385662 280032 199812 138022 93454 62046 39738 24910 15386 9206 5354 2876 1456 614 284 114 40 20 8 6 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 2 8 32 57 274 624 1582 3345 6671 12878 23174 40033 64231 98645 145106 204253 279359 366384 461177 555242 646848 717552 765226 783929 770772 731701 667603 589087 500014 408365 322407 245646 180126 130801 91295 62431 42177 27283 17217 10783 6529 3916 2148 1149 472 227 94 30 16 5 6 tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 1.99219 1.98425 1.968 1.97056 1.92709 1.91045 1.87532 1.84941 1.82321 1.79271 1.76472 1.73425 1.70965 1.68583 1.66307 1.64237 1.61928 1.59685 1.5749 1.55487 1.53271 1.51346 1.49473 1.47687 1.46071 1.44438 1.42959 1.41419 1.39975 1.38682 1.37426 1.36305 1.35677 1.34538 1.33855 1.33196 1.32023 1.31343 1.30883 1.29917 1.29079 1.26858 1.25313 1.21085 1.23127 1.2007 1.17544 1.25 1.2 1.375 1 tree_stats_height=61 tree_stats_numInternals=9988933 tree_stats_numLeaves=9988934 tree_stats_numNodes=19977867 tree_stats_numKeys=9988932 tree_stats_avgDegreeInternal=2 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.5 tree_stats_avgKeyDepth=33.3461 tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 20320 40000 77440 150320 278720 507520 888480 1509360 2485040 3939840 6025760 8848880 12559280 17226960 22845440 29350640 36352560 43394400 49894640 55369920 58992000 60579840 59941600 57168880 52676000 46815920 40223600 33320240 26639360 20609520 15426480 11201280 7992480 5520880 3738160 2481840 1589520 996400 615440 368240 214160 115040 58240 24560 11360 4560 1600 800 320 240 tree_stats_sizeInBytes=799114680 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=3654 6info_tIxPvE_object_size=64 6info_tIxPvE_allocated_count=0 6info_tIxPvE_allocated_size=0MB 6info_tIxPvE_get_from_pool=0 6info_tIxPvE_deallocated=0 6info_tIxPvE_limbo_count=0 6info_tIxPvE_limbo_details=0 0 0 global_epoch_counter=0 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:0 16:0 32:92882 64:759440 128:18014 (2^05, 2^06]: 92882 (2^06, 2^07]: 759440 (2^07, 2^08]: 18014 sum_limbo_reclamation_event_size_total=76042839 count_limbo_reclamation_event_size_by_thread=6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 6044 count_limbo_reclamation_event_size_total=870336 sum_limbo_reclamation_event_count_total=870912 first_thread_announced_epoch_by_thread=7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 7308 sum_num_inserts_by_thread=209750 211335 212016 213813 211471 209191 210206 211390 212567 213595 211281 210918 211638 211955 212880 213829 211560 210708 209024 210304 212673 212509 209724 208853 209942 211244 212246 213002 211286 209316 209970 210856 213861 213148 210890 209686 211129 212240 213675 213313 211461 210642 209822 210723 212018 212993 209741 208546 210085 211668 212878 212933 211217 209967 210326 211896 214145 214064 212378 210630 210874 213227 214141 214551 212764 209928 209894 210566 213259 213091 212038 210901 210376 211934 213661 213060 211882 209985 211149 211881 213657 213830 212026 211138 210531 212485 214870 213886 212080 209296 209081 210296 213395 213470 211502 210181 209614 210514 213297 212677 213083 209222 210584 211374 212835 213129 211809 209684 211382 213411 212842 213750 211046 209112 210426 210607 212451 212529 211060 207430 209017 211241 212914 212767 211853 211130 210686 212068 214257 212936 212333 209473 211033 212717 213383 213151 211470 208083 209598 210874 212839 213525 211094 209214 sum_num_inserts_total=30469537 sum_num_deletes_by_thread=210423 211224 213204 212390 211511 210211 209358 211276 213557 214590 209956 210009 210659 212337 213635 213874 211499 209593 209026 210818 212517 213671 211202 208653 209786 211580 212991 213001 212552 209395 210335 210818 213496 213816 211522 209440 210932 211517 213588 214030 211431 210350 208715 209961 212352 213081 209898 208577 210621 212567 214338 213589 211304 209602 211100 211678 214002 214358 212187 211430 211038 212782 213495 213691 212729 210111 209982 210784 213624 214235 211586 209238 211062 212673 213967 212930 212248 210460 210246 211706 214133 214324 212992 211298 211205 212364 214300 214074 211660 210521 208562 210268 212766 213976 212196 210947 209805 211081 213195 212977 212422 209734 210317 211652 214625 214453 211079 210348 210692 212538 213793 214126 210988 208408 210618 210916 211714 212777 212280 209119 209986 210619 212334 212227 211558 209861 210932 211024 213932 213799 211482 209387 210939 211925 214414 213468 211469 209111 209557 211871 213219 213930 211360 208911 sum_num_deletes_total=30486278 sum_num_searches_by_thread=3776533 3794170 3830060 3829893 3815808 3770607 3790706 3806017 3844812 3849911 3801452 3782044 3802113 3824590 3840524 3841479 3815741 3791002 3769322 3791307 3817780 3837334 3790380 3755402 3774672 3796075 3831979 3828683 3813929 3771258 3788133 3804817 3847573 3845236 3798639 3784209 3798456 3819928 3844802 3843347 3812468 3788469 3764537 3788702 3813331 3839135 3788533 3752476 3788296 3815086 3838357 3840933 3807071 3785645 3798746 3813671 3853408 3854230 3818144 3795937 3801748 3826957 3848355 3845930 3820620 3774338 3770006 3791765 3845427 3840593 3811407 3786241 3785178 3813039 3838956 3842936 3812123 3790755 3792358 3811786 3857943 3856678 3823595 3800248 3807556 3827763 3845321 3846743 3816494 3774689 3763558 3790656 3838406 3836817 3804680 3775357 3776171 3797183 3830317 3829772 3826772 3790920 3798362 3814336 3843031 3856249 3812293 3777882 3804163 3820814 3843340 3840330 3800550 3757245 3770749 3791140 3814573 3834053 3802956 3753123 3776822 3802517 3827556 3833157 3815136 3786314 3797335 3812586 3851198 3848840 3816759 3778100 3804211 3828651 3850554 3849762 3804524 3762437 3774928 3793894 3829606 3845001 3811974 3763662 sum_num_searches_total=548686768 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=4196706 4216729 4255280 4256096 4238790 4190009 4210270 4228683 4270936 4278096 4222689 4202971 4224410 4248882 4267039 4269182 4238800 4211303 4187372 4212429 4242970 4263514 4211306 4172908 4194400 4218899 4257216 4254686 4237767 4189969 4208438 4226491 4274930 4272200 4221051 4203335 4220517 4243685 4272065 4270690 4235360 4209461 4183074 4209386 4237701 4265209 4208172 4169599 4209002 4239321 4265573 4267455 4229592 4205214 4220172 4237245 4281555 4282652 4242709 4217997 4223660 4252966 4275991 4274172 4246113 4194377 4189882 4213115 4272310 4267919 4235031 4206380 4206616 4237646 4266584 4268926 4236253 4211200 4213753 4235373 4285733 4284832 4248613 4222684 4229292 4252612 4274491 4274703 4240234 4194506 4181201 4211220 4264567 4264263 4228378 4196485 4195590 4218778 4256809 4255426 4252277 4209876 4219263 4237362 4270491 4283831 4235181 4197914 4226237 4246763 4269975 4268206 4222584 4174765 4191793 4212663 4238738 4259359 4226296 4169672 4195825 4224377 4252804 4258151 4238547 4207305 4218953 4235678 4279387 4275575 4240574 4196960 4226183 4253293 4278351 4276381 4227463 4179631 4194083 4216639 4255664 4272456 4234428 4181787 average_num_operations_total=4233629 stdev_num_operations_total=2514 sum_num_operations_total=609642583 min_num_operations_total=4169599 max_num_operations_total=4285733 first_time_thread_terminate_by_thread=10000139 10000139 10000138 10000139 10000139 10000141 10000141 10000142 10000139 10000139 10000140 10000142 10000140 10000139 10000139 10000138 10000139 10000138 10000141 10000138 10000139 10000142 10000142 10000139 10000141 10000142 10000138 10000139 10000139 10000141 10000138 10000141 10000139 10000141 10000139 10000140 10000138 10000139 10000140 10000138 10000139 10000138 10000141 10000138 10000139 10000142 10000142 10000139 10000139 10000142 10000140 10000139 10000137 10000138 10000138 10000140 10000138 10000142 10000141 10000140 10000139 10000137 10000137 10000137 10000140 10000139 10000138 10000138 10000138 10000142 10000139 10000139 10000139 10000142 10000140 10000139 10000137 10000137 10000138 10000140 10000138 10000142 10000141 10000140 10000139 10000138 10000142 10000137 10000140 10000139 10000138 10000138 10000138 10000142 10000139 10000139 10000142 10000138 10000139 10000140 10000140 10000138 10000140 10000137 10000137 10000139 10000140 10000140 10000138 10000139 10000138 10000140 10000142 10000137 10000138 10000140 10000137 10000138 10000141 10000138 10000141 10000138 10000139 10000140 10000140 10000140 10000140 10000140 10000137 10000139 10000140 10000140 10000141 10000137 10000138 10000137 10000142 10000137 10000138 10000140 10000137 10000138 10000141 10000138 min_time_thread_terminate_total=10000137 max_time_thread_terminate_total=10000142 first_time_thread_start_by_thread=4 5 4 4 4 4 4 4 4 4 5 5 4 4 5 5 4 4 4 4 5 4 4 5 4 5 4 5 4 4 4 4 4 4 5 5 4 4 5 5 4 4 4 4 5 4 4 5 4 4 5 4 4 5 4 4 4 4 4 4 4 4 5 5 4 4 4 4 4 5 5 4 4 4 5 4 4 5 4 4 4 4 4 4 4 4 5 5 4 4 4 4 4 5 5 4 4 4 4 4 4 4 4 4 4 5 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 5 4 4 4 4 4 4 4 4 4 4 4 4 4 4 min_time_thread_start_total=4 max_time_thread_start_total=5 sum_duration_all_ops_total= threads_final_keysum=99876680819762 threads_final_size=9988932 final_keysum=99876680819762 final_size=9988932 validate_result=success Validation OK. Structural validation OK. total_find=548686768 total_rq=0 total_inserts=30469537 total_deletes=30486278 total_updates=60955815 total_queries=548686768 total_ops=609642583 find_throughput=54868676 rq_throughput=0 update_throughput=6095581 query_throughput=54868676 total_throughput=60964258 total find : 548686768 total rq : 0 total inserts : 30469537 total deletes : 30486278 total updates : 60955815 total queries : 548686768 total ops : 609642583 find throughput : 54868676 rq throughput : 0 update throughput : 6095581 query throughput : 54868676 total throughput : 60964258 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=39.863 PAPI_L3_TCM=15.4555 PAPI_TOT_CYC=6571.65 PAPI_TOT_INS=413.638 garbage=2707125538646273 total_execution_walltime=13.381s REALTIME_MAIN_END_PERF_FORMAT=6983333.398987397 [time_cmd_output] time_elapsed_sec=13.56, faults_major=0, faults_minor=323380, mem_maxresident_kb=1272468, user_cputime=1859.78, sys_cputime=9.46, percent_cpu=13776% timeout=false algorithm=ellen_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