__step=000259 __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 96 -nprefill 96 -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=data000259.txt __path_data=data/data000259.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6997677.118817377 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=2000000 PREFILL_THREADS=96 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=96 WORK_THREADS=96 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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143 noREC system ready Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.015s prefilling_size=334796 prefilling_elapsed_millis=1.001s prefilling_size=361537 prefilling_elapsed_millis=1.101s prefilling_size=387443 prefilling_elapsed_millis=1.201s prefilling_size=412165 prefilling_elapsed_millis=1.301s prefilling_size=435610 prefilling_elapsed_millis=1.402s prefilling_size=458103 prefilling_elapsed_millis=1.502s prefilling_size=480060 prefilling_elapsed_millis=1.602s prefilling_size=501035 prefilling_elapsed_millis=1.702s prefilling_size=520861 prefilling_elapsed_millis=1.802s prefilling_size=539736 prefilling_elapsed_millis=1.903s prefilling_size=557782 prefilling_elapsed_millis=2.003s prefilling_size=575300 prefilling_elapsed_millis=2.103s prefilling_size=592416 prefilling_elapsed_millis=2.203s prefilling_size=608991 prefilling_elapsed_millis=2.303s prefilling_size=624832 prefilling_elapsed_millis=2.404s prefilling_size=639502 prefilling_elapsed_millis=2.504s prefilling_size=654119 prefilling_elapsed_millis=2.604s prefilling_size=667975 prefilling_elapsed_millis=2.704s prefilling_size=681673 prefilling_elapsed_millis=2.804s prefilling_size=694276 prefilling_elapsed_millis=2.905s prefilling_size=706558 prefilling_elapsed_millis=3.005s prefilling_size=718088 prefilling_elapsed_millis=3.105s prefilling_size=729350 prefilling_elapsed_millis=3.205s prefilling_size=740150 prefilling_elapsed_millis=3.305s prefilling_size=750319 prefilling_elapsed_millis=3.406s prefilling_size=759876 prefilling_elapsed_millis=3.506s prefilling_size=769487 prefilling_elapsed_millis=3.606s prefilling_size=778446 prefilling_elapsed_millis=3.706s prefilling_size=787434 prefilling_elapsed_millis=3.806s prefilling_size=795975 prefilling_elapsed_millis=3.907s prefilling_size=804240 prefilling_elapsed_millis=4.007s prefilling_size=811661 prefilling_elapsed_millis=4.107s prefilling_size=818791 prefilling_elapsed_millis=4.207s prefilling_size=825794 prefilling_elapsed_millis=4.307s prefilling_size=832820 prefilling_elapsed_millis=4.408s prefilling_size=839156 prefilling_elapsed_millis=4.508s prefilling_size=845527 prefilling_elapsed_millis=4.608s prefilling_size=851459 prefilling_elapsed_millis=4.708s prefilling_size=857787 prefilling_elapsed_millis=4.808s prefilling_size=863233 prefilling_elapsed_millis=4.908s prefilling_size=868377 prefilling_elapsed_millis=5.009s Info: prefilling requires an additional insert phase to complete. Info: prefilling using INSERTION ONLY. timing_start inserting 131604 keys with 96 threads... timing_elapsed 0.32073s prefilling_size=1000000 prefilling_elapsed_millis=0.321s finished prefilling to size 1000000 for expected size 1000000 keysum=1000104984397, performing 4375830 updates; total_prefilling_elapsed_ms=321 ms) pref_size=1000000 pref_millis=321 prefill_elapsed_ms=321 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6997682.740162276 REALTIME_END_PERF_FORMAT=6997692.740247449 ############################################################################### ################################## 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 (96 threads)... partitioned into 512 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.011s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32719 64281 115526 155450 121512 44356 5943 214 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 45 1039 11118 61478 144844 142661 56105 7457 259 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32764 65320 126644 216928 266356 187017 62048 7671 259 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32764 65320 126644 216928 266356 187017 62048 7671 259 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99976 1.99503 1.95473 1.80069 1.51126 1.24593 1.0946 1.02785 1.00587 1 tree_stats_height=24 tree_stats_numInternals=572768 tree_stats_numLeaves=425006 tree_stats_numNodes=997774 tree_stats_numKeys=997774 tree_stats_avgDegreeInternal=1.74202 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.42595 tree_stats_avgKeyDepth=18.3399 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=123652 first_thread_announced_epoch_by_thread=2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 2684 sum_commit_tx_reader_total=107213840 sum_commit_tx_reader_by_thread=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1135769 1138610 1126597 1131863 1112733 1127021 1127932 1090992 1136993 1138677 1090466 1122754 1083530 1139354 1124325 1139478 1098403 1139638 1142377 1131998 1131557 1101624 1096818 1122803 1099778 1130028 1093616 1102566 1114510 1094871 1101935 1098495 1130653 1106067 1136453 1120985 1098158 1150772 1151556 1132936 1101303 1116146 1087539 1131607 1128669 1149953 1099315 1134461 1131416 1131395 1132279 1127938 1104810 1109933 1142599 1159796 1095756 1125829 1105726 1140178 1118878 1128850 1120383 1136569 1129931 1121706 1102218 1082095 1108423 1098073 1107010 1118337 1098461 1110166 1118606 1121906 1122184 1103767 1104177 1130702 1117618 1124867 1115887 1091033 1090919 1103861 1094130 1109483 1097448 1093607 1095103 1098840 1088867 1094725 1134619 1128052 sum_commit_tx_writer_total=5643188 sum_commit_tx_writer_by_thread=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 59874 59891 59370 59577 58770 59198 59053 57469 59865 59875 57251 59465 57063 60304 59347 60058 57408 59954 59980 59621 59279 57400 57790 59096 58056 59330 57624 58079 58681 57601 57761 57630 59071 58489 59520 59245 57655 60657 60600 59990 58015 59005 57625 59438 59382 60359 57765 59747 59328 59556 59368 59330 58197 58706 59914 61568 57688 58978 57999 60051 58838 59520 58990 59692 59880 59047 57883 57038 58221 57748 58740 59130 57355 58860 59285 59111 59185 58158 58149 59424 58801 59264 59285 57467 57693 58384 57616 58241 58062 57843 57288 57668 57089 56735 59395 59137 sum_abort_tx_total=3098 sum_abort_tx_by_thread=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 40 36 24 37 27 34 35 38 30 32 26 36 33 30 26 28 38 37 31 36 30 29 27 38 36 33 32 36 34 24 33 31 37 35 32 35 31 34 28 33 38 38 30 27 35 38 25 32 26 34 32 37 26 28 33 36 37 25 26 40 29 37 33 28 25 31 36 32 46 32 36 37 28 37 38 44 39 38 22 37 26 40 28 30 26 30 29 27 28 30 34 29 27 30 23 31 max_ht_capacity_by_thread=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 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 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=20.9:12 29.8:361 38.7:13257 47.6:77061 56.5:4107 65.4:976 74.3:166 83.2:41 92.1:16 101:2 [ 12.00, 20.90]: 12 ( 20.90, 29.80]: 361 ( 29.80, 38.70]: 13257 ( 38.70, 47.60]: 77061 ( 47.60, 56.50]: 4107 ( 56.50, 65.40]: 976 ( 65.40, 74.30]: 166 ( 74.30, 83.20]: 41 ( 83.20, 92.10]: 16 ( 92.10, 101.00]: 2 linear_histogram_of_none_tx_wrset_size_full_data=3.9:29416 6.8:6757 9.7:22953 12.6:11248 15.5:16927 18.4:6508 21.3:1414 24.2:695 27.1:71 30:9 [ 1.00, 3.90]: 29416 ( 3.90, 6.80]: 6757 ( 6.80, 9.70]: 22953 ( 9.70, 12.60]: 11248 ( 12.60, 15.50]: 16927 ( 15.50, 18.40]: 6508 ( 18.40, 21.30]: 1414 ( 21.30, 24.20]: 695 ( 24.20, 27.10]: 71 ( 27.10, 30.00]: 9 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=59139 59263 59132 59050 59627 58608 60371 60031 59889 60216 59993 59092 61572 59702 59882 59499 59024 59557 60113 59129 59203 59661 59775 59310 59978 59048 59308 59369 59791 58815 60293 59305 59445 60319 59912 59392 60671 59402 59455 59142 60048 59442 59681 58962 58990 59381 60301 59041 58721 57685 57506 58026 58069 57684 59257 57556 57925 57938 59309 57839 59043 56887 57770 57213 57682 57299 58079 56653 58654 58183 57609 57603 58609 56692 57556 58707 57823 57940 59183 58211 58356 58324 58730 57148 59296 57684 58676 57078 57316 57521 57326 56843 58118 58216 56883 57627 sum_num_inserts_total=5640382 sum_num_deletes_by_thread=59853 58675 59182 59009 59229 58965 60893 59492 59711 60093 60010 59215 61216 59670 60179 59265 59193 59526 59842 59118 59026 59522 59825 59935 59960 58515 59049 59277 59352 58728 60776 59531 59714 59981 60152 59659 60543 59678 59498 58810 59635 59558 59630 59261 59531 59552 59981 59056 58701 57865 57358 58633 57805 57843 58753 57915 57981 58388 58824 57543 59198 57813 58230 57452 57740 57201 57910 57096 58140 57745 57358 57705 58739 57787 57342 58382 57630 57877 58859 57690 57947 58449 58687 57786 59283 57934 58457 57099 57279 57748 57814 57061 58106 58262 57078 58241 sum_num_deletes_total=5642805 sum_num_searches_by_thread=1075022 1063961 1062439 1057113 1072791 1060143 1090165 1076120 1076661 1079227 1082510 1072529 1098576 1070439 1079531 1070594 1068972 1072357 1078597 1061126 1066578 1072436 1078901 1069125 1080291 1057588 1067610 1065026 1068125 1058876 1091087 1071290 1071886 1079358 1072862 1071900 1089098 1071664 1069098 1066179 1074525 1076973 1077547 1063146 1063698 1070791 1082075 1059794 1055769 1040263 1037527 1051065 1041960 1043497 1068975 1037001 1046019 1043775 1059334 1036068 1062776 1036540 1044645 1033796 1040394 1033217 1043329 1026844 1051845 1047797 1040844 1038136 1054155 1030685 1036848 1048661 1039155 1043879 1062188 1039609 1046023 1049871 1051609 1033678 1067640 1040507 1047423 1031779 1033905 1040552 1041368 1025229 1046783 1045767 1037499 1041212 sum_num_searches_total=101573841 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=1194014 1181899 1180753 1175172 1191647 1177716 1211429 1195643 1196261 1199536 1202513 1190836 1221364 1189811 1199592 1189358 1187189 1191440 1198552 1179373 1184807 1191619 1198501 1188370 1200229 1175151 1185967 1183672 1187268 1176419 1212156 1190126 1191045 1199658 1192926 1190951 1210312 1190744 1188051 1184131 1194208 1195973 1196858 1181369 1182219 1189724 1202357 1177891 1173191 1155813 1152391 1167724 1157834 1159024 1186985 1152472 1161925 1160101 1177467 1151450 1181017 1151240 1160645 1148461 1155816 1147717 1159318 1140593 1168639 1163725 1155811 1153444 1171503 1145164 1151746 1165750 1154608 1159696 1180230 1155510 1162326 1166644 1169026 1148612 1186219 1156125 1164556 1145956 1148500 1155821 1156508 1139133 1163007 1162245 1151460 1157080 average_num_operations_total=1175594 stdev_num_operations_total=1967 sum_num_operations_total=112857028 min_num_operations_total=1139133 max_num_operations_total=1221364 first_time_thread_terminate_by_thread=10000150 10000088 10000092 10000093 10000102 10000093 10000093 10000099 10000085 10000089 10000085 10000085 10000091 10000093 10000099 10000084 10000093 10000092 10000089 10000093 10000088 10000084 10000091 10000093 10000093 10000093 10000089 10000093 10000093 10000089 10000093 10000099 10000099 10000093 10000090 10000094 10000085 10000089 10000099 10000088 10000093 10000090 10000089 10000093 10000088 10000084 10000093 10000092 10000086 10000090 10000085 10000088 10000088 10000089 10000086 10000087 10000088 10000085 10000096 10000085 10000085 10000085 10000092 10000098 10000085 10000096 10000090 10000085 10000085 10000085 10000085 10000085 10000092 10000085 10000085 10000085 10000089 10000085 10000088 10000087 10000092 10000090 10000096 10000085 10000090 10000088 10000088 10000096 10000085 10000096 10000088 10000089 10000090 10000098 10000088 10000103 min_time_thread_terminate_total=10000084 max_time_thread_terminate_total=10000150 first_time_thread_start_by_thread=9 5 5 5 6 5 5 5 5 5 5 6 5 5 5 5 5 5 5 5 5 5 5 5 4 5 5 5 6 5 5 5 5 5 5 6 5 5 5 5 5 5 5 5 5 5 5 5 6 5 6 6 6 5 6 6 6 5 6 5 5 5 6 6 6 5 6 5 6 6 6 6 6 5 6 6 6 5 6 6 6 5 6 5 5 5 6 6 6 5 6 5 6 6 6 6 min_time_thread_start_total=4 max_time_thread_start_total=9 sum_duration_all_ops_total= threads_final_keysum=997911182422 threads_final_size=997774 final_keysum=997911182422 final_size=997774 validate_result=success Validation OK. Structural validation OK. total_find=101573841 total_rq=0 total_inserts=5640382 total_deletes=5642805 total_updates=11283187 total_queries=101573841 total_ops=112857028 find_throughput=10157384 rq_throughput=0 update_throughput=1128318 query_throughput=10157384 total_throughput=11285702 total find : 101573841 total rq : 0 total inserts : 5640382 total deletes : 5642805 total updates : 11283187 total queries : 101573841 total ops : 112857028 find throughput : 10157384 rq throughput : 0 update throughput : 1128318 query throughput : 10157384 total throughput : 11285702 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=18.625 PAPI_L3_TCM=2.56832 PAPI_TOT_CYC=21501.8 PAPI_TOT_INS=8193.33 garbage=49217803200941 total_execution_walltime=16.096s REALTIME_MAIN_END_PERF_FORMAT=6997693.215527083 noREC system shutdown: [time_cmd_output] time_elapsed_sec=16.23, faults_major=0, faults_minor=135781, mem_maxresident_kb=540848, user_cputime=1465.42, sys_cputime=27.21, percent_cpu=9191% 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