__step=000466 __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 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=data000466.txt __path_data=data/data000466.txt __hostname=jax sizeof(kcasdesc_t)=1920 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x5605f132a480 addrof(kcasDescriptors[1])=0x5605f132ac00 addrof(rdcssDescriptors[0])=0x5605f141a480 addrof(rdcssDescriptors[1])=0x5605f141a540 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6984524.840132386 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.007s prefilling_size=1000044 prefilling_elapsed_millis=1.001s finished prefilling to size 1000049 for expected size 1000000 keysum=1000395803938, performing 65508710 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=1000049 pref_millis=1102 prefill_elapsed_ms=1125 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6984526.161953817 REALTIME_END_PERF_FORMAT=6984536.162116938 ############################################################################### ################################## 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.06s tree_stats_numInternalsAtDepth=1 1 8 66 482 3678 28458 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 195745 tree_stats_numNodesAtDepth=1 1 8 66 482 3678 28458 195745 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 1000914 tree_stats_avgDegreeAtDepth=1 8 8.25 7.30303 7.63071 7.73736 6.87838 5.11336 tree_stats_height=8 tree_stats_numInternals=32694 tree_stats_numLeaves=195745 tree_stats_numNodes=228439 tree_stats_numKeys=1000914 tree_stats_avgDegreeInternal=6.98718 tree_stats_avgDegreeLeaves=5.11336 tree_stats_avgDegree=5.38154 tree_stats_avgKeyDepth=7 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:63501 2:79021 4:12420 8:118 [2^00, 2^01]: 63501 (2^01, 2^02]: 79021 (2^02, 2^03]: 12420 (2^03, 2^04]: 118 sum_limbo_reclamation_event_size_total=280870 count_limbo_reclamation_event_size_by_thread=3268 3034 3278 3224 3138 3110 3098 3346 3358 3330 3266 3166 3152 3320 3274 3216 3178 3314 3164 3254 3302 3258 3244 3076 3268 3172 3148 3272 3254 3124 3328 3188 3234 3392 3220 3302 3246 3322 3234 3064 3276 3182 3232 3168 3408 3194 3308 3156 count_limbo_reclamation_event_size_total=155060 sum_limbo_reclamation_event_count_total=3396764 first_thread_announced_epoch_by_thread=76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 76790 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=364 sum_abtree_erase_repeat_total=89 sum_abtree_search_repeat_total=28 sum_abtree_search_complete_total=78738691 sum_abtree_fix_weight_viol_attempt_total=74777 sum_abtree_fix_degree_viol_attempt_total=582011 sum_abtree_rebalancing_kcas_attempt_total=656719 sum_abtree_update_kcas_attempt_total=39036370 sum_abtree_internal_complex_search_while_iters_total=78738774 sum_abtree_internal_basic_search_while_iters_total=702590609 sum_kcas_desc_new_total= sum_num_inserts_by_thread=807351 813736 817728 816936 814828 808364 810370 811198 820698 821074 809890 806607 811397 814968 817129 819340 816138 812242 808346 810175 815823 818082 812503 803595 806631 808625 818916 817795 815404 808273 809113 810072 822933 822277 811723 806941 811651 814906 820443 820732 815784 812690 805277 812235 817081 819366 814464 804947 sum_num_inserts_total=39046797 sum_num_deletes_by_thread=807079 812721 816529 817949 814501 806030 808552 811234 820110 821803 808593 808428 811166 814721 815859 817918 815602 811123 809260 811022 815103 816170 812556 806098 807010 808938 816269 818776 814101 808966 811354 810474 821006 821545 812781 806463 812185 814992 819435 820015 815984 810974 805903 812344 818378 820114 812859 803472 sum_num_deletes_total=39034465 sum_num_searches_by_thread=14531880 14616029 14687245 14711743 14657267 14530459 14568364 14594264 14756012 14791194 14582470 14555038 14602790 14659331 14702254 14725185 14667724 14608262 14535484 14598978 14670015 14709985 14618997 14484356 14517093 14557261 14717547 14723937 14689849 14545983 14575302 14592609 14785539 14776203 14621471 14522612 14604459 14681534 14777176 14774116 14672277 14625455 14503689 14605127 14702604 14730359 14653755 14466023 sum_num_searches_total=702587306 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=16146310 16242486 16321502 16346628 16286596 16144853 16187286 16216696 16396820 16434071 16200953 16170073 16225353 16289020 16335242 16362443 16299464 16231627 16153090 16220175 16300941 16344237 16244056 16094049 16130734 16174824 16352732 16360508 16319354 16163222 16195769 16213155 16429478 16420025 16245975 16136016 16228295 16311432 16417054 16414863 16304045 16249119 16114869 16229706 16338063 16369839 16281078 16074442 average_num_operations_total=16263928 stdev_num_operations_total=14061 sum_num_operations_total=780668568 min_num_operations_total=16074442 max_num_operations_total=16434071 first_time_thread_terminate_by_thread=10000163 10000164 10000164 10000164 10000164 10000164 10000163 10000164 10000164 10000163 10000164 10000164 10000164 10000164 10000164 10000164 10000164 10000163 10000164 10000163 10000164 10000164 10000164 10000163 10000163 10000164 10000164 10000164 10000164 10000164 10000163 10000164 10000164 10000163 10000164 10000164 10000164 10000164 10000164 10000164 10000164 10000163 10000164 10000163 10000164 10000164 10000164 10000163 min_time_thread_terminate_total=10000163 max_time_thread_terminate_total=10000164 first_time_thread_start_by_thread=4 3 3 4 3 3 4 4 3 4 3 4 3 3 4 3 4 4 4 3 4 4 3 4 4 3 3 4 3 3 4 4 3 4 3 4 3 3 4 3 4 4 4 3 4 4 3 4 min_time_thread_start_total=3 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=1001488756365 threads_final_size=1000914 final_keysum=1001488756365 final_size=1000914 validate_result=success Validation OK. Structural validation OK. total_find=702587306 total_rq=0 total_inserts=39046797 total_deletes=39034465 total_updates=78081262 total_queries=702587306 total_ops=780668568 find_throughput=70258730 rq_throughput=0 update_throughput=7808126 query_throughput=70258730 total_throughput=78066856 total find : 702587306 total rq : 0 total inserts : 39046797 total deletes : 39034465 total updates : 78081262 total queries : 702587306 total ops : 780668568 find throughput : 70258730 rq throughput : 0 update throughput : 7808126 query throughput : 70258730 total throughput : 78066856 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=11.2312 PAPI_L3_TCM=1.23968 PAPI_TOT_CYC=1627.09 PAPI_TOT_INS=890.656 garbage=351317070604379 total_execution_walltime=11.473s REALTIME_MAIN_END_PERF_FORMAT=6984536.313995743 [time_cmd_output] time_elapsed_sec=11.62, faults_major=0, faults_minor=87648, mem_maxresident_kb=351276, user_cputime=566.59, sys_cputime=3.03, percent_cpu=4902% 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