__step=000804 __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 96 -nprefill 96 -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=data000804.txt __path_data=data/data000804.txt __hostname=jax sizeof(kcasdesc_t)=1920 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x5640c96ca480 addrof(kcasDescriptors[1])=0x5640c96cac00 addrof(rdcssDescriptors[0])=0x5640c97ba480 addrof(rdcssDescriptors[1])=0x5640c97ba540 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6988678.84136753 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=96 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=96 WORK_THREADS=96 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,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.048s prefilling_size=1001164 prefilling_elapsed_millis=1s finished prefilling to size 1001193 for expected size 1000000 keysum=1001658796784, performing 94292326 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=1001193 pref_millis=1102 prefill_elapsed_ms=1128 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6988679.444155748 REALTIME_END_PERF_FORMAT=6988689.444243500 ############################################################################### ################################## TIME IS UP ################################# ############################################################################### joining threads... ############################################################################### ################################# END RUNNING ################################# ############################################################################### 10.1s PRODUCING OUTPUT computing tree_stats in PARALLEL... bounded depth BFS to partition into subtrees for parallel computation (192 threads)... partitioned into 3977 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 72 539 3977 30896 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 194769 tree_stats_numNodesAtDepth=1 1 8 72 539 3977 30896 194769 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 1000393 tree_stats_avgDegreeAtDepth=1 8 9 7.48611 7.37848 7.76867 6.30402 5.13631 tree_stats_height=8 tree_stats_numInternals=35494 tree_stats_numLeaves=194769 tree_stats_numNodes=230263 tree_stats_numKeys=1000393 tree_stats_avgDegreeInternal=6.48738 tree_stats_avgDegreeLeaves=5.13631 tree_stats_avgDegree=5.34457 tree_stats_avgKeyDepth=7 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:1646 2:21816 4:215479 8:530031 16:189049 32:814 64:111 128:142 256:44 [2^00, 2^01]: 1646 (2^01, 2^02]: 21816 (2^02, 2^03]: 215479 (2^03, 2^04]: 530031 (2^04, 2^05]: 189049 (2^05, 2^06]: 814 (2^06, 2^07]: 111 (2^07, 2^08]: 142 (2^08, 2^09]: 44 sum_limbo_reclamation_event_size_total=10827545 count_limbo_reclamation_event_size_by_thread=9982 9986 9992 9990 9992 9990 9988 9990 9990 9990 9992 9990 9992 9986 9992 9994 9994 9992 9994 9988 9986 9988 9992 9986 9990 9996 9992 9992 9992 9986 9994 9994 9992 9990 9990 9990 9990 9990 9988 9994 9992 9996 9990 9990 9984 9992 9996 9992 9994 9990 9992 9992 9990 9994 9988 9994 9988 9990 9992 9996 9996 9994 9990 9996 9990 9986 9992 9994 9986 9992 9994 9990 9992 9990 9982 9996 9992 9986 9994 9988 9996 9988 9994 9994 9994 9988 9992 9992 9992 9992 9996 9992 9992 9988 9982 9992 count_limbo_reclamation_event_size_total=959132 sum_limbo_reclamation_event_count_total=2048640 first_thread_announced_epoch_by_thread=23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 23506 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=71628 sum_abtree_erase_repeat_total=10042 sum_abtree_search_repeat_total=7077 sum_abtree_search_complete_total=938882104 sum_abtree_fix_weight_viol_attempt_total=876820 sum_abtree_fix_degree_viol_attempt_total=6789164 sum_abtree_rebalancing_kcas_attempt_total=7656438 sum_abtree_update_kcas_attempt_total=465617509 sum_abtree_internal_complex_search_while_iters_total=938898513 sum_abtree_internal_basic_search_while_iters_total= sum_kcas_desc_new_total= sum_num_inserts_by_thread=4819131 4822134 4857681 4882077 4869912 4781936 4793923 4838390 4879615 4842466 4818241 4815715 4855953 4847869 4850733 4860353 4859172 4803463 4790750 4843140 4886833 4835586 4784074 4807796 4817540 4788920 4818630 4846505 4860696 4814971 4794314 4824270 4873259 4827066 4804158 4824361 4849271 4806989 4843790 4858953 4869453 4773456 4785407 4811820 4863964 4822297 4801248 4803839 4854620 4849013 4840272 4914370 4860213 4813317 4831405 4906197 4915212 4894104 4856322 4874568 4854657 4829323 4868238 4909844 4885744 4845005 4862495 4888508 5001662 4875561 4843872 4868699 4829197 4857462 4888675 4914320 4852745 4832000 4826923 4873277 4878585 4858910 4875743 4870114 4834388 4828698 4837973 4925610 4865961 4828428 4809976 4907864 4899689 4906496 4860847 4910777 sum_num_inserts_total=465549999 sum_num_deletes_by_thread=4818748 4824295 4861212 4883400 4866870 4781216 4793316 4837608 4881165 4840211 4819061 4815753 4858810 4848603 4850645 4861147 4858035 4807803 4788801 4844238 4887532 4836292 4783566 4807071 4817228 4790172 4819829 4848272 4865731 4815879 4797045 4828029 4874371 4826219 4804877 4823747 4843668 4804381 4841028 4856929 4869908 4775069 4782423 4811156 4857378 4817582 4802074 4805702 4855472 4848276 4838588 4913041 4865943 4812389 4833278 4906551 4916527 4895251 4856559 4872314 4859045 4833523 4870631 4916234 4881282 4847933 4863452 4892607 4998165 4878798 4842992 4868382 4830448 4861685 4889974 4911696 4849511 4829176 4829842 4867572 4876997 4858728 4876782 4867171 4838412 4833281 4839715 4921816 4862809 4825474 4810639 4905649 4895821 4901781 4862237 4910401 sum_num_deletes_total=465558945 sum_num_searches_by_thread= sum_num_searches_total= sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=9637879 9646429 9718893 9765477 9736782 9563152 9587239 9675998 9760780 9682677 9637302 9631468 9714763 9696472 9701378 9721500 9717207 9611266 9579551 9687378 9774365 9671878 9567640 9614867 9634768 9579092 9638459 9694777 9726427 9630850 9591359 9652299 9747630 9653285 9609035 9648108 9692939 9611370 9684818 9715882 9739361 9548525 9567830 9622976 9721342 9639879 9603322 9609541 9710092 9697289 9678860 9827411 9726156 9625706 9664683 9812748 9831739 9789355 9712881 9746882 9713702 9662846 9738869 9826078 9767026 9692938 9725947 9781115 9999827 9754359 9686864 9737081 9659645 9719147 9778649 9826016 9702256 9661176 9656765 9740849 9755582 9717638 9752525 9737285 9672800 9661979 9677688 9847426 9728770 9653902 9620615 9813513 9795510 9808277 9723084 9821178 average_num_operations_total=9699051 stdev_num_operations_total=7852 sum_num_operations_total=931108944 min_num_operations_total=9548525 max_num_operations_total=9999827 first_time_thread_terminate_by_thread=10000089 10000091 10000091 10000089 10000089 10000090 10000090 10000089 10000089 10000089 10000090 10000092 10000089 10000089 10000089 10000090 10000089 10000089 10000089 10000089 10000089 10000089 10000090 10000089 10000089 10000089 10000088 10000089 10000089 10000090 10000090 10000089 10000091 10000089 10000088 10000092 10000089 10000089 10000091 10000091 10000089 10000089 10000089 10000089 10000089 10000089 10000089 10000089 10000089 10000092 10000092 10000088 10000089 10000088 10000090 10000088 10000089 10000089 10000089 10000091 10000088 10000091 10000088 10000087 10000088 10000091 10000090 10000090 10000090 10000088 10000089 10000088 10000088 10000091 10000091 10000088 10000089 10000089 10000088 10000088 10000089 10000088 10000089 10000091 10000088 10000090 10000090 10000157 10000088 10000090 10000088 10000090 10000090 10000088 10000089 10000088 min_time_thread_terminate_total=10000087 max_time_thread_terminate_total=10000157 first_time_thread_start_by_thread=6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 5 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 5 6 6 6 6 6 5 5 5 6 6 5 5 6 17 5 5 5 6 5 5 5 6 5 6 5 5 5 6 6 5 5 5 6 6 5 5 6 17 5 5 5 6 5 17 5 6 5 6 5 5 5 6 min_time_thread_start_total=5 max_time_thread_start_total=17 sum_duration_all_ops_total= threads_final_keysum=1000770598826 threads_final_size=1000393 final_keysum=1000770598826 final_size=1000393 validate_result=success Validation OK. Structural validation OK. total_find=0 total_rq=0 total_inserts=465549999 total_deletes=465558945 total_updates=931108944 total_queries=0 total_ops=931108944 find_throughput=0 rq_throughput=0 update_throughput=93110894 query_throughput=0 total_throughput=93110894 total find : 0 total rq : 0 total inserts : 465549999 total deletes : 465558945 total updates : 931108944 total queries : 0 total ops : 931108944 find throughput : 0 rq throughput : 0 update throughput : 93110894 query throughput : 0 total throughput : 93110894 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=13.1482 PAPI_L3_TCM=2.95695 PAPI_TOT_CYC=2846.41 PAPI_TOT_INS=1333.7 garbage=0 total_execution_walltime=11.632s REALTIME_MAIN_END_PERF_FORMAT=6988689.716909387 [time_cmd_output] time_elapsed_sec=11.76, faults_major=0, faults_minor=92557, mem_maxresident_kb=365676, user_cputime=1101.66, sys_cputime=2.32, percent_cpu=9383% 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=2