__step=000450 __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 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000450.txt __path_data=data/data000450.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6984337.3968663 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=5 DEL_FRAC=5 RQ=0 RQSIZE=0 MAXKEY=2000000 PREFILL_THREADS=48 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=48 WORK_THREADS=48 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 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 Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.006s prefilling_size=1000236 prefilling_elapsed_millis=1.001s finished prefilling to size 1000185 for expected size 1000000 keysum=1000191353854, performing 60377609 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=1000185 pref_millis=1102 prefill_elapsed_ms=1123 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=3048 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6984338.282112682 REALTIME_END_PERF_FORMAT=6984348.282275425 ############################################################################### ################################## 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 3637 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.063s tree_stats_numInternalsAtDepth=1 1 8 63 490 3637 28476 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 195523 tree_stats_numNodesAtDepth=1 1 8 63 490 3637 28476 195523 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 998903 tree_stats_avgDegreeAtDepth=1 8 7.875 7.77778 7.42245 7.82953 6.86624 5.10888 tree_stats_height=8 tree_stats_numInternals=32676 tree_stats_numLeaves=195523 tree_stats_numNodes=228199 tree_stats_numKeys=998903 tree_stats_avgDegreeInternal=6.98369 tree_stats_avgDegreeLeaves=5.10888 tree_stats_avgDegree=5.37733 tree_stats_avgKeyDepth=7 tree_stats_bytesAtDepth=208 208 1664 13104 101920 756496 5923008 40668784 tree_stats_sizeInBytes=47465392 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=44737 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:6 2:6 4:70 8:17332 16:427460 32:34917 64:12 128:0 256:0 512:0 1024:47 [2^00, 2^01]: 6 (2^01, 2^02]: 6 (2^02, 2^03]: 70 (2^03, 2^04]: 17332 (2^04, 2^05]: 427460 (2^05, 2^06]: 34917 (2^06, 2^07]: 12 (2^07, 2^08]: 0 (2^08, 2^09]: 0 (2^09, 2^10]: 0 (2^10, 2^11]: 47 sum_limbo_reclamation_event_size_total=11573674 count_limbo_reclamation_event_size_by_thread=9997 9997 9997 9997 9996 9997 9996 9997 9997 9997 9997 9997 9996 9996 9998 9997 9996 9997 9996 9997 9997 9997 9997 9997 9996 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 count_limbo_reclamation_event_size_total=479850 sum_limbo_reclamation_event_count_total=2000863 first_thread_announced_epoch_by_thread=89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 89474 sum_num_inserts_by_thread=948383 959138 959853 954418 959455 943351 954671 952054 969971 965684 961204 953731 955059 949859 958773 961780 961550 948968 948663 960197 962710 965222 957384 946396 959316 956712 956850 957137 963168 949752 953270 956704 967403 966881 957873 945782 957179 958672 963010 955870 958643 950327 945432 946196 956364 960375 953480 946310 sum_num_inserts_total=45901180 sum_num_deletes_by_thread=949894 960683 960196 953926 959382 943632 954963 951744 970099 963479 961136 951855 956723 949962 957380 962294 963569 949833 947808 961292 962659 963219 955392 945062 956947 956982 960772 959869 962491 948267 950636 958037 969039 968439 958163 945271 957377 961853 962617 958754 957125 950844 944855 947889 956291 962699 952096 945798 sum_num_deletes_total=45909293 sum_num_searches_by_thread=17091944 17280702 17275776 17194435 17281438 16969660 17199643 17153373 17458130 17355687 17279322 17156223 17221366 17086666 17261450 17317957 17307913 17088185 17053411 17288832 17336766 17357355 17207484 17042834 17260476 17234934 17250628 17268546 17294817 17098915 17136729 17242941 17410118 17430093 17250272 17025681 17222505 17260461 17343766 17217180 17251924 17124501 17002564 17053642 17192398 17294014 17155301 17037101 sum_num_searches_total=826326059 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=18990221 19200523 19195825 19102779 19200275 18856643 19109277 19057171 19398200 19284850 19201662 19061809 19133148 18986487 19177603 19242031 19233032 18986986 18949882 19210321 19262135 19285796 19120260 18934292 19176739 19148628 19168250 19185552 19220476 18996934 19040635 19157682 19346560 19365413 19166308 18916734 19137061 19180986 19269393 19131804 19167692 19025672 18892851 18947727 19105053 19217088 19060877 18929209 average_num_operations_total=19127844 stdev_num_operations_total=18718 sum_num_operations_total=918136532 min_num_operations_total=18856643 max_num_operations_total=19398200 first_time_thread_terminate_by_thread=10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000163 10000162 10000162 10000163 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000163 10000162 10000162 10000163 10000162 10000162 min_time_thread_terminate_total=10000162 max_time_thread_terminate_total=10000163 first_time_thread_start_by_thread=3 3 3 4 3 3 3 3 3 4 3 3 4 3 3 4 4 3 3 3 4 3 4 4 3 3 3 4 3 3 3 3 3 4 3 3 4 3 3 4 4 3 3 3 4 3 4 4 min_time_thread_start_total=3 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=999035195330 threads_final_size=998903 final_keysum=999035195330 final_size=998903 validate_result=success Validation OK. Structural validation OK. total_find=826326059 total_rq=0 total_inserts=45901180 total_deletes=45909293 total_updates=91810473 total_queries=826326059 total_ops=918136532 find_throughput=82632605 rq_throughput=0 update_throughput=9181047 query_throughput=82632605 total_throughput=91813653 total find : 826326059 total rq : 0 total inserts : 45901180 total deletes : 45909293 total updates : 91810473 total queries : 826326059 total ops : 918136532 find throughput : 82632605 rq throughput : 0 update throughput : 9181047 query throughput : 82632605 total throughput : 91813653 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=10.5772 PAPI_L3_TCM=1.08586 PAPI_TOT_CYC=1409.73 PAPI_TOT_INS=377.133 garbage=413154077130928 total_execution_walltime=11.438s REALTIME_MAIN_END_PERF_FORMAT=6984348.443510009 [time_cmd_output] time_elapsed_sec=11.57, faults_major=0, faults_minor=91319, mem_maxresident_kb=366200, user_cputime=565.24, sys_cputime=3.70, percent_cpu=4914% 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