__step=000465 __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=data000465.txt __path_data=data/data000465.txt __hostname=jax sizeof(kcasdesc_t)=1920 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x560cb0ac1480 addrof(kcasDescriptors[1])=0x560cb0ac1c00 addrof(rdcssDescriptors[0])=0x560cb0bb1480 addrof(rdcssDescriptors[1])=0x560cb0bb1540 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6984513.196574046 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.005s prefilling_size=999234 prefilling_elapsed_millis=1.001s finished prefilling to size 999282 for expected size 1000000 keysum=999227387083, performing 65753863 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=999282 pref_millis=1102 prefill_elapsed_ms=1132 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6984514.473631490 REALTIME_END_PERF_FORMAT=6984524.473776115 ############################################################################### ################################## 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 3656 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.055s tree_stats_numInternalsAtDepth=1 1 8 66 496 3656 28371 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 195331 tree_stats_numNodesAtDepth=1 1 8 66 496 3656 28371 195331 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 999615 tree_stats_avgDegreeAtDepth=1 8 8.25 7.51515 7.37097 7.76012 6.88488 5.11754 tree_stats_height=8 tree_stats_numInternals=32599 tree_stats_numLeaves=195331 tree_stats_numNodes=227930 tree_stats_numKeys=999615 tree_stats_avgDegreeInternal=6.99193 tree_stats_avgDegreeLeaves=5.11754 tree_stats_avgDegree=5.38562 tree_stats_avgKeyDepth=7 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:63252 2:78564 4:12135 8:162 16:37 [2^00, 2^01]: 63252 (2^01, 2^02]: 78564 (2^02, 2^03]: 12135 (2^03, 2^04]: 162 (2^04, 2^05]: 37 sum_limbo_reclamation_event_size_total=280123 count_limbo_reclamation_event_size_by_thread=3234 3132 3224 3352 3290 3206 3290 3172 3184 3198 3244 3264 3194 3222 3176 3264 3134 3262 3130 3240 3282 3188 3208 3182 3176 3224 3240 3130 3288 3302 3168 3218 3184 3298 3238 3094 3144 3168 3212 3272 3170 3264 3124 3106 3154 3276 3166 3262 count_limbo_reclamation_event_size_total=154150 sum_limbo_reclamation_event_count_total=3375072 first_thread_announced_epoch_by_thread=76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 76356 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=348 sum_abtree_erase_repeat_total=75 sum_abtree_search_repeat_total=26 sum_abtree_search_complete_total=78344267 sum_abtree_fix_weight_viol_attempt_total=73741 sum_abtree_fix_degree_viol_attempt_total=576194 sum_abtree_rebalancing_kcas_attempt_total=649870 sum_abtree_update_kcas_attempt_total=38847334 sum_abtree_internal_complex_search_while_iters_total=78344338 sum_abtree_internal_basic_search_while_iters_total=699259061 sum_kcas_desc_new_total= sum_num_inserts_by_thread=805360 809233 815422 814137 809964 802438 805416 806859 815998 815030 806523 802355 807695 808851 813782 813528 807104 808269 803041 808889 813654 814893 807014 803384 804773 809015 815071 814371 809767 803638 805682 809307 814196 817345 810225 804262 806334 812126 814333 815588 808788 807161 803345 808806 814230 813806 807911 800014 sum_num_inserts_total=38848933 sum_num_deletes_by_thread=803719 807794 812122 813629 809148 801987 804785 809286 816583 817316 807738 805967 807684 810846 814745 813991 809551 808372 804384 808339 814054 815654 806063 802118 803414 808521 815798 812301 811756 800562 804548 808592 815306 814837 810237 804029 807636 811315 813316 813921 808440 808169 801396 808108 814219 813441 806911 802157 sum_num_deletes_total=38844805 sum_num_searches_by_thread=14481449 14562902 14656127 14642220 14572941 14453043 14497168 14565704 14683718 14687316 14523416 14464101 14525106 14561805 14665443 14656486 14539627 14523870 14476862 14547157 14659641 14699871 14520983 14441365 14476568 14550734 14669376 14652782 14595138 14442212 14503240 14561233 14664642 14696208 14567092 14497524 14523935 14588895 14650296 14669976 14572004 14534884 14455211 14544307 14647292 14637269 14539342 14407425 sum_num_searches_total=699255906 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=16090528 16179929 16283671 16269986 16192053 16057468 16107369 16181849 16316299 16319662 16137677 16072423 16140485 16181502 16293970 16284005 16156282 16140511 16084287 16164385 16287349 16330418 16134060 16046867 16084755 16168270 16300245 16279454 16216661 16046412 16113470 16179132 16294144 16328390 16187554 16105815 16137905 16212336 16277945 16299485 16189232 16150214 16059952 16161221 16275741 16264516 16154164 16009596 average_num_operations_total=16186450 stdev_num_operations_total=13009 sum_num_operations_total=776949644 min_num_operations_total=16009596 max_num_operations_total=16330418 first_time_thread_terminate_by_thread=10000145 10000145 10000145 10000145 10000146 10000145 10000145 10000145 10000145 10000146 10000145 10000146 10000145 10000145 10000145 10000145 10000145 10000145 10000146 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000146 10000145 10000145 10000145 10000145 10000146 10000145 10000146 10000145 10000145 10000145 10000145 10000145 10000145 10000146 10000145 10000145 10000145 10000145 10000145 min_time_thread_terminate_total=10000145 max_time_thread_terminate_total=10000146 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=1000038106833 threads_final_size=999615 final_keysum=1000038106833 final_size=999615 validate_result=success Validation OK. Structural validation OK. total_find=699255906 total_rq=0 total_inserts=38848933 total_deletes=38844805 total_updates=77693738 total_queries=699255906 total_ops=776949644 find_throughput=69925590 rq_throughput=0 update_throughput=7769373 query_throughput=69925590 total_throughput=77694964 total find : 699255906 total rq : 0 total inserts : 38848933 total deletes : 38844805 total updates : 77693738 total queries : 699255906 total ops : 776949644 find throughput : 69925590 rq throughput : 0 update throughput : 7769373 query throughput : 69925590 total throughput : 77694964 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=11.2666 PAPI_L3_TCM=1.24218 PAPI_TOT_CYC=1632.95 PAPI_TOT_INS=890.33 garbage=342373392191838 total_execution_walltime=11.441s REALTIME_MAIN_END_PERF_FORMAT=6984524.638193951 [time_cmd_output] time_elapsed_sec=11.56, faults_major=0, faults_minor=87528, mem_maxresident_kb=350956, user_cputime=565.85, sys_cputime=2.57, percent_cpu=4914% 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