__step=000579 __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_abtree_kcas_validate_htm.debra -nwork 96 -nprefill 96 -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=data000579.txt __path_data=data/data000579.txt __hostname=jax sizeof(kcasdesc_t)=1920 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x5617dc28b480 addrof(kcasDescriptors[1])=0x5617dc28bc00 addrof(rdcssDescriptors[0])=0x5617dc37b480 addrof(rdcssDescriptors[1])=0x5617dc37b540 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=7001786.305674159 binary=./brown_sigouin_abtree_kcas_validate_htm.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=brown_sigouin_abtree_kcas_validate_htm 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=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=40 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 Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.011s prefilling_size=100348 prefilling_elapsed_millis=1.001s finished prefilling to size 100259 for expected size 100000 keysum=10014580514, performing 127687191 updates; total_prefilling_elapsed_ms=1103 ms) pref_size=100259 pref_millis=1103 prefill_elapsed_ms=1125 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=7001787.595744448 REALTIME_END_PERF_FORMAT=7001797.595888449 ############################################################################### ################################## 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 3202 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.059s tree_stats_numInternalsAtDepth=1 1 8 54 397 3202 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 19485 tree_stats_numNodesAtDepth=1 1 8 54 397 3202 19485 tree_stats_numKeysAtDepth=0 0 0 0 0 0 99760 tree_stats_avgDegreeAtDepth=1 8 6.75 7.35185 8.06549 6.08526 5.11984 tree_stats_height=7 tree_stats_numInternals=3663 tree_stats_numLeaves=19485 tree_stats_numNodes=23148 tree_stats_numKeys=99760 tree_stats_avgDegreeInternal=6.31941 tree_stats_avgDegreeLeaves=5.11984 tree_stats_avgDegree=5.30966 tree_stats_avgKeyDepth=6 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:170240 2:256381 4:73447 8:2036 [2^00, 2^01]: 170240 (2^01, 2^02]: 256381 (2^02, 2^03]: 73447 (2^03, 2^04]: 2036 sum_limbo_reclamation_event_size_total=1059815 count_limbo_reclamation_event_size_by_thread=5084 5094 5218 5216 5296 5010 5218 5212 5088 5372 5332 5240 5222 5406 5064 5136 5196 5172 5138 4968 5216 5114 5192 4926 5316 5018 5334 5216 5306 5212 5212 5102 5176 5216 5082 5224 5160 5036 5094 5208 5192 5168 5114 5190 5222 5182 5098 5216 5300 5134 5202 5348 5250 5290 5092 5414 5256 5316 5292 5268 5294 5300 5354 5368 5148 5096 5332 5130 5290 5244 5350 5068 5356 5340 5252 5230 5308 5360 5280 5312 5358 5186 5328 5404 5148 5312 5234 5358 5408 5298 5424 5300 5352 5342 5376 5278 count_limbo_reclamation_event_size_total=502104 sum_limbo_reclamation_event_count_total=4590144 first_thread_announced_epoch_by_thread=50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 50760 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= 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=33659 sum_abtree_erase_repeat_total=10761 sum_abtree_search_repeat_total=120 sum_abtree_search_complete_total=212064350 sum_abtree_fix_weight_viol_attempt_total=196918 sum_abtree_fix_degree_viol_attempt_total=1521346 sum_abtree_rebalancing_kcas_attempt_total=1713289 sum_abtree_update_kcas_attempt_total=105186436 sum_abtree_internal_complex_search_while_iters_total=212065524 sum_abtree_internal_basic_search_while_iters_total=1892824610 sum_kcas_desc_new_total= sum_num_inserts_by_thread=1087965 1085655 1094950 1090503 1088153 1077560 1083772 1091295 1100209 1095252 1085536 1084367 1090685 1090092 1096308 1090726 1098552 1091554 1086650 1094136 1098192 1088827 1086468 1078591 1088032 1083890 1092837 1087908 1092598 1073247 1077502 1088402 1101409 1093875 1089501 1082323 1087775 1084409 1091389 1088726 1083876 1088233 1072396 1084587 1090331 1080979 1078706 1066208 1093958 1104476 1109170 1101029 1106087 1097891 1103463 1109932 1110375 1109190 1099665 1099119 1094106 1091420 1103333 1120292 1111444 1079160 1100404 1106253 1114491 1108204 1100448 1100463 1100482 1100471 1107150 1108927 1098658 1089508 1095030 1096509 1109869 1107252 1097549 1089133 1088289 1095615 1100812 1107617 1102548 1099336 1095198 1099863 1121616 1116185 1117219 1113121 sum_num_inserts_total=105137467 sum_num_deletes_by_thread=1086911 1085977 1095722 1089661 1087401 1078158 1082820 1092702 1102149 1093445 1085822 1082504 1091102 1088895 1094786 1091257 1097480 1093445 1085659 1092983 1098957 1087964 1087798 1078221 1088049 1084591 1092992 1087513 1094874 1074330 1076244 1087124 1101124 1093864 1085236 1083161 1089814 1085679 1091687 1088064 1084386 1089097 1074684 1084860 1088614 1081531 1078651 1067617 1094086 1103726 1110372 1104521 1105411 1100875 1104337 1112368 1107876 1109816 1099483 1100261 1094040 1092042 1102246 1118495 1112697 1079678 1099321 1107389 1113806 1109724 1098996 1101812 1101408 1101730 1107591 1109071 1100828 1090047 1096399 1094469 1110383 1103612 1100652 1088654 1090261 1095524 1104707 1107617 1099326 1100701 1097067 1100485 1123029 1116033 1117601 1112732 sum_num_deletes_total=105158910 sum_num_searches_by_thread=19588677 19565416 19696422 19629501 19562844 19412769 19508562 19644116 19818848 19698130 19537664 19532250 19644358 19613314 19715833 19651904 19753826 19657530 19562128 19689979 19769410 19603702 19546937 19419898 19584617 19488849 19658661 19566021 19678717 19335114 19367530 19588583 19811963 19690415 19598045 19484967 19611094 19536558 19639448 19596020 19504527 19590248 19346805 19527871 19623851 19482908 19430924 19190283 19688998 19893301 19971386 19855034 19904924 19787077 19882349 19992380 19987368 19941384 19771262 19779453 19687869 19643924 19836253 20143137 20032054 19420708 19803375 19918906 20026767 19963872 19796270 19824267 19811814 19806713 19950172 19958192 19811369 19605014 19715239 19705120 19973187 19904892 19787030 19622524 19598599 19721406 19852633 19931227 19820249 19823143 19752564 19809530 20190878 20099319 20129608 20045479 sum_num_searches_total=1892736256 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=21763553 21737048 21887094 21809665 21738398 21568487 21675154 21828113 22021206 21886827 21709022 21699121 21826145 21792301 21906927 21833887 21949858 21842529 21734437 21877098 21966559 21780493 21721203 21576710 21760698 21657330 21844490 21741442 21866189 21482691 21521276 21764109 22014496 21878154 21772782 21650451 21788683 21706646 21822524 21772810 21672789 21767578 21493885 21697318 21802796 21645418 21588281 21324108 21877042 22101503 22190928 22060584 22116422 21985843 22090149 22214680 22205619 22160390 21970410 21978833 21876015 21827386 22041832 22381924 22256195 21579546 22003100 22132548 22255064 22181800 21995714 22026542 22013704 22008914 22164913 22176190 22010855 21784569 21906668 21896098 22193439 22115756 21985231 21800311 21777149 21912545 22058152 22146461 22022123 22023180 21944829 22009878 22435523 22331537 22364428 22271332 average_num_operations_total=21906589 stdev_num_operations_total=22438 sum_num_operations_total=2103032633 min_num_operations_total=21324108 max_num_operations_total=22435523 first_time_thread_terminate_by_thread=10000144 10000146 10000144 10000146 10000144 10000146 10000143 10000145 10000143 10000146 10000145 10000146 10000144 10000144 10000143 10000143 10000145 10000146 10000143 10000144 10000143 10000143 10000145 10000143 10000144 10000146 10000144 10000146 10000144 10000146 10000143 10000145 10000143 10000146 10000145 10000146 10000144 10000144 10000143 10000143 10000145 10000146 10000143 10000144 10000143 10000143 10000145 10000143 10000145 10000143 10000143 10000143 10000144 10000143 10000146 10000145 10000145 10000146 10000144 10000146 10000145 10000146 10000144 10000144 10000145 10000145 10000143 10000144 10000144 10000144 10000144 10000146 10000145 10000143 10000143 10000143 10000144 10000143 10000146 10000145 10000145 10000146 10000144 10000146 10000145 10000146 10000144 10000144 10000145 10000145 10000144 10000144 10000144 10000144 10000144 10000146 min_time_thread_terminate_total=10000143 max_time_thread_terminate_total=10000146 first_time_thread_start_by_thread=3 3 2 3 3 3 3 2 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 2 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 2 2 2 3 3 3 2 3 3 3 2 3 3 2 3 3 3 3 3 3 2 3 3 3 2 2 2 3 3 3 2 3 3 3 2 3 3 2 3 3 3 3 3 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=9962791988 threads_final_size=99760 final_keysum=9962791988 final_size=99760 validate_result=success Validation OK. Structural validation OK. total_find=1892736256 total_rq=0 total_inserts=105137467 total_deletes=105158910 total_updates=210296377 total_queries=1892736256 total_ops=2103032633 find_throughput=189273625 rq_throughput=0 update_throughput=21029637 query_throughput=189273625 total_throughput=210303263 total find : 1892736256 total rq : 0 total inserts : 105137467 total deletes : 105158910 total updates : 210296377 total queries : 1892736256 total ops : 2103032633 find throughput : 189273625 rq throughput : 0 update throughput : 21029637 query throughput : 189273625 total throughput : 210303263 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=6.13515 PAPI_L3_TCM=0.41205 PAPI_TOT_CYC=1191.17 PAPI_TOT_INS=806.79 garbage=93642381749280 total_execution_walltime=11.463s REALTIME_MAIN_END_PERF_FORMAT=7001797.769884888 [time_cmd_output] time_elapsed_sec=11.58, faults_major=0, faults_minor=79308, mem_maxresident_kb=313676, user_cputime=1097.44, sys_cputime=2.93, percent_cpu=9496% timeout=false algorithm=brown_sigouin_abtree_kcas_validate_htm.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=1