__step=000490 __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.rhnorec_post -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=data000490.txt __path_data=data/data000490.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=7000706.676134090 binary=./brown_sigouin_int_avl_tm_auto.debra.rhnorec_post 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 RH noREC w/postfix htm system ready Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.004s prefilling_size=94547 prefilling_elapsed_millis=1.001s prefilling_size=96010 prefilling_elapsed_millis=1.101s prefilling_size=97087 prefilling_elapsed_millis=1.201s prefilling_size=98017 prefilling_elapsed_millis=1.301s finished prefilling to size 98024 for expected size 100000 keysum=9792861171, performing 773705 updates; total_prefilling_elapsed_ms=1402 ms) pref_size=98024 pref_millis=1402 prefill_elapsed_ms=1426 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=7000708.270689534 REALTIME_END_PERF_FORMAT=7000718.270833828 ############################################################################### ################################## TIME IS UP ################################# ############################################################################### joining threads... ############################################################################### ################################# END RUNNING ################################# ############################################################################### 10.1s 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.033s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4095 8013 13481 15046 9481 3026 227 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 1 162 2182 9503 15398 11351 3896 280 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8175 15663 24549 24879 14377 4123 280 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8175 15663 24549 24879 14377 4123 280 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99609 1.93578 1.70663 1.40055 1.19679 1.0763 1.01285 1 tree_stats_height=20 tree_stats_numInternals=57464 tree_stats_numLeaves=42773 tree_stats_numNodes=100237 tree_stats_numKeys=100237 tree_stats_avgDegreeInternal=1.74434 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.42672 tree_stats_avgKeyDepth=15.0235 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=185882 first_thread_announced_epoch_by_thread=7822 7822 7824 7822 7822 7822 7824 7824 7822 7824 7824 7824 7822 7824 7824 7824 7824 7824 7822 7822 7824 7822 7824 7824 7822 7822 7824 7822 7824 7822 7822 7822 7824 7824 7824 7824 7822 7822 7824 7824 7824 7822 7824 7822 7824 7822 7822 7824 sum_commit_tx_reader_total= sum_commit_tx_reader_by_thread= sum_commit_tx_writer_total= sum_commit_tx_writer_by_thread= sum_abort_tx_total= sum_abort_tx_by_thread= max_ht_capacity_by_thread= linear_histogram_of_none_tx_rdset_size_full_data= linear_histogram_of_none_tx_wrset_size_full_data= sum_fasthtm_commit_total=53256203 sum_fasthtm_abort_total=112837652 sum_htmpostfix_commit_total=2715602 sum_htmpostfix_abort_total=18266314 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=79278024 sum_stmprefix_commit_total=464 sum_slow_commit_total=80011 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=56210 56686 57855 58191 59034 59871 56744 57228 58652 58572 59503 61193 57519 56952 57296 58288 58901 61559 57227 56811 58131 59725 58756 60640 56405 55633 57436 58088 58997 59793 57103 57166 58574 58765 59440 61677 57071 57110 57225 58867 59283 61594 57144 57493 57610 59246 59157 60997 sum_num_inserts_total=2803418 sum_num_deletes_by_thread=56150 56190 57069 57901 58546 59500 56664 57293 58259 58706 59124 61091 56963 57650 57732 58773 58974 61221 57097 56947 57732 59233 58952 60585 55747 56149 57910 58282 58922 59658 57155 56877 58209 59301 59695 61446 57591 56872 56948 58728 59435 61227 57369 57213 57303 59472 59086 61365 sum_num_deletes_total=2800312 sum_num_searches_by_thread=1009036 1016006 1036488 1044126 1066657 1075665 1019300 1031041 1049529 1059451 1068965 1092243 1030867 1033541 1036894 1049545 1064286 1103498 1029794 1028831 1041911 1073170 1058809 1087595 1012087 1009189 1036033 1049563 1062255 1077978 1030801 1024843 1052555 1062260 1072128 1115204 1035554 1028099 1026616 1055824 1064354 1103260 1027740 1031923 1030496 1070978 1062492 1099070 sum_num_searches_total=50448550 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=1121396 1128882 1151412 1160218 1184237 1195036 1132708 1145562 1166440 1176729 1187592 1214527 1145349 1148143 1151922 1166606 1182161 1226278 1144118 1142589 1157774 1192128 1176517 1208820 1124239 1120971 1151379 1165933 1180174 1197429 1145059 1138886 1169338 1180326 1191263 1238327 1150216 1142081 1140789 1173419 1183072 1226081 1142253 1146629 1145409 1189696 1180735 1221432 average_num_operations_total=1167755 stdev_num_operations_total=4293 sum_num_operations_total=56052280 min_num_operations_total=1120971 max_num_operations_total=1238327 first_time_thread_terminate_by_thread=10000198 10000216 10000188 10000197 10000152 10000196 10000143 10000160 10000195 10000223 10000205 10000215 10000176 10000221 10000156 10000227 10000226 10000190 10000152 10000208 10000214 10000170 10000146 10000206 10000183 10000156 10000192 10000164 10000211 10000144 10000161 10000149 10000212 10000178 10000143 10000205 10000225 10000147 10000209 10000227 10000188 10000217 10000143 10000155 10000221 10000220 10000200 10000222 min_time_thread_terminate_total=10000143 max_time_thread_terminate_total=10000227 first_time_thread_start_by_thread=3 3 3 2 3 2 2 3 3 2 3 2 2 2 3 2 3 3 3 3 3 3 2 2 3 3 3 2 3 2 2 3 3 2 3 2 2 2 3 2 3 3 3 3 3 3 2 2 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=10017382886 threads_final_size=100237 final_keysum=10017382886 final_size=100237 validate_result=success Validation OK. Structural validation OK. total_find=50448550 total_rq=0 total_inserts=2803418 total_deletes=2800312 total_updates=5603730 total_queries=50448550 total_ops=56052280 find_throughput=5044855 rq_throughput=0 update_throughput=560373 query_throughput=5044855 total_throughput=5605228 total find : 50448550 total rq : 0 total inserts : 2803418 total deletes : 2800312 total updates : 5603730 total queries : 50448550 total ops : 56052280 find throughput : 5044855 rq throughput : 0 update throughput : 560373 query throughput : 5044855 total throughput : 5605228 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=27.7915 PAPI_L3_TCM=0.282281 PAPI_TOT_CYC=20539.9 PAPI_TOT_INS=3743.27 garbage=2365455336879 total_execution_walltime=11.813s REALTIME_MAIN_END_PERF_FORMAT=7000718.490442290 RH noREC w/postfix htm system shutdown: HTM_ATTEMPT_THRESH=40 [time_cmd_output] time_elapsed_sec=11.95, faults_major=0, faults_minor=118973, mem_maxresident_kb=477792, user_cputime=559.81, sys_cputime=21.25, percent_cpu=4858% timeout=false algorithm=brown_sigouin_int_avl_tm_auto.debra.rhnorec_post thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=2