__step=000275 __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=data000275.txt __path_data=data/data000275.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6982095.844490234 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.051s prefilling_size=99969 prefilling_elapsed_millis=1s finished prefilling to size 99943 for expected size 100000 keysum=9991974188, performing 52301802 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=99943 pref_millis=1102 prefill_elapsed_ms=1126 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=1134 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6982097.215606916 REALTIME_END_PERF_FORMAT=6982107.215748246 ############################################################################### ################################## 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 960 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 249 480 888 1519 2438 3528 4754 6098 7434 8557 9247 9327 8900 8011 6928 5734 4617 3461 2536 1786 1254 761 485 310 136 68 38 21 7 3 1 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 7 18 72 257 600 1348 2302 3410 4762 6311 7867 9167 9754 9789 9094 8122 6851 5773 4386 3286 2318 1747 1037 660 484 204 98 55 35 11 5 2 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 498 960 1776 3038 4876 7056 9508 12196 14868 17114 18494 18654 17800 16022 13856 11468 9234 6922 5072 3572 2508 1522 970 620 272 136 76 42 14 6 2 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 7 18 72 257 600 1348 2302 3410 4762 6311 7867 9167 9754 9789 9094 8122 6851 5773 4386 3286 2318 1747 1037 660 484 204 98 55 35 11 5 2 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.97266 1.96386 1.925 1.85529 1.8025 1.72354 1.67375 1.64135 1.60954 1.57553 1.54032 1.50433 1.47711 1.45006 1.43241 1.41383 1.4026 1.37481 1.36637 1.35213 1.35106 1.30343 1.31866 1.31959 1.21935 1.25 1.27941 1.27632 1.16667 1.21429 1.16667 1 tree_stats_height=40 tree_stats_numInternals=99831 tree_stats_numLeaves=99832 tree_stats_numNodes=199663 tree_stats_numKeys=99832 tree_stats_avgDegreeInternal=2.00001 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.5 tree_stats_avgKeyDepth=21.1025 tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8192 15936 30720 56832 97216 156032 225792 304256 390272 475776 547648 591808 596928 569600 512704 443392 366976 295488 221504 162304 114304 80256 48704 31040 19840 8704 4352 2432 1344 448 192 64 tree_stats_sizeInBytes=6389216 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=23055 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:218994 4:451799 8:191948 16:2535 (2^01, 2^02]: 218994 (2^02, 2^03]: 451799 (2^03, 2^04]: 191948 (2^04, 2^05]: 2535 sum_limbo_reclamation_event_size_total=4439848 count_limbo_reclamation_event_size_by_thread=8979 8982 8992 9067 9021 9004 8970 9002 9004 9012 9045 9007 8957 9004 9052 8998 9044 8917 8958 9015 9060 9001 8998 8966 8995 8968 9044 9004 8982 8968 9007 9001 8990 9055 9037 9027 8941 9018 9053 9046 9016 8929 8865 8970 9018 9012 8997 8940 8970 9016 9027 9042 9028 9000 8969 9007 9049 9066 9075 9059 8980 9082 9073 9027 8973 9038 8987 9009 9054 9037 9037 9030 9023 9002 9041 9027 8964 9042 9033 8956 9046 9043 9064 9049 8997 9081 9044 9056 9031 8963 8962 9053 9096 9065 9078 8987 count_limbo_reclamation_event_size_total=865276 sum_limbo_reclamation_event_count_total=2104411 first_thread_announced_epoch_by_thread=46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 46110 sum_num_inserts_by_thread=100587 101436 101876 102548 102421 100600 100611 101893 102810 101917 101530 100465 99951 101044 102026 101999 101750 99540 98801 100567 100743 102658 101610 100032 99988 100381 101003 101901 101117 100638 100129 101033 102389 101601 101171 100496 99349 100980 101118 102101 101374 100176 98645 100162 100335 101650 100269 99384 101542 101723 102800 103166 101416 101585 100665 101133 102870 101934 103546 101872 101103 102628 103064 103496 102713 100805 100798 102674 103226 103542 102288 101012 101091 101392 103068 103100 101136 102068 101192 100868 102614 103155 102572 101787 101034 102906 102386 102692 103220 100290 100869 102368 103333 104368 103456 102787 sum_num_inserts_total=9752158 sum_num_deletes_by_thread=100248 101509 102288 102191 101698 100299 100215 100875 102590 102307 101803 100770 99381 101378 101975 101829 101427 100210 99237 100789 101280 102457 101161 100272 100224 100045 101696 102536 101936 100266 100651 101494 102736 102223 100648 100732 99396 100560 101915 101990 101309 99658 99047 101414 100819 102031 100517 98956 101165 101830 102478 102576 101361 101833 100527 100719 103087 102577 103193 101907 100856 103293 102634 103733 102689 100970 101566 102199 102539 103428 101758 101043 100611 101321 102791 102336 100628 101719 100881 100390 102457 103121 102874 102129 101528 103314 102774 102351 102497 100386 100807 101965 103451 104784 103852 102415 sum_num_deletes_total=9752331 sum_num_searches_by_thread=19884319 20111064 20163157 20305141 20101870 19911078 19899670 20048853 20322433 20282769 20082759 19964535 19773274 20026597 20149348 20216256 20105444 19794186 19664266 19940547 20004198 20262135 20021129 19763720 19799022 19883125 20024322 20229626 19973433 19932233 19868744 20038280 20281584 20243993 19954844 19869543 19655263 19993373 20121954 20196153 20072944 19768188 19546162 19838342 19961635 20262932 19921875 19656858 19993135 20111904 20346395 20398866 20069101 20159514 19989596 19954005 20426450 20281365 20311971 20232463 20072312 20392697 20353575 20483468 20327058 20042390 20049398 20264312 20393831 20493212 20204187 20014004 19929921 20025074 20327656 20370232 20010342 20121213 19927932 19946414 20402693 20417416 20343744 20223859 20076676 20374688 20403362 20371659 20262034 19937385 20011635 20306553 20485195 20665788 20502888 20307919 sum_num_searches_total=1931010663 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=20085154 20314009 20367321 20509880 20305989 20111977 20100496 20251621 20527833 20486993 20286092 20165770 19972606 20229019 20353349 20420084 20308621 19993936 19862304 20141903 20206221 20467250 20223900 19964024 19999234 20083551 20227021 20434063 20176486 20133137 20069524 20240807 20486709 20447817 20156663 20070771 19854008 20194913 20324987 20400244 20275627 19968022 19743854 20039918 20162789 20466613 20122661 19855198 20195842 20315457 20551673 20604608 20271878 20362932 20190788 20155857 20632407 20485876 20518710 20436242 20274271 20598618 20559273 20690697 20532460 20244165 20251762 20469185 20599596 20700182 20408233 20216059 20131623 20227787 20533515 20575668 20212106 20325000 20130005 20147672 20607764 20623692 20549190 20427775 20279238 20580908 20608522 20576702 20467751 20138061 20213311 20510886 20691979 20874940 20710196 20513121 average_num_operations_total=20317866 stdev_num_operations_total=23198 sum_num_operations_total=1950515152 min_num_operations_total=19743854 max_num_operations_total=20874940 first_time_thread_terminate_by_thread=10000139 10000139 10000140 10000140 10000139 10000140 10000139 10000140 10000140 10000139 10000141 10000140 10000141 10000140 10000140 10000139 10000141 10000140 10000140 10000139 10000139 10000141 10000141 10000139 10000139 10000139 10000140 10000140 10000139 10000140 10000139 10000140 10000140 10000139 10000141 10000140 10000141 10000140 10000140 10000139 10000141 10000140 10000140 10000139 10000139 10000141 10000141 10000139 10000142 10000142 10000140 10000141 10000141 10000140 10000140 10000141 10000142 10000141 10000142 10000142 10000142 10000141 10000140 10000142 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000142 10000142 10000142 10000140 10000141 10000141 10000140 10000140 10000141 10000142 10000141 10000142 10000142 10000142 10000141 10000140 10000142 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000142 min_time_thread_terminate_total=10000139 max_time_thread_terminate_total=10000142 first_time_thread_start_by_thread=4 5 5 5 4 4 5 4 5 5 4 5 5 5 5 5 5 5 5 5 4 5 4 5 4 5 5 5 4 4 5 4 5 5 4 5 5 5 5 5 5 5 5 5 4 5 4 5 5 4 5 5 5 5 5 5 5 5 4 5 5 4 5 4 5 4 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 4 5 5 4 5 4 5 4 5 5 5 5 5 5 min_time_thread_start_total=4 max_time_thread_start_total=5 sum_duration_all_ops_total= threads_final_keysum=9989365750 threads_final_size=99832 final_keysum=9989365750 final_size=99832 validate_result=success Validation OK. Structural validation OK. total_find=1931010663 total_rq=0 total_inserts=9752158 total_deletes=9752331 total_updates=19504489 total_queries=1931010663 total_ops=1950515152 find_throughput=193101066 rq_throughput=0 update_throughput=1950448 query_throughput=193101066 total_throughput=195051515 total find : 1931010663 total rq : 0 total inserts : 9752158 total deletes : 9752331 total updates : 19504489 total queries : 1931010663 total ops : 1950515152 find throughput : 193101066 rq throughput : 0 update throughput : 1950448 query throughput : 193101066 total throughput : 195051515 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=4.98721 PAPI_L3_TCM=0.0572143 PAPI_TOT_CYC=1363.68 PAPI_TOT_INS=296.968 garbage=96567141985708 total_execution_walltime=11.506s REALTIME_MAIN_END_PERF_FORMAT=6982107.363619373 [time_cmd_output] time_elapsed_sec=11.63, faults_major=0, faults_minor=79475, mem_maxresident_kb=315748, user_cputime=1086.99, sys_cputime=3.24, percent_cpu=9368% 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=1