__step=000505 __cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 180 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_sigouin_int_avl_tm_auto.debra.hytm1 -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000505.txt __path_data=data/data000505.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=7000894.578289063 binary=./brown_sigouin_int_avl_tm_auto.debra.hytm1 parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=brown_sigouin_int_avl_tm_auto 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=200000 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 sizes: node=48 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 HyTM1 system ready Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.006s prefilling_size=99862 prefilling_elapsed_millis=1.001s finished prefilling to size 99866 for expected size 100000 keysum=10010511155, performing 10388525 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=99866 pref_millis=1102 prefill_elapsed_ms=1122 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=7000895.890307828 REALTIME_END_PERF_FORMAT=7000905.890450898 ############################################################################### ################################## 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 1024 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.054s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8130 14316 16430 8717 1657 61 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 59 1701 9761 17949 10879 2097 74 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8189 16017 26191 26666 12536 2158 74 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8189 16017 26191 26666 12536 2158 74 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99927 1.96312 1.7414 1.39082 1.14322 1.03996 1.00602 1 tree_stats_height=20 tree_stats_numInternals=57502 tree_stats_numLeaves=42520 tree_stats_numNodes=100022 tree_stats_numKeys=100022 tree_stats_avgDegreeInternal=1.73945 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.42511 tree_stats_avgKeyDepth=14.9336 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 [2^00, 2^01]: 0 sum_limbo_reclamation_event_size_total= count_limbo_reclamation_event_size_by_thread= count_limbo_reclamation_event_size_total= sum_limbo_reclamation_event_count_total=933359 first_thread_announced_epoch_by_thread=39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39892 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 39894 sum_num_inserts_by_thread=438312 440981 443206 445714 440144 438922 440765 445051 447554 448102 442308 443109 439120 444735 446516 447354 445076 440607 438973 444698 445105 447661 443059 438961 441404 440536 445589 445297 442897 440799 439319 444521 445879 447675 441134 435472 438708 444051 444007 445863 443969 440107 437890 442199 443026 447342 439900 438896 sum_num_inserts_total=21252513 sum_num_deletes_by_thread=439062 440500 443834 446221 441711 437258 440794 444861 447621 448550 442541 441169 440274 444439 446484 446975 446097 440983 440473 443694 446058 447467 442467 439886 440732 440716 444717 445489 442724 440653 440345 443985 447207 448571 442411 436168 438877 443379 443707 445175 444897 439574 437279 442636 444135 446672 440359 438686 sum_num_deletes_total=21258513 sum_num_searches_by_thread=7896201 7938005 7973540 8024386 7930094 7883719 7922088 7993027 8051444 8070806 7957660 7953753 7905865 8000479 8040350 8048574 8032361 7947321 7914843 7989283 8012613 8042752 7971605 7909643 7927804 7939622 8015155 8008939 7952362 7929244 7914910 7988087 8038184 8066591 7945181 7848071 7881830 7977495 7982403 8017336 7987090 7922992 7876828 7941559 7977590 8038008 7916466 7904270 sum_num_searches_total=382408429 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=8773575 8819486 8860580 8916321 8811949 8759899 8803647 8882939 8946619 8967458 8842509 8838031 8785259 8889653 8933350 8942903 8923534 8828911 8794289 8877675 8903776 8937880 8857131 8788490 8809940 8820874 8905461 8899725 8837983 8810696 8794574 8876593 8931270 8962837 8828726 8719711 8759415 8864925 8870117 8908374 8875956 8802673 8751997 8826394 8864751 8932022 8796725 8781852 average_num_operations_total=8852488 stdev_num_operations_total=9092 sum_num_operations_total=424919455 min_num_operations_total=8719711 max_num_operations_total=8967458 first_time_thread_terminate_by_thread=10000147 10000147 10000147 10000147 10000146 10000147 10000147 10000147 10000147 10000147 10000148 10000146 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000146 10000148 10000147 10000147 10000147 10000147 10000146 10000147 10000148 10000148 10000146 10000147 10000148 10000146 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000146 10000148 min_time_thread_terminate_total=10000146 max_time_thread_terminate_total=10000148 first_time_thread_start_by_thread=3 3 2 3 2 3 3 2 3 3 3 2 3 3 2 3 2 3 3 3 3 3 2 3 3 3 3 3 2 3 3 2 3 3 3 2 3 3 2 3 2 3 3 3 3 3 2 3 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=10030611030 threads_final_size=100022 final_keysum=10030611030 final_size=100022 validate_result=success Validation OK. Structural validation OK. total_find=382408429 total_rq=0 total_inserts=21252513 total_deletes=21258513 total_updates=42511026 total_queries=382408429 total_ops=424919455 find_throughput=38240842 rq_throughput=0 update_throughput=4251102 query_throughput=38240842 total_throughput=42491945 total find : 382408429 total rq : 0 total inserts : 21252513 total deletes : 21258513 total updates : 42511026 total queries : 382408429 total ops : 424919455 find throughput : 38240842 rq throughput : 0 update throughput : 4251102 query throughput : 38240842 total throughput : 42491945 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=6.69213 PAPI_L3_TCM=0.0104619 PAPI_TOT_CYC=3078.68 PAPI_TOT_INS=2562 garbage=19114532001205 total_execution_walltime=11.434s REALTIME_MAIN_END_PERF_FORMAT=7000906.14646018 HyTM1 system shutdown: HTM_ATTEMPT_THRESH=40 [fast htm] total fast htm commit : 435096452 [slow htm] [fallback] total fallback commit : 211529 seconds global lock is held : 4.52992 [time_cmd_output] time_elapsed_sec=11.59, faults_major=0, faults_minor=386986, mem_maxresident_kb=961420, user_cputime=553.08, sys_cputime=6.05, percent_cpu=4821% timeout=false algorithm=brown_sigouin_int_avl_tm_auto.debra.hytm1 thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=1