__step=000858 __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" ./sigouin_int_bst_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=data000858.txt __path_data=data/data000858.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x55f6e7c37400 addrof(kcasDescriptors[1])=0x55f6e7c37d00 addrof(rdcssDescriptors[0])=0x55f6e7d57400 addrof(rdcssDescriptors[1])=0x55f6e7d574c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6989311.563377430 binary=./sigouin_int_bst_kcas_validate.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=sigouin_int_bst_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=56 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.006s prefilling_size=998930 prefilling_elapsed_millis=1.001s finished prefilling to size 998862 for expected size 1000000 keysum=999133871318, performing 38024300 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=998862 pref_millis=1102 prefill_elapsed_ms=1125 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6989312.858811366 REALTIME_END_PERF_FORMAT=6989322.858959403 ############################################################################### ################################## 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 949 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.033s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 251 483 931 1739 3120 5257 8601 13199 19187 25959 33445 40526 46737 51459 53682 53588 50995 46389 41091 35657 29979 24208 18979 14722 10945 8009 5849 3933 2542 1526 850 445 228 118 57 25 5 2 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 3 7 18 66 189 530 1066 2169 3921 6789 10042 14109 18377 22312 26144 28628 29674 29324 27168 24408 21569 18663 15323 12083 9625 7269 5257 4025 2721 1824 1125 629 341 181 89 49 27 4 2 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 254 490 949 1805 3309 5787 9667 15368 23108 32748 43487 54635 65114 73771 79826 82216 80669 75713 68259 60065 51548 42871 34302 26805 20570 15278 11106 7958 5263 3350 1975 1074 569 299 146 74 32 6 2 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 254 490 949 1805 3309 5787 9667 15368 23108 32748 43487 54635 65114 73771 79826 82216 80669 75713 68259 60065 51548 42871 34302 26805 20570 15278 11106 7958 5263 3350 1975 1074 569 299 146 74 32 6 2 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.98438 1.94094 1.95102 1.92097 1.86981 1.80598 1.76205 1.70001 1.64478 1.58685 1.53524 1.48727 1.45004 1.41518 1.38453 1.35745 1.32939 1.30641 1.28885 1.27797 1.26456 1.2501 1.23545 1.22815 1.21817 1.21065 1.20271 1.1899 1.16713 1.15352 1.13403 1.11342 1.11546 1.12478 1.09365 1.11644 1.09459 1.03125 1 1 tree_stats_height=47 tree_stats_numInternals=654973 tree_stats_numLeaves=345750 tree_stats_numNodes=1000723 tree_stats_numKeys=1000723 tree_stats_avgDegreeInternal=1.52788 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.3455 tree_stats_avgKeyDepth=23.8138 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:0 16:3 32:243 64:454730 128:24928 (2^04, 2^05]: 3 (2^05, 2^06]: 243 (2^06, 2^07]: 454730 (2^07, 2^08]: 24928 sum_limbo_reclamation_event_size_total=53939153 count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 count_limbo_reclamation_event_size_total=479904 sum_limbo_reclamation_event_count_total=799584 first_thread_announced_epoch_by_thread=36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 36840 sum_num_inserts_by_thread=3715034 3730190 3751351 3766900 3749293 3713065 3719465 3738003 3774101 3789125 3745989 3738416 3737809 3753122 3768595 3775015 3755013 3722765 3713804 3737886 3756326 3773836 3741852 3705428 3713683 3733856 3757751 3769589 3751667 3722942 3724732 3744673 3779067 3782117 3746097 3728462 3734447 3754827 3770948 3778827 3757348 3738757 3703683 3736475 3755390 3779210 3742810 3715685 sum_num_inserts_total=179795426 sum_num_deletes_by_thread=3712835 3727471 3749441 3765354 3751771 3715869 3720971 3738845 3771212 3787352 3744619 3740532 3741968 3751407 3769083 3777988 3756881 3720116 3712401 3733437 3757982 3774809 3739144 3705219 3712801 3732591 3764990 3768355 3752416 3724947 3721074 3744191 3776219 3782194 3746893 3727361 3734489 3759127 3771871 3775637 3757606 3738043 3704739 3741694 3759965 3776677 3741950 3715193 sum_num_deletes_total=179797730 sum_num_searches_by_thread= sum_num_searches_total= sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=7427869 7457661 7500792 7532254 7501064 7428934 7440436 7476848 7545313 7576477 7490608 7478948 7479777 7504529 7537678 7553003 7511894 7442881 7426205 7471323 7514308 7548645 7480996 7410647 7426484 7466447 7522741 7537944 7504083 7447889 7445806 7488864 7555286 7564311 7492990 7455823 7468936 7513954 7542819 7554464 7514954 7476800 7408422 7478169 7515355 7555887 7484760 7430878 average_num_operations_total=7491524 stdev_num_operations_total=6552 sum_num_operations_total=359593156 min_num_operations_total=7408422 max_num_operations_total=7576477 first_time_thread_terminate_by_thread=10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000147 10000146 10000146 10000147 10000147 10000146 10000147 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000147 10000146 10000146 10000146 10000146 10000146 10000146 10000147 10000147 10000146 10000147 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000147 10000146 min_time_thread_terminate_total=10000146 max_time_thread_terminate_total=10000147 first_time_thread_start_by_thread=3 3 4 3 4 3 3 3 3 3 4 4 4 4 4 3 4 3 3 3 4 4 3 3 3 3 4 3 4 3 3 3 3 3 4 4 4 4 4 3 4 3 3 3 4 4 3 3 min_time_thread_start_total=3 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=1000855205669 threads_final_size=1000723 final_keysum=1000855205669 final_size=1000723 validate_result=success Validation OK. Structural validation OK. total_find=0 total_rq=0 total_inserts=179795426 total_deletes=179797730 total_updates=359593156 total_queries=0 total_ops=359593156 find_throughput=0 rq_throughput=0 update_throughput=35959315 query_throughput=0 total_throughput=35959315 total find : 0 total rq : 0 total inserts : 179795426 total deletes : 179797730 total updates : 359593156 total queries : 0 total ops : 359593156 find throughput : 0 rq throughput : 0 update throughput : 35959315 query throughput : 0 total throughput : 35959315 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=15.4264 PAPI_L3_TCM=2.3901 PAPI_TOT_CYC=3672.85 PAPI_TOT_INS=1963.07 garbage=0 total_execution_walltime=11.42s REALTIME_MAIN_END_PERF_FORMAT=6989322.996849733 [time_cmd_output] time_elapsed_sec=11.56, faults_major=0, faults_minor=92364, mem_maxresident_kb=370904, user_cputime=561.26, sys_cputime=2.77, percent_cpu=4879% timeout=false algorithm=sigouin_int_bst_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