__step=000353 __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.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=data000353.txt __path_data=data/data000353.txt __hostname=jax sizeof(kcasdesc_t)=1920 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x559c3fbe2480 addrof(kcasDescriptors[1])=0x559c3fbe2c00 addrof(rdcssDescriptors[0])=0x559c3fcd2480 addrof(rdcssDescriptors[1])=0x559c3fcd2540 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6999076.766198830 binary=./brown_sigouin_abtree_kcas_validate.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 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.021s prefilling_size=998817 prefilling_elapsed_millis=1.001s finished prefilling to size 998738 for expected size 1000000 keysum=999256137678, performing 65429158 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=998738 pref_millis=1102 prefill_elapsed_ms=1123 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6999078.86369256 REALTIME_END_PERF_FORMAT=6999088.86507118 ############################################################################### ################################## 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 3678 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.078s tree_stats_numInternalsAtDepth=1 1 8 64 484 3678 28430 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 195605 tree_stats_numNodesAtDepth=1 1 8 64 484 3678 28430 195605 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 999559 tree_stats_avgDegreeAtDepth=1 8 8 7.5625 7.59917 7.72974 6.88023 5.11009 tree_stats_height=8 tree_stats_numInternals=32666 tree_stats_numLeaves=195605 tree_stats_numNodes=228271 tree_stats_numKeys=999559 tree_stats_avgDegreeInternal=6.98803 tree_stats_avgDegreeLeaves=5.11009 tree_stats_avgDegree=5.37883 tree_stats_avgKeyDepth=7 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:64021 2:79540 4:12305 8:96 [2^00, 2^01]: 64021 (2^01, 2^02]: 79540 (2^02, 2^03]: 12305 (2^03, 2^04]: 96 sum_limbo_reclamation_event_size_total=281953 count_limbo_reclamation_event_size_by_thread=3252 3304 3286 3282 3208 3206 3314 3256 3258 3198 3258 3184 3294 3324 3310 3194 3294 3216 3198 3390 3082 3266 3274 3216 3140 3236 3268 3346 3420 3238 3276 3310 3354 3114 3096 3202 3274 3194 3306 3234 3230 3184 3310 3276 3284 3164 3334 3108 count_limbo_reclamation_event_size_total=155962 sum_limbo_reclamation_event_count_total=3401374 first_thread_announced_epoch_by_thread=76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 76880 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=363 sum_abtree_erase_repeat_total=73 sum_abtree_search_repeat_total=18 sum_abtree_search_complete_total=78806783 sum_abtree_fix_weight_viol_attempt_total=74763 sum_abtree_fix_degree_viol_attempt_total=583126 sum_abtree_rebalancing_kcas_attempt_total=657819 sum_abtree_update_kcas_attempt_total=39079831 sum_abtree_internal_complex_search_while_iters_total=78806849 sum_abtree_internal_basic_search_while_iters_total=703440107 sum_kcas_desc_new_total= sum_num_inserts_by_thread=810407 809706 814641 816588 816152 809159 808814 812323 821606 822516 813569 807903 813098 816499 820884 817883 816178 812505 809305 814685 817864 820321 813032 807032 809800 813857 818027 814470 818827 809761 808968 811112 820416 821381 811484 810880 810680 815864 817681 820025 813579 808415 805292 811362 816932 818225 812686 805427 sum_num_inserts_total=39067821 sum_num_deletes_by_thread=810743 810860 816371 817389 814506 809677 808687 813570 820609 823205 817441 807894 812128 815541 820219 821910 815796 813354 809091 815082 818488 817776 814066 806989 810062 812480 818549 815300 816593 808280 809224 811737 820579 822508 811989 810561 810997 814889 820994 821156 815444 807325 804797 810873 816897 820145 811014 806670 sum_num_deletes_total=39080455 sum_num_searches_by_thread=14562837 14605055 14696927 14713327 14679560 14553814 14583163 14645537 14781087 14823167 14675922 14553536 14604546 14678505 14771285 14760740 14683821 14636176 14588207 14640699 14732785 14753164 14652667 14532333 14601221 14644791 14739282 14667469 14700634 14542783 14570226 14612320 14775537 14797669 14587255 14589174 14590128 14692342 14766350 14778154 14658719 14548613 14481593 14588682 14715738 14732022 14643229 14504034 sum_num_searches_total=703436825 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=16183987 16225621 16327939 16347304 16310218 16172650 16200664 16271430 16423302 16468888 16306932 16169333 16229772 16310545 16412388 16400533 16315795 16262035 16206603 16270466 16369137 16391261 16279765 16146354 16221083 16271128 16375858 16297239 16336054 16160824 16188418 16235169 16416532 16441558 16210728 16210615 16211805 16323095 16405025 16419335 16287742 16164353 16091682 16210917 16349567 16370392 16266929 16116131 average_num_operations_total=16283022 stdev_num_operations_total=13751 sum_num_operations_total=781585101 min_num_operations_total=16091682 max_num_operations_total=16468888 first_time_thread_terminate_by_thread=10000137 10000137 10000138 10000137 10000137 10000138 10000137 10000137 10000137 10000138 10000137 10000138 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000139 10000137 10000137 10000138 10000137 10000137 10000137 10000138 10000137 10000138 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 min_time_thread_terminate_total=10000137 max_time_thread_terminate_total=10000139 first_time_thread_start_by_thread=3 4 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 4 4 4 3 4 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 4 4 4 min_time_thread_start_total=3 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=1000151694545 threads_final_size=999559 final_keysum=1000151694545 final_size=999559 validate_result=success Validation OK. Structural validation OK. total_find=703436825 total_rq=0 total_inserts=39067821 total_deletes=39080455 total_updates=78148276 total_queries=703436825 total_ops=781585101 find_throughput=70343682 rq_throughput=0 update_throughput=7814827 query_throughput=70343682 total_throughput=78158510 total find : 703436825 total rq : 0 total inserts : 39067821 total deletes : 39080455 total updates : 78148276 total queries : 703436825 total ops : 781585101 find throughput : 70343682 rq throughput : 0 update throughput : 7814827 query throughput : 70343682 total throughput : 78158510 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=11.2812 PAPI_L3_TCM=1.24434 PAPI_TOT_CYC=1622.33 PAPI_TOT_INS=891.171 garbage=344308273902167 total_execution_walltime=11.501s REALTIME_MAIN_END_PERF_FORMAT=6999088.268078221 [time_cmd_output] time_elapsed_sec=11.62, faults_major=0, faults_minor=87652, mem_maxresident_kb=351400, user_cputime=568.18, sys_cputime=1.37, percent_cpu=4899% timeout=false algorithm=brown_sigouin_abtree_kcas_validate.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=1