__step=000506 __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=data000506.txt __path_data=data/data000506.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=7000906.245002261 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.023s prefilling_size=99594 prefilling_elapsed_millis=1.001s finished prefilling to size 99594 for expected size 100000 keysum=9953875004, performing 10421882 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=99594 pref_millis=1102 prefill_elapsed_ms=1125 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=7000907.538512847 REALTIME_END_PERF_FORMAT=7000917.538653210 ############################################################################### ################################## 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.039s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8088 14187 16255 8910 1671 52 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 97 1739 9723 17636 11189 2108 58 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8185 15926 25978 26546 12860 2160 58 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8185 15926 25978 26546 12860 2160 58 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99829 1.95761 1.74036 1.39614 1.1488 1.03802 1.00278 1 tree_stats_height=20 tree_stats_numInternals=57354 tree_stats_numLeaves=42550 tree_stats_numNodes=99904 tree_stats_numKeys=99904 tree_stats_avgDegreeInternal=1.74188 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.42591 tree_stats_avgKeyDepth=14.9393 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=933456 first_thread_announced_epoch_by_thread=39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 39900 sum_num_inserts_by_thread=438335 437986 439863 443815 437771 439658 439080 443889 448178 448369 444614 437186 438801 441685 438643 447789 435975 441511 437328 437633 444513 447690 439891 438615 441277 441566 444341 443143 439253 439745 440672 443993 444965 448469 440880 439759 438134 442204 439219 448242 441306 441089 438482 441096 444018 445258 440855 434403 sum_num_inserts_total=21191187 sum_num_deletes_by_thread=439650 438628 440180 443340 438964 439526 439245 443014 447491 445726 446111 436982 438760 442076 438969 447364 434644 442516 437579 437275 444515 446825 440085 437987 440111 441352 444884 444681 440414 439722 440480 444742 445515 447993 442734 437814 439199 443224 437983 447031 441857 440431 439383 440818 443817 444947 441109 434107 sum_num_deletes_total=21191800 sum_num_searches_by_thread=7898105 7891041 7919239 7990675 7903398 7898362 7901073 7990478 8056157 8050309 8014577 7867205 7905082 7953540 7893182 8047697 7833648 7956853 7897317 7886108 8010896 8065097 7918795 7888578 7931311 7950108 7994360 7990904 7920980 7925282 7920821 7989829 8006667 8069749 7947156 7894190 7878919 7969285 7879693 8047866 7941315 7935327 7905793 7938567 7992104 7999133 7936119 7818626 sum_num_searches_total=381421516 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=8776090 8767655 8799282 8877830 8780133 8777546 8779398 8877381 8951826 8944404 8905302 8741373 8782643 8837301 8770794 8942850 8704267 8840880 8772224 8761016 8899924 8959612 8798771 8765180 8812699 8833026 8883585 8878728 8800647 8804749 8801973 8878564 8897147 8966211 8830770 8771763 8756252 8854713 8756895 8943139 8824478 8816847 8783658 8820481 8879939 8889338 8818083 8687136 average_num_operations_total=8829260 stdev_num_operations_total=9997 sum_num_operations_total=423804503 min_num_operations_total=8687136 max_num_operations_total=8966211 first_time_thread_terminate_by_thread=10000139 10000139 10000138 10000139 10000138 10000139 10000138 10000138 10000138 10000139 10000138 10000139 10000138 10000138 10000139 10000138 10000139 10000138 10000139 10000139 10000139 10000139 10000139 10000138 10000138 10000139 10000138 10000139 10000138 10000138 10000138 10000138 10000138 10000139 10000139 10000139 10000138 10000138 10000139 10000138 10000139 10000138 10000139 10000139 10000139 10000139 10000139 10000138 min_time_thread_terminate_total=10000138 max_time_thread_terminate_total=10000139 first_time_thread_start_by_thread=4 5 5 5 4 4 5 5 5 4 4 5 5 5 4 5 5 4 4 4 5 5 5 4 4 5 5 5 4 4 5 5 5 4 4 5 5 5 4 5 5 4 4 4 5 5 5 4 min_time_thread_start_total=4 max_time_thread_start_total=5 sum_duration_all_ops_total= threads_final_keysum=9983329377 threads_final_size=99904 final_keysum=9983329377 final_size=99904 validate_result=success Validation OK. Structural validation OK. total_find=381421516 total_rq=0 total_inserts=21191187 total_deletes=21191800 total_updates=42382987 total_queries=381421516 total_ops=423804503 find_throughput=38142151 rq_throughput=0 update_throughput=4238298 query_throughput=38142151 total_throughput=42380450 total find : 381421516 total rq : 0 total inserts : 21191187 total deletes : 21191800 total updates : 42382987 total queries : 381421516 total ops : 423804503 find throughput : 38142151 rq throughput : 0 update throughput : 4238298 query throughput : 38142151 total throughput : 42380450 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=6.71699 PAPI_L3_TCM=0.0106552 PAPI_TOT_CYC=3087.69 PAPI_TOT_INS=2549.84 garbage=19067120114584 total_execution_walltime=11.429s REALTIME_MAIN_END_PERF_FORMAT=7000917.675619642 HyTM1 system shutdown: HTM_ATTEMPT_THRESH=40 [fast htm] total fast htm commit : 434011751 [slow htm] [fallback] total fallback commit : 214635 seconds global lock is held : 4.46586 [time_cmd_output] time_elapsed_sec=11.62, faults_major=0, faults_minor=386450, mem_maxresident_kb=960220, user_cputime=555.70, sys_cputime=6.66, percent_cpu=4839% 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=2