__step=000116 __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" ./brown_ext_abtree_lf.debra -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000116.txt __path_data=data/data000116.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6980233.364131829 binary=./brown_ext_abtree_lf.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=brown_ext_abtree_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=2000000 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 size_node=208 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.06s prefilling_size=999715 prefilling_elapsed_millis=1s finished prefilling to size 999643 for expected size 1000000 keysum=999779676742, performing 44944574 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=999643 pref_millis=1102 prefill_elapsed_ms=1125 N9abtree_ns4NodeILi11ExEE_object_size=208 N9abtree_ns4NodeILi11ExEE_allocated_count=0 N9abtree_ns4NodeILi11ExEE_allocated_size=0MB N9abtree_ns4NodeILi11ExEE_get_from_pool=0 N9abtree_ns4NodeILi11ExEE_deallocated=0 N9abtree_ns4NodeILi11ExEE_limbo_count=0 N9abtree_ns4NodeILi11ExEE_limbo_details=0 0 0 global_epoch_counter=1006 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6980234.708497671 REALTIME_END_PERF_FORMAT=6980244.708582596 ############################################################################### ################################## 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 3486 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.051s tree_stats_numInternalsAtDepth=1 1 8 65 471 3486 27034 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 196653 tree_stats_numNodesAtDepth=1 1 8 65 471 3486 27034 196653 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 1000843 tree_stats_avgDegreeAtDepth=1 8 8.125 7.24615 7.40127 7.75502 7.27428 5.08939 tree_stats_height=8 tree_stats_numInternals=31066 tree_stats_numLeaves=196653 tree_stats_numNodes=227719 tree_stats_numKeys=1000843 tree_stats_avgDegreeInternal=7.33017 tree_stats_avgDegreeLeaves=5.08939 tree_stats_avgDegree=5.39508 tree_stats_avgKeyDepth=7 tree_stats_bytesAtDepth=208 208 1664 13520 97968 725088 5623072 40903824 tree_stats_sizeInBytes=47365552 N9abtree_ns4NodeILi11ExEE_object_size=208 N9abtree_ns4NodeILi11ExEE_allocated_count=0 N9abtree_ns4NodeILi11ExEE_allocated_size=0MB N9abtree_ns4NodeILi11ExEE_get_from_pool=0 N9abtree_ns4NodeILi11ExEE_deallocated=0 N9abtree_ns4NodeILi11ExEE_limbo_count=0 N9abtree_ns4NodeILi11ExEE_limbo_details=0 0 0 global_epoch_counter=23067 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:42125 2:245874 4:538516 8:123447 16:537 32:40 64:87 [2^00, 2^01]: 42125 (2^01, 2^02]: 245874 (2^02, 2^03]: 538516 (2^03, 2^04]: 123447 (2^04, 2^05]: 537 (2^05, 2^06]: 40 (2^06, 2^07]: 87 sum_limbo_reclamation_event_size_total=4646240 count_limbo_reclamation_event_size_by_thread=9910 9904 9894 9907 9897 9902 9898 9906 9915 9914 9915 9882 9908 9885 9916 9902 9923 9909 9873 9914 9907 9896 9901 9883 9891 9901 9905 9913 9906 9877 9890 9903 9910 9917 9900 9896 9916 9902 9899 9912 9899 9883 9891 9908 9904 9905 9893 9879 9912 9901 9910 9901 9883 9893 9903 9928 9895 9896 9878 9911 9899 9902 9904 9910 9914 9902 9891 9913 9904 9914 9890 9902 9908 9874 9921 9916 9898 9902 9900 9925 9905 9914 9890 9908 9896 9896 9914 9904 9907 9892 9904 9916 9897 9908 9900 9914 count_limbo_reclamation_event_size_total=950626 sum_limbo_reclamation_event_count_total=2117862 first_thread_announced_epoch_by_thread=46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 46134 sum_num_inserts_by_thread=101606 101817 102856 103778 102287 100627 101470 102017 102814 103094 100899 101557 100837 100957 101017 103413 102303 100595 99556 100857 101962 101435 101282 100480 101377 99911 101725 102583 101668 100483 100528 102157 103348 103081 101395 100412 102089 101131 102663 102897 103399 99469 98972 100482 102485 100771 100117 99612 101453 101772 102886 103332 100784 101016 101467 102307 102259 102518 101334 102164 100991 101435 102642 103884 103493 100099 100566 102439 103742 101875 101618 101637 101645 100364 101642 102643 102280 100653 100099 102044 103388 103353 102160 101963 102015 101291 102734 103811 102435 100526 100984 102585 103968 104130 103298 103597 sum_num_inserts_total=9773592 sum_num_deletes_by_thread=101060 101776 101857 103014 102652 100303 101497 101875 102353 102065 101052 101715 101369 101479 101481 102638 102612 100523 99141 101331 102265 101515 101251 100393 101891 100216 101108 101864 101869 100913 101361 101717 103179 102426 101262 100565 101642 101165 102212 102726 102747 99703 99908 100518 101674 101196 99904 99328 101453 101293 102929 102905 100993 102104 101537 102585 102886 102284 101042 101713 100394 100241 102860 103893 103347 100722 100328 102514 104068 102414 102037 101366 101850 100101 102000 103041 101429 100503 100020 102125 103883 103094 101459 102198 101745 100986 101953 103792 103041 99750 100791 103030 103745 103411 103087 103680 sum_num_deletes_total=9766933 sum_num_searches_by_thread=20139678 20186723 20326946 20509143 20325804 19990573 20126950 20179385 20381148 20338878 19965416 20121103 20053724 20035389 19998053 20395122 20279769 19967944 19742065 20047656 20258984 20093743 19984849 19846871 20076366 19809944 20063675 20283179 20197674 19876557 19989406 20114332 20496298 20345097 20031117 19859042 20162912 20042894 20218253 20337238 20314858 19839305 19707573 19850971 20209753 19877441 19708369 19718577 20122265 20058414 20352976 20474026 19993742 20100694 20044833 20299439 20363195 20302803 20014662 20250323 19920932 19983956 20206372 20516157 20405037 19860207 19902112 20274504 20511901 20201933 20206192 20144680 20083625 19889198 20196301 20369254 20127518 19895232 19866061 20276680 20456780 20334631 20133427 20175576 20122014 20046029 20298864 20532923 20378693 19871413 19943065 20358087 20618659 20505885 20464872 20582669 sum_num_searches_total=1934465558 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=20342344 20390316 20531659 20715935 20530743 20191503 20329917 20383277 20586315 20544037 20167367 20324375 20255930 20237825 20200551 20601173 20484684 20169062 19940762 20249844 20463211 20296693 20187382 20047744 20279634 20010071 20266508 20487626 20401211 20077953 20191295 20318206 20702825 20550604 20233774 20060019 20366643 20245190 20423128 20542861 20521004 20038477 19906453 20051971 20413912 20079408 19908390 19917517 20325171 20261479 20558791 20680263 20195519 20303814 20247837 20504331 20568340 20507605 20217038 20454200 20122317 20185632 20411874 20723934 20611877 20061028 20103006 20479457 20719711 20406222 20409847 20347683 20287120 20089663 20399943 20574938 20331227 20096388 20066180 20480849 20664051 20541078 20337046 20379737 20325774 20248306 20503551 20740526 20584169 20071689 20144840 20563702 20826372 20713426 20671257 20789946 average_num_operations_total=20354230 stdev_num_operations_total=22731 sum_num_operations_total=1954006083 min_num_operations_total=19906453 max_num_operations_total=20826372 first_time_thread_terminate_by_thread=10000085 10000084 10000085 10000085 10000084 10000084 10000085 10000084 10000085 10000085 10000085 10000085 10000085 10000085 10000085 10000085 10000084 10000085 10000085 10000084 10000085 10000084 10000085 10000085 10000085 10000084 10000085 10000085 10000084 10000084 10000085 10000084 10000085 10000085 10000085 10000085 10000085 10000085 10000085 10000085 10000084 10000085 10000085 10000084 10000085 10000084 10000085 10000085 10000084 10000085 10000084 10000085 10000084 10000084 10000085 10000085 10000085 10000084 10000084 10000085 10000085 10000085 10000085 10000084 10000085 10000084 10000084 10000085 10000085 10000085 10000085 10000085 10000084 10000085 10000084 10000085 10000084 10000084 10000085 10000085 10000085 10000084 10000084 10000085 10000085 10000085 10000085 10000084 10000085 10000084 10000084 10000085 10000085 10000085 10000085 10000085 min_time_thread_terminate_total=10000084 max_time_thread_terminate_total=10000085 first_time_thread_start_by_thread=6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 7 7 6 6 6 6 6 6 7 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 7 7 6 6 6 6 6 6 7 6 6 6 6 5 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 7 6 6 6 6 5 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 7 min_time_thread_start_total=5 max_time_thread_start_total=7 sum_duration_all_ops_total= threads_final_keysum=1001356178256 threads_final_size=1000843 final_keysum=1001356178256 final_size=1000843 validate_result=success Validation OK. Structural validation OK. total_find=1934465558 total_rq=0 total_inserts=9773592 total_deletes=9766933 total_updates=19540525 total_queries=1934465558 total_ops=1954006083 find_throughput=193446555 rq_throughput=0 update_throughput=1954052 query_throughput=193446555 total_throughput=195400608 total find : 1934465558 total rq : 0 total inserts : 9773592 total deletes : 9766933 total updates : 19540525 total queries : 1934465558 total ops : 1954006083 find throughput : 193446555 rq throughput : 0 update throughput : 1954052 query throughput : 193446555 total throughput : 195400608 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=10.3483 PAPI_L3_TCM=1.22871 PAPI_TOT_CYC=1326.34 PAPI_TOT_INS=350.267 garbage=967698147028771 total_execution_walltime=11.507s REALTIME_MAIN_END_PERF_FORMAT=6980244.873569389 [time_cmd_output] time_elapsed_sec=11.63, faults_major=0, faults_minor=97839, mem_maxresident_kb=388668, user_cputime=1092.12, sys_cputime=2.96, percent_cpu=9408% timeout=false algorithm=brown_ext_abtree_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