__step=000801 __cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 60 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 50.0 50.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000801.txt __path_data=data/data000801.txt __hostname=jax sizeof(kcasdesc_t)=1920 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x55c0b4096480 addrof(kcasDescriptors[1])=0x55c0b4096c00 addrof(rdcssDescriptors[0])=0x55c0b4186480 addrof(rdcssDescriptors[1])=0x55c0b4186540 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6988643.43793110 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=50 DEL_FRAC=50 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=50.0 50.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=999914 prefilling_elapsed_millis=1.001s finished prefilling to size 999897 for expected size 1000000 keysum=999956381643, performing 65988041 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=999897 pref_millis=1102 prefill_elapsed_ms=1124 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6988644.334206671 REALTIME_END_PERF_FORMAT=6988654.334354465 ############################################################################### ################################## 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 3934 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.062s tree_stats_numInternalsAtDepth=1 1 8 71 534 3934 30531 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 194925 tree_stats_numNodesAtDepth=1 1 8 71 534 3934 30531 194925 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 1000685 tree_stats_avgDegreeAtDepth=1 8 8.875 7.52113 7.36704 7.7608 6.38449 5.13369 tree_stats_height=8 tree_stats_numInternals=35080 tree_stats_numLeaves=194925 tree_stats_numNodes=230005 tree_stats_numKeys=1000685 tree_stats_avgDegreeInternal=6.55658 tree_stats_avgDegreeLeaves=5.13369 tree_stats_avgDegree=5.35071 tree_stats_avgKeyDepth=7 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:19408 2:100382 4:222500 8:122790 16:4842 [2^00, 2^01]: 19408 (2^01, 2^02]: 100382 (2^02, 2^03]: 222500 (2^03, 2^04]: 122790 (2^04, 2^05]: 4842 sum_limbo_reclamation_event_size_total=2730370 count_limbo_reclamation_event_size_by_thread=9798 9788 9822 9818 9814 9792 9774 9784 9796 9830 9758 9770 9718 9780 9786 9780 9836 9796 9788 9766 9820 9772 9780 9776 9778 9774 9826 9786 9794 9762 9782 9806 9810 9768 9778 9796 9746 9776 9828 9796 9796 9780 9774 9790 9846 9786 9800 9802 count_limbo_reclamation_event_size_total=469922 sum_limbo_reclamation_event_count_total=2704608 first_thread_announced_epoch_by_thread=62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 62404 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=20289 sum_abtree_erase_repeat_total=3871 sum_abtree_search_repeat_total=1272 sum_abtree_search_complete_total=620506721 sum_abtree_fix_weight_viol_attempt_total=580792 sum_abtree_fix_degree_viol_attempt_total=4505779 sum_abtree_rebalancing_kcas_attempt_total=5082974 sum_abtree_update_kcas_attempt_total=307708925 sum_abtree_internal_complex_search_while_iters_total=620511333 sum_abtree_internal_basic_search_while_iters_total= sum_kcas_desc_new_total= sum_num_inserts_by_thread=6349184 6350444 6436887 6430690 6420683 6360734 6376059 6395462 6445025 6457171 6427396 6389079 6406720 6425510 6473149 6445272 6411886 6384965 6345714 6402401 6420874 6463989 6383863 6373833 6346830 6371981 6434496 6436750 6421772 6375178 6396081 6419372 6468807 6469352 6407641 6386562 6436974 6436972 6466952 6465288 6417456 6375982 6327590 6385838 6446488 6458293 6400646 6386977 sum_num_inserts_total=307717268 sum_num_deletes_by_thread=6343432 6351256 6438829 6432210 6420646 6367811 6372418 6400148 6442672 6458742 6429908 6386806 6400481 6429952 6466045 6444641 6410829 6384717 6352967 6403989 6422893 6460995 6382376 6371826 6352656 6368412 6429094 6431826 6421419 6376252 6392958 6415393 6468391 6459842 6408188 6386126 6430588 6431201 6466198 6467494 6419231 6372669 6323732 6381928 6439598 6456983 6400415 6390832 sum_num_deletes_total=307668015 sum_num_searches_by_thread= sum_num_searches_total= sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=12692616 12701700 12875716 12862900 12841329 12728545 12748477 12795610 12887697 12915913 12857304 12775885 12807201 12855462 12939194 12889913 12822715 12769682 12698681 12806390 12843767 12924984 12766239 12745659 12699486 12740393 12863590 12868576 12843191 12751430 12789039 12834765 12937198 12929194 12815829 12772688 12867562 12868173 12933150 12932782 12836687 12748651 12651322 12767766 12886086 12915276 12801061 12777809 average_num_operations_total=12820526 stdev_num_operations_total=10982 sum_num_operations_total=615385283 min_num_operations_total=12651322 max_num_operations_total=12939194 first_time_thread_terminate_by_thread=10000148 10000148 10000148 10000148 10000147 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000147 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 min_time_thread_terminate_total=10000147 max_time_thread_terminate_total=10000148 first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 min_time_thread_start_total=3 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=1000358050017 threads_final_size=1000685 final_keysum=1000358050017 final_size=1000685 validate_result=success Validation OK. Structural validation OK. total_find=0 total_rq=0 total_inserts=307717268 total_deletes=307668015 total_updates=615385283 total_queries=0 total_ops=615385283 find_throughput=0 rq_throughput=0 update_throughput=61538528 query_throughput=0 total_throughput=61538528 total find : 0 total rq : 0 total inserts : 307717268 total deletes : 307668015 total updates : 615385283 total queries : 0 total ops : 615385283 find throughput : 0 rq throughput : 0 update throughput : 61538528 query throughput : 0 total throughput : 61538528 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=12.01 PAPI_L3_TCM=1.31696 PAPI_TOT_CYC=2040.09 PAPI_TOT_INS=1333.75 garbage=0 total_execution_walltime=11.455s REALTIME_MAIN_END_PERF_FORMAT=6988654.499385707 [time_cmd_output] time_elapsed_sec=11.57, faults_major=0, faults_minor=88068, mem_maxresident_kb=353100, user_cputime=565.30, sys_cputime=2.62, percent_cpu=4906% 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