__step=000577 __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 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=data000577.txt __path_data=data/data000577.txt __hostname=jax sizeof(kcasdesc_t)=1920 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x555aed807480 addrof(kcasDescriptors[1])=0x555aed807c00 addrof(rdcssDescriptors[0])=0x555aed8f7480 addrof(rdcssDescriptors[1])=0x555aed8f7540 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=7001763.34642751 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=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=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 Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.004s prefilling_size=99629 prefilling_elapsed_millis=1.001s finished prefilling to size 99678 for expected size 100000 keysum=9938415355, performing 88504350 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=99678 pref_millis=1102 prefill_elapsed_ms=1122 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=7001764.330396798 REALTIME_END_PERF_FORMAT=7001774.330542963 ############################################################################### ################################## 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 3147 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.061s tree_stats_numInternalsAtDepth=1 1 8 59 422 3147 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 19491 tree_stats_numNodesAtDepth=1 1 8 59 422 3147 19491 tree_stats_numKeysAtDepth=0 0 0 0 0 0 99647 tree_stats_avgDegreeAtDepth=1 8 7.375 7.15254 7.45735 6.19352 5.11246 tree_stats_height=7 tree_stats_numInternals=3638 tree_stats_numLeaves=19491 tree_stats_numNodes=23129 tree_stats_numKeys=99647 tree_stats_avgDegreeInternal=6.35761 tree_stats_avgDegreeLeaves=5.11246 tree_stats_avgDegree=5.30831 tree_stats_avgKeyDepth=6 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:62456 2:77153 4:11194 8:93 [2^00, 2^01]: 62456 (2^01, 2^02]: 77153 (2^02, 2^03]: 11194 (2^03, 2^04]: 93 sum_limbo_reclamation_event_size_total=270467 count_limbo_reclamation_event_size_by_thread=3014 3148 3368 3034 3116 3228 3284 3226 3184 3070 3060 3130 3128 3244 3242 3246 3102 3034 3152 3190 3066 3146 3040 3178 3094 3102 3226 3158 3166 3008 3090 3080 3078 2982 3222 3180 3194 3112 3204 3208 3134 3200 3206 3124 3058 3168 3126 3146 count_limbo_reclamation_event_size_total=150896 sum_limbo_reclamation_event_count_total=5050368 first_thread_announced_epoch_by_thread=113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 113332 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=5588 sum_abtree_erase_repeat_total=1293 sum_abtree_search_repeat_total=86 sum_abtree_search_complete_total=117183460 sum_abtree_fix_weight_viol_attempt_total=108601 sum_abtree_fix_degree_viol_attempt_total=838308 sum_abtree_rebalancing_kcas_attempt_total=945655 sum_abtree_update_kcas_attempt_total=58121071 sum_abtree_internal_complex_search_while_iters_total=117183952 sum_abtree_internal_basic_search_while_iters_total=1046156265 sum_kcas_desc_new_total= sum_num_inserts_by_thread=1203716 1210131 1221121 1221315 1210776 1206319 1205115 1213461 1220598 1222417 1208850 1207954 1208429 1217736 1223774 1223896 1205811 1215145 1204452 1201451 1197380 1172476 1203166 1202136 1175066 1193115 1220604 1218491 1207439 1205861 1208701 1215154 1220760 1222277 1208404 1202953 1207257 1217318 1222953 1224654 1220739 1212423 1195140 1207018 1217205 1236164 1216263 1207153 sum_num_inserts_total=58110737 sum_num_deletes_by_thread=1200460 1209709 1219797 1220306 1212736 1206363 1205611 1213852 1221397 1224500 1210489 1208005 1206498 1218092 1224982 1225697 1208292 1214418 1206030 1201316 1196149 1175244 1203097 1199493 1175425 1196542 1220768 1217421 1208712 1204548 1207406 1214317 1222335 1223932 1212637 1202228 1204050 1216002 1222789 1224685 1218302 1213026 1195685 1206502 1216303 1234356 1217685 1208674 sum_num_deletes_total=58116863 sum_num_searches_by_thread=21668576 21772083 21971461 21973498 21784705 21714559 21670968 21847753 21986754 22016959 21790598 21756359 21738185 21930952 22056024 22027250 21721659 21853189 21709308 21633000 21550253 21118626 21661619 21627643 21164423 21521918 21967644 21917888 21754906 21703228 21738725 21867567 21985672 22014288 21784709 21658465 21711342 21882620 22015930 22058297 21941393 21825133 21521629 21731112 21899555 22221713 21919887 21731481 sum_num_searches_total=1046121506 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=24072752 24191923 24412379 24415119 24208217 24127241 24081694 24275066 24428749 24463876 24209937 24172318 24153112 24366780 24504780 24476843 24135762 24282752 24119790 24035767 23943782 23466346 24067882 24029272 23514914 23911575 24409016 24353800 24171057 24113637 24154832 24297038 24428767 24460497 24205750 24063646 24122649 24315940 24461672 24507636 24380434 24250582 23912454 24144632 24333063 24692233 24353835 24147308 average_num_operations_total=24215606 stdev_num_operations_total=33684 sum_num_operations_total=1162349106 min_num_operations_total=23466346 max_num_operations_total=24692233 first_time_thread_terminate_by_thread=10000145 10000145 10000146 10000145 10000145 10000145 10000146 10000146 10000145 10000145 10000146 10000145 10000145 10000146 10000145 10000146 10000146 10000145 10000145 10000146 10000146 10000146 10000146 10000145 10000145 10000145 10000146 10000145 10000145 10000145 10000146 10000146 10000145 10000145 10000146 10000145 10000145 10000146 10000145 10000146 10000146 10000145 10000145 10000146 10000146 10000146 10000146 10000145 min_time_thread_terminate_total=10000145 max_time_thread_terminate_total=10000146 first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 2 3 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=9967649177 threads_final_size=99647 final_keysum=9967649177 final_size=99647 validate_result=success Validation OK. Structural validation OK. total_find=1046121506 total_rq=0 total_inserts=58110737 total_deletes=58116863 total_updates=116227600 total_queries=1046121506 total_ops=1162349106 find_throughput=104612150 rq_throughput=0 update_throughput=11622760 query_throughput=104612150 total_throughput=116234910 total find : 1046121506 total rq : 0 total inserts : 58110737 total deletes : 58116863 total updates : 116227600 total queries : 1046121506 total ops : 1162349106 find throughput : 104612150 rq throughput : 0 update throughput : 11622760 query throughput : 104612150 total throughput : 116234910 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=5.8548 PAPI_L3_TCM=9.04685e-05 PAPI_TOT_CYC=1097.18 PAPI_TOT_INS=800.114 garbage=51203827947000 total_execution_walltime=11.451s REALTIME_MAIN_END_PERF_FORMAT=7001774.486593074 [time_cmd_output] time_elapsed_sec=11.56, faults_major=0, faults_minor=76253, mem_maxresident_kb=306140, user_cputime=565.47, sys_cputime=2.83, percent_cpu=4912% 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