__step=000276 __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 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000276.txt __path_data=data/data000276.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6982107.547867096 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=0.5 DEL_FRAC=0.5 RQ=0 RQSIZE=0 MAXKEY=200000 PREFILL_THREADS=96 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=96 WORK_THREADS=96 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=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 Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.009s prefilling_size=100180 prefilling_elapsed_millis=1.001s finished prefilling to size 100182 for expected size 100000 keysum=10034784515, performing 51221080 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=100182 pref_millis=1102 prefill_elapsed_ms=1130 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=1129 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6982108.840190875 REALTIME_END_PERF_FORMAT=6982118.840331579 ############################################################################### ################################## 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 1204 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 61 116 195 343 602 1020 1612 2369 3457 4763 6212 7755 9094 9923 10127 9766 8788 7284 5540 3969 2710 1785 1097 644 305 149 69 24 4 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 3 6 37 47 84 184 428 855 1281 2151 3314 4669 6416 8265 9719 10488 10744 10292 9028 7111 5228 3635 2473 1550 983 461 229 114 44 8 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 122 232 390 686 1204 2040 3224 4738 6914 9526 12424 15510 18188 19846 20254 19532 17576 14568 11080 7938 5420 3570 2194 1288 610 298 138 48 8 tree_stats_numKeysAtDepth=0 0 0 0 0 0 3 6 37 47 84 184 428 855 1281 2151 3314 4669 6416 8265 9719 10488 10744 10292 9028 7111 5228 3635 2473 1550 983 461 229 114 44 8 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.95312 1.95082 1.84052 1.87949 1.87755 1.84718 1.7902 1.7348 1.72963 1.68889 1.65211 1.6242 1.58633 1.54558 1.51028 1.48218 1.44993 1.41443 1.38029 1.35821 1.3414 1.32934 1.30728 1.29353 1.2368 1.24426 1.23154 1.17391 1.08333 1 tree_stats_height=36 tree_stats_numInternals=99846 tree_stats_numLeaves=99847 tree_stats_numNodes=199693 tree_stats_numKeys=99847 tree_stats_avgDegreeInternal=2.00001 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.5 tree_stats_avgKeyDepth=21.654 tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 3904 7424 12480 21952 38528 65280 103168 151616 221248 304832 397568 496320 582016 635072 648128 625024 562432 466176 354560 254016 173440 114240 70208 41216 19520 9536 4416 1536 256 tree_stats_sizeInBytes=6390176 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=22999 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:217560 4:452444 8:193655 16:2535 32:1 (2^01, 2^02]: 217560 (2^02, 2^03]: 452444 (2^03, 2^04]: 193655 (2^04, 2^05]: 2535 (2^05, 2^06]: 1 sum_limbo_reclamation_event_size_total=4457904 count_limbo_reclamation_event_size_by_thread=9032 9043 8970 9013 8981 8988 9018 8944 9008 9034 8976 9021 9040 9042 8989 9011 9024 9037 8980 9018 8989 9042 8973 8978 8988 9000 9012 8996 9036 8997 8966 9020 9009 9084 8969 9003 8963 9000 9026 9007 9022 9023 9084 8991 9029 9055 9004 8990 8972 9011 9063 9076 9099 9005 9070 9001 9039 9038 9013 9046 9005 9039 9054 9051 9051 9046 9027 9080 9059 9070 9059 9049 8996 9062 9059 9069 9083 8969 9020 9058 8996 9049 9030 9010 9067 9016 9038 9006 9007 9004 9024 8947 9053 9090 9050 9044 count_limbo_reclamation_event_size_total=866195 sum_limbo_reclamation_event_count_total=2099592 first_thread_announced_epoch_by_thread=45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 45998 sum_num_inserts_by_thread=100910 101293 101874 101297 101126 99862 100659 100465 102025 101732 100816 100777 100449 101266 101639 102264 101597 100318 99711 101025 101999 102149 101469 100534 100096 100675 101182 101339 101168 99998 100611 100945 101925 101604 101102 100124 99847 100381 102266 101446 100705 100721 99680 100665 101299 101712 100548 99322 101311 100934 102887 102540 101611 101448 101405 101613 102875 102731 102694 101910 101243 102487 103009 102985 102356 101254 101343 102218 102430 102541 101657 100754 100750 101103 102351 102755 101790 101226 101304 101536 101870 102648 102730 101801 101846 102059 102325 102291 101639 100516 100748 101559 103103 103264 102972 101543 sum_num_inserts_total=9740582 sum_num_deletes_by_thread=100183 101742 102156 101414 100707 99636 100030 100731 101985 102211 100920 100170 99965 101100 101667 101815 101528 100966 99803 101105 101309 102808 100905 99757 99657 101198 100822 101163 101038 100552 100321 100507 101742 102300 101230 100060 99785 100861 101120 102270 101098 100550 99442 100308 101315 101697 100637 99872 101318 101556 102879 103128 101823 101566 101535 102126 102917 102808 102645 102321 101319 102394 103485 103454 102154 100941 101302 101882 102020 102813 101689 100947 100430 100611 102884 102328 102168 101533 100970 100776 102352 103078 102382 101939 101675 101520 102369 102299 101506 100603 101119 102152 103537 103467 103362 101641 sum_num_deletes_total=9741881 sum_num_searches_by_thread=19907102 20025093 20095109 20098483 19983102 19788564 19796028 19952605 20228472 20260201 19984390 19895783 19842909 19992539 20135002 20128128 20082394 19950119 19764070 19986545 20111326 20252442 20035655 19790795 19754796 19949072 20032016 20120498 20014289 19812483 19861577 19933718 20189304 20212065 19967467 19845719 19772467 19969044 20142870 20124466 20020037 19897239 19674218 19868382 20072942 20227350 19933675 19653972 20010257 20112274 20361899 20355005 20145151 20104385 20072279 20138057 20349904 20347323 20318474 20159435 20035462 20311892 20429075 20373761 20315187 20002336 20081674 20165467 20311550 20353361 20194624 20032872 19904730 20013717 20253909 20322243 20138823 20075259 20001330 19967821 20309584 20360586 20292749 20159627 20081933 20220510 20306872 20232153 20160872 19926058 19991977 20153642 20497468 20512077 20371104 20137372 sum_num_searches_total=1928610642 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=20108195 20228128 20299139 20301194 20184935 19988062 19996717 20153801 20432482 20464144 20186126 20096730 20043323 20194905 20338308 20332207 20285519 20151403 19963584 20188675 20314634 20457399 20238029 19991086 19954549 20150945 20234020 20323000 20216495 20013033 20062509 20135170 20392971 20415969 20169799 20045903 19972099 20170286 20346256 20328182 20221840 20098510 19873340 20069355 20275556 20430759 20134860 19853166 20212886 20314764 20567665 20560673 20348585 20307399 20275219 20341796 20555696 20552862 20523813 20363666 20238024 20516773 20635569 20580200 20519697 20204531 20284319 20369567 20516000 20558715 20397970 20234573 20105910 20215431 20459144 20527326 20342781 20278018 20203604 20170133 20513806 20566312 20497861 20363367 20285454 20424089 20511566 20436743 20364017 20127177 20193844 20357353 20704108 20718808 20577438 20340556 average_num_operations_total=20292636 stdev_num_operations_total=19438 sum_num_operations_total=1948093105 min_num_operations_total=19853166 max_num_operations_total=20718808 first_time_thread_terminate_by_thread=10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000138 10000139 10000139 10000139 10000139 10000140 10000140 10000140 10000139 10000139 10000140 10000139 10000139 10000139 10000140 10000140 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000138 10000139 10000139 10000139 10000139 10000140 10000140 10000140 10000139 10000139 10000140 10000139 10000139 10000139 10000140 10000140 10000141 10000140 10000141 10000139 10000141 10000141 10000141 10000141 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000141 10000141 10000141 10000141 10000140 10000139 10000140 10000140 10000140 10000141 10000140 10000141 10000139 10000141 10000140 10000141 10000141 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000141 10000141 10000141 10000140 10000140 10000139 10000140 10000140 10000140 min_time_thread_terminate_total=10000138 max_time_thread_terminate_total=10000141 first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 4 4 3 3 3 3 3 3 3 4 4 3 3 3 3 3 3 3 3 3 3 3 4 3 4 4 3 3 3 3 3 3 3 4 4 3 3 min_time_thread_start_total=3 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=9990547900 threads_final_size=99847 final_keysum=9990547900 final_size=99847 validate_result=success Validation OK. Structural validation OK. total_find=1928610642 total_rq=0 total_inserts=9740582 total_deletes=9741881 total_updates=19482463 total_queries=1928610642 total_ops=1948093105 find_throughput=192861064 rq_throughput=0 update_throughput=1948246 query_throughput=192861064 total_throughput=194809310 total find : 1928610642 total rq : 0 total inserts : 9740582 total deletes : 9741881 total updates : 19482463 total queries : 1928610642 total ops : 1948093105 find throughput : 192861064 rq throughput : 0 update throughput : 1948246 query throughput : 192861064 total throughput : 194809310 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=4.97086 PAPI_L3_TCM=0.0565829 PAPI_TOT_CYC=1366.2 PAPI_TOT_INS=301.907 garbage=95413257298072 total_execution_walltime=11.44s REALTIME_MAIN_END_PERF_FORMAT=6982118.989479984 [time_cmd_output] time_elapsed_sec=11.57, faults_major=0, faults_minor=79532, mem_maxresident_kb=315992, user_cputime=1083.25, sys_cputime=3.51, percent_cpu=9392% 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=2