__step=000473 __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.norec -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=data000473.txt __path_data=data/data000473.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=7000498.152540231 binary=./brown_sigouin_int_avl_tm_auto.debra.norec 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 noREC system ready Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.008s prefilling_size=99863 prefilling_elapsed_millis=1s finished prefilling to size 99857 for expected size 100000 keysum=9992331933, performing 1968979 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=99857 pref_millis=1102 prefill_elapsed_ms=1126 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=7000499.421936497 REALTIME_END_PERF_FORMAT=7000509.422084309 ############################################################################### ################################## 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.037s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8081 14004 15939 8952 2074 139 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 106 1874 9728 17084 11038 2624 174 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8187 15878 25667 26036 13112 2763 174 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8187 15878 25667 26036 13112 2763 174 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99878 1.95236 1.73454 1.39338 1.15978 1.05255 1.01267 1 tree_stats_height=20 tree_stats_numInternals=57380 tree_stats_numLeaves=42628 tree_stats_numNodes=100008 tree_stats_numKeys=100008 tree_stats_avgDegreeInternal=1.74291 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.42625 tree_stats_avgKeyDepth=14.9624 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=331632 first_thread_announced_epoch_by_thread=14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 14004 sum_commit_tx_reader_total=144647483 sum_commit_tx_reader_by_thread=0 3015328 3002957 3031902 2992843 2979746 3016866 3037841 2985126 3038552 2969982 3007236 3019880 3037732 3049397 3003900 2986187 3040800 3012506 3038736 3036655 2975731 3021063 2981969 2982808 3053575 3054846 3006023 2992062 3002969 3049991 3014340 3017468 3030678 2952354 3046345 2998932 2978140 3044524 2997304 3012904 3044395 2961606 3016251 2999364 3014518 3013067 3034408 3045676 sum_commit_tx_writer_total=7615663 sum_commit_tx_writer_by_thread=0 158414 158294 159317 158273 156404 159194 159574 157560 159412 155802 158685 159515 159379 160969 157796 158010 160042 159196 159648 159068 156768 158438 157104 157374 160670 161174 158050 157132 158828 159911 158795 158436 160106 155292 160171 158190 156374 159971 157818 159001 160664 156314 159125 157868 158857 158410 159866 160404 sum_abort_tx_total=12092 sum_abort_tx_by_thread=0 251 230 270 241 236 251 278 243 240 260 244 239 254 269 242 222 233 271 252 236 246 272 233 250 274 235 278 269 265 261 237 257 252 229 246 266 268 260 256 249 249 258 235 267 251 253 252 262 max_ht_capacity_by_thread=0 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 linear_histogram_of_none_tx_rdset_size_full_data=15.8:11 23.6:218 31.4:3811 39.2:39809 47:3081 54.8:864 62.6:175 70.4:24 78.2:5 86:1 [ 8.00, 15.80]: 11 ( 15.80, 23.60]: 218 ( 23.60, 31.40]: 3811 ( 31.40, 39.20]: 39809 ( 39.20, 47.00]: 3081 ( 47.00, 54.80]: 864 ( 54.80, 62.60]: 175 ( 62.60, 70.40]: 24 ( 70.40, 78.20]: 5 ( 78.20, 86.00]: 1 linear_histogram_of_none_tx_wrset_size_full_data=3.4:14417 5.8:3070 8.2:9096 10.6:6151 13:3236 15.4:8317 17.8:2663 20.2:421 22.6:540 25:83 [ 1.00, 3.40]: 14417 ( 3.40, 5.80]: 3070 ( 5.80, 8.20]: 9096 ( 8.20, 10.60]: 6151 ( 10.60, 13.00]: 3236 ( 13.00, 15.40]: 8317 ( 15.40, 17.80]: 2663 ( 17.80, 20.20]: 421 ( 20.20, 22.60]: 540 ( 22.60, 25.00]: 83 sum_fasthtm_commit_total= sum_fasthtm_abort_total= sum_htmpostfix_commit_total= sum_htmpostfix_abort_total= sum_htmprefix_commit_total= sum_htmprefix_abort_total= sum_htmprefix_abort_explicit_total= sum_htmprefix_abort_conflict_total= sum_htmprefix_abort_capacity_total= sum_htmprefix_abort_nesting_total= sum_htmprefix_abort_illegal_total= sum_htmprefix_abort_zero_total= sum_stmprefix_abort_total= sum_stmprefix_commit_total= sum_slow_commit_total= sum_abtree_insert_repeat_total= sum_abtree_erase_repeat_total= sum_abtree_search_repeat_total= sum_abtree_search_complete_total= sum_abtree_fix_weight_viol_attempt_total= sum_abtree_fix_degree_viol_attempt_total= sum_abtree_rebalancing_kcas_attempt_total= sum_abtree_update_kcas_attempt_total= sum_abtree_internal_complex_search_while_iters_total= sum_abtree_internal_basic_search_while_iters_total= sum_kcas_desc_new_total= sum_num_inserts_by_thread=160078 159864 158513 158284 159472 158129 155277 158252 159390 157505 158545 159892 158454 159092 160235 159896 158794 158379 156306 156115 158947 159847 158176 157625 156951 159353 159786 157511 160106 156108 158669 159363 159215 160975 158186 157241 159619 158879 159651 159612 156836 159428 157464 157011 160886 160776 158130 157444 sum_num_inserts_total=7614267 sum_num_deletes_by_thread=159854 159481 159294 157919 159346 158635 154919 158860 160786 157675 158595 159981 158881 159189 160418 160269 158962 158383 157329 155883 158213 159766 158087 158355 156477 158977 159378 157111 159321 155718 157688 159177 160243 160866 157681 157663 160504 158768 159958 159396 156689 158222 156575 157467 160521 160653 158154 156891 sum_num_deletes_total=7613178 sum_num_searches_by_thread=2889970 2874929 2855328 2838919 2871966 2840358 2797450 2856263 2886340 2842052 2844657 2886207 2854570 2857095 2884406 2884330 2858148 2854715 2820879 2805922 2856582 2871606 2844988 2835136 2822722 2857730 2878251 2828064 2878537 2813958 2849564 2860855 2877653 2888525 2845829 2829293 2880719 2854055 2878775 2876715 2818974 2861851 2825034 2825704 2892838 2894591 2847789 2834859 sum_num_searches_total=137035701 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=3209902 3194274 3173135 3155122 3190784 3157122 3107646 3173375 3206516 3157232 3161797 3206080 3171905 3175376 3205059 3204495 3175904 3171477 3134514 3117920 3173742 3191219 3161251 3151116 3136150 3176060 3197415 3142686 3197964 3125784 3165921 3179395 3197111 3210366 3161696 3144197 3200842 3171702 3198384 3195723 3132499 3179501 3139073 3140182 3214245 3216020 3164073 3149194 average_num_operations_total=3172148 stdev_num_operations_total=4027 sum_num_operations_total=152263146 min_num_operations_total=3107646 max_num_operations_total=3216020 first_time_thread_terminate_by_thread=10000150 10000151 10000150 10000150 10000151 10000150 10000150 10000151 10000150 10000151 10000161 10000150 10000150 10000150 10000151 10000150 10000150 10000150 10000150 10000151 10000152 10000151 10000150 10000150 10000150 10000151 10000150 10000150 10000151 10000150 10000150 10000151 10000150 10000151 10000151 10000150 10000151 10000151 10000151 10000150 10000150 10000150 10000150 10000151 10000152 10000151 10000150 10000150 min_time_thread_terminate_total=10000150 max_time_thread_terminate_total=10000161 first_time_thread_start_by_thread=4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 min_time_thread_start_total=3 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=9980978182 threads_final_size=100008 final_keysum=9980978182 final_size=100008 validate_result=success Validation OK. Structural validation OK. total_find=137035701 total_rq=0 total_inserts=7614267 total_deletes=7613178 total_updates=15227445 total_queries=137035701 total_ops=152263146 find_throughput=13703570 rq_throughput=0 update_throughput=1522744 query_throughput=13703570 total_throughput=15226314 total find : 137035701 total rq : 0 total inserts : 7614267 total deletes : 7613178 total updates : 15227445 total queries : 137035701 total ops : 152263146 find throughput : 13703570 rq throughput : 0 update throughput : 1522744 query throughput : 13703570 total throughput : 15226314 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=11.512 PAPI_L3_TCM=0.00520034 PAPI_TOT_CYC=7115.56 PAPI_TOT_INS=5075.52 garbage=6852898587925 total_execution_walltime=11.566s REALTIME_MAIN_END_PERF_FORMAT=7000509.719269449 noREC system shutdown: [time_cmd_output] time_elapsed_sec=11.70, faults_major=0, faults_minor=127293, mem_maxresident_kb=510848, user_cputime=527.37, sys_cputime=34.88, percent_cpu=4801% timeout=false algorithm=brown_sigouin_int_avl_tm_auto.debra.norec thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=1