__step=000362 __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 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000362.txt __path_data=data/data000362.txt __hostname=jax sizeof(kcasdesc_t)=1920 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x5611893fe480 addrof(kcasDescriptors[1])=0x5611893fec00 addrof(rdcssDescriptors[0])=0x5611894ee480 addrof(rdcssDescriptors[1])=0x5611894ee540 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6999182.394414595 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=2000000 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=1000770 prefilling_elapsed_millis=1.001s finished prefilling to size 1000786 for expected size 1000000 keysum=1000184864498, performing 68758412 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=1000786 pref_millis=1102 prefill_elapsed_ms=1123 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6999183.682596885 REALTIME_END_PERF_FORMAT=6999193.682736101 ############################################################################### ################################## 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 3654 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.065s tree_stats_numInternalsAtDepth=1 1 8 65 489 3654 28489 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 195413 tree_stats_numNodesAtDepth=1 1 8 65 489 3654 28489 195413 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 1000392 tree_stats_avgDegreeAtDepth=1 8 8.125 7.52308 7.47239 7.79666 6.85924 5.11937 tree_stats_height=8 tree_stats_numInternals=32707 tree_stats_numLeaves=195413 tree_stats_numNodes=228120 tree_stats_numKeys=1000392 tree_stats_avgDegreeInternal=6.97465 tree_stats_avgDegreeLeaves=5.11937 tree_stats_avgDegree=5.38538 tree_stats_avgKeyDepth=7 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:63362 2:78773 4:12141 8:96 [2^00, 2^01]: 63362 (2^01, 2^02]: 78773 (2^02, 2^03]: 12141 (2^03, 2^04]: 96 sum_limbo_reclamation_event_size_total=278955 count_limbo_reclamation_event_size_by_thread=3254 3234 3290 3136 3148 3218 3240 3072 3272 3398 3258 3148 3080 3198 3190 3370 3262 3188 3138 3176 3164 3302 3162 3186 3198 3020 3196 3308 3274 3120 3218 3106 3000 3054 3442 3368 3308 3186 3308 3276 3290 3172 3310 3102 3166 3304 3270 3292 count_limbo_reclamation_event_size_total=154372 sum_limbo_reclamation_event_count_total=3439296 first_thread_announced_epoch_by_thread=77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 77960 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=361 sum_abtree_erase_repeat_total=127 sum_abtree_search_repeat_total=1 sum_abtree_search_complete_total=79784229 sum_abtree_fix_weight_viol_attempt_total=74887 sum_abtree_fix_degree_viol_attempt_total=586740 sum_abtree_rebalancing_kcas_attempt_total=661556 sum_abtree_update_kcas_attempt_total=39560012 sum_abtree_internal_complex_search_while_iters_total=79784239 sum_abtree_internal_basic_search_while_iters_total=712053267 sum_kcas_desc_new_total= sum_num_inserts_by_thread=820468 824684 826514 827038 826157 815243 821460 824229 831710 832488 824143 821758 820549 828104 831817 828459 826650 824715 819288 821801 826712 827698 820658 815612 820721 825608 829469 828340 827383 815507 821291 820725 831194 834145 824589 816505 817163 825701 828692 827142 823451 822450 819198 820164 826753 828364 821800 816515 sum_num_inserts_total=39560825 sum_num_deletes_by_thread=820404 826595 827446 826940 825461 816320 822391 824474 831444 833976 822393 820290 820568 826711 831333 825947 826487 826047 818709 821715 828106 828013 823244 814700 820079 825395 829526 828174 823342 813778 821869 821231 831167 833245 825692 816788 817177 827633 830816 828615 824015 824473 818346 820245 826510 827669 821206 814436 sum_num_deletes_total=39561141 sum_num_searches_by_thread=14769759 14847862 14880202 14917970 14841458 14705603 14781535 14817444 14937633 14995942 14835876 14771253 14768932 14897205 14984149 14898021 14872832 14848018 14736787 14800012 14902031 14892308 14775765 14664213 14773962 14847637 14917936 14892099 14853245 14666247 14792983 14808066 14968376 15018656 14834749 14709961 14719643 14873167 14939401 14889102 14823922 14811010 14731408 14786017 14882380 14899272 14795972 14672524 sum_num_searches_total=712050545 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=16410631 16499141 16534162 16571948 16493076 16337166 16425386 16466147 16600787 16662406 16482412 16413301 16410049 16552020 16647299 16552427 16525969 16498780 16374784 16443528 16556849 16548019 16419667 16294525 16414762 16498640 16576931 16548613 16503970 16295532 16436143 16450022 16630737 16686046 16485030 16343254 16353983 16526501 16598909 16544859 16471388 16457933 16368952 16426426 16535643 16555305 16438978 16303475 average_num_operations_total=16482760 stdev_num_operations_total=13997 sum_num_operations_total=791172511 min_num_operations_total=16294525 max_num_operations_total=16686046 first_time_thread_terminate_by_thread=10000139 10000138 10000139 10000138 10000138 10000138 10000139 10000138 10000138 10000138 10000139 10000139 10000139 10000138 10000138 10000138 10000139 10000139 10000139 10000139 10000138 10000139 10000139 10000138 10000139 10000138 10000139 10000138 10000138 10000138 10000139 10000138 10000138 10000138 10000139 10000139 10000139 10000138 10000138 10000138 10000138 10000139 10000139 10000139 10000138 10000139 10000139 10000138 min_time_thread_terminate_total=10000138 max_time_thread_terminate_total=10000139 first_time_thread_start_by_thread=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 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 3 4 min_time_thread_start_total=3 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=1000427806155 threads_final_size=1000392 final_keysum=1000427806155 final_size=1000392 validate_result=success Validation OK. Structural validation OK. total_find=712050545 total_rq=0 total_inserts=39560825 total_deletes=39561141 total_updates=79121966 total_queries=712050545 total_ops=791172511 find_throughput=71205054 rq_throughput=0 update_throughput=7912196 query_throughput=71205054 total_throughput=79117251 total find : 712050545 total rq : 0 total inserts : 39560825 total deletes : 39561141 total updates : 79121966 total queries : 712050545 total ops : 791172511 find throughput : 71205054 rq throughput : 0 update throughput : 7912196 query throughput : 71205054 total throughput : 79117251 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=11.3068 PAPI_L3_TCM=1.23963 PAPI_TOT_CYC=1606.18 PAPI_TOT_INS=873.117 garbage=348702062519468 total_execution_walltime=11.453s REALTIME_MAIN_END_PERF_FORMAT=6999193.848647414 [time_cmd_output] time_elapsed_sec=11.59, faults_major=0, faults_minor=87769, mem_maxresident_kb=351764, user_cputime=562.91, sys_cputime=1.98, percent_cpu=4873% 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=2