__step=000970 __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 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000970.txt __path_data=data/data000970.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x55ef5ba66400 addrof(kcasDescriptors[1])=0x55ef5ba66d00 addrof(rdcssDescriptors[0])=0x55ef5bb86400 addrof(rdcssDescriptors[1])=0x55ef5bb864c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6990624.37786509 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=200000 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=100029 prefilling_elapsed_millis=1.001s finished prefilling to size 100087 for expected size 100000 keysum=10008228564, performing 55603911 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=100087 pref_millis=1102 prefill_elapsed_ms=1122 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6990625.349899309 REALTIME_END_PERF_FORMAT=6990635.350030429 ############################################################################### ################################## 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 799 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.028s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 63 122 229 423 750 1253 1934 2872 4031 5220 6163 6816 6951 6539 5790 5001 3922 2763 1779 1056 556 283 116 60 44 39 36 37 36 39 35 32 30 25 21 21 24 19 18 13 13 15 10 6 4 4 1 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 1 2 9 24 49 142 311 557 938 1565 2304 2954 3569 3939 3888 3446 3174 2676 1947 1303 802 406 227 97 36 21 23 18 20 20 26 20 19 19 14 11 10 15 7 12 5 5 9 7 5 2 4 2 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 124 238 447 799 1395 2245 3429 4969 6785 8467 9770 10520 10478 9678 8447 7096 5439 3726 2359 1358 689 343 157 80 60 59 55 56 59 61 52 49 44 35 32 34 34 25 25 18 20 19 13 9 6 5 2 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 124 238 447 799 1395 2245 3429 4969 6785 8467 9770 10520 10478 9678 8447 7096 5439 3726 2359 1358 689 343 157 80 60 59 55 56 59 61 52 49 44 35 32 34 34 25 25 18 20 19 13 9 6 5 2 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.95312 1.93548 1.91597 1.84116 1.80726 1.71111 1.66592 1.61155 1.55424 1.47856 1.42601 1.37912 1.33527 1.29958 1.27454 1.24802 1.21378 1.17705 1.15566 1.12802 1.09794 1.08708 1.11953 1.12739 1.2 1.33333 1.32203 1.34545 1.41071 1.37288 1.27869 1.32692 1.28571 1.22727 1.31429 1.40625 1.29412 1.17647 1.28 1.2 1.38889 1.2 1.15789 1.23077 1.22222 1.16667 1.2 1 tree_stats_height=54 tree_stats_numInternals=65277 tree_stats_numLeaves=34660 tree_stats_numNodes=99937 tree_stats_numKeys=99937 tree_stats_avgDegreeInternal=1.53097 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.34682 tree_stats_avgKeyDepth=18.6533 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:22 2:1 4:8 8:12 16:38 32:418 64:461362 128:17886 256:17 512:30 1024:0 2048:39 [2^00, 2^01]: 22 (2^01, 2^02]: 1 (2^02, 2^03]: 8 (2^03, 2^04]: 12 (2^04, 2^05]: 38 (2^05, 2^06]: 418 (2^06, 2^07]: 461362 (2^07, 2^08]: 17886 (2^08, 2^09]: 17 (2^09, 2^10]: 30 (2^10, 2^11]: 0 (2^11, 2^12]: 39 sum_limbo_reclamation_event_size_total=53554828 count_limbo_reclamation_event_size_by_thread=9996 9997 9996 9997 9996 9996 9997 9996 9995 9997 9997 9996 9998 9998 9996 9997 9996 9996 9996 9996 9997 9997 9997 9998 9997 9996 9996 9997 9997 9996 9996 9996 9997 9997 9997 9996 9997 9996 9996 9997 9997 9996 9996 9996 9995 9997 9996 9998 count_limbo_reclamation_event_size_total=479833 sum_limbo_reclamation_event_count_total=1180825 first_thread_announced_epoch_by_thread=54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 54434 sum_num_inserts_by_thread=5432434 5470626 5483039 5521716 5487382 5444795 5432457 5440453 5532995 5525692 5487740 5482452 5466881 5487945 5516427 5493662 5537177 5491502 5453338 5486347 5485007 5537795 5456453 5466745 5442444 5500090 5479511 5518898 5499932 5463170 5456899 5499035 5529135 5555082 5518965 5488266 5489856 5475550 5511340 5518365 5476679 5454511 5451407 5467373 5512003 5551090 5506816 5461822 sum_num_inserts_total=263449299 sum_num_deletes_by_thread=5427833 5464208 5477680 5526492 5490115 5439731 5430836 5436726 5538364 5526231 5486316 5485079 5466350 5484190 5513997 5495287 5534330 5494092 5452668 5481177 5485893 5538843 5453986 5465040 5441559 5499702 5481354 5530000 5497238 5463788 5460307 5489176 5531383 5556651 5511414 5488065 5493747 5476615 5514002 5521508 5477432 5457375 5450359 5472464 5512539 5552553 5506483 5456386 sum_num_deletes_total=263437564 sum_num_searches_by_thread= sum_num_searches_total= sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=10860267 10934834 10960719 11048208 10977497 10884526 10863293 10877179 11071359 11051923 10974056 10967531 10933231 10972135 11030424 10988949 11071507 10985594 10906006 10967524 10970900 11076638 10910439 10931785 10884003 10999792 10960865 11048898 10997170 10926958 10917206 10988211 11060518 11111733 11030379 10976331 10983603 10952165 11025342 11039873 10954111 10911886 10901766 10939837 11024542 11103643 11013299 10918208 average_num_operations_total=10976809 stdev_num_operations_total=9355 sum_num_operations_total=526886863 min_num_operations_total=10860267 max_num_operations_total=11111733 first_time_thread_terminate_by_thread=10000131 10000130 10000131 10000131 10000130 10000131 10000130 10000131 10000131 10000131 10000130 10000130 10000130 10000130 10000130 10000130 10000130 10000130 10000131 10000130 10000130 10000130 10000131 10000130 10000131 10000130 10000130 10000131 10000130 10000130 10000130 10000130 10000131 10000131 10000130 10000130 10000130 10000130 10000130 10000130 10000130 10000131 10000130 10000130 10000130 10000130 10000131 10000130 min_time_thread_terminate_total=10000130 max_time_thread_terminate_total=10000131 first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 2 3 3 3 3 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=9999526050 threads_final_size=99937 final_keysum=9999526050 final_size=99937 validate_result=success Validation OK. Structural validation OK. total_find=0 total_rq=0 total_inserts=263449299 total_deletes=263437564 total_updates=526886863 total_queries=0 total_ops=526886863 find_throughput=0 rq_throughput=0 update_throughput=52688686 query_throughput=0 total_throughput=52688686 total find : 0 total rq : 0 total inserts : 263449299 total deletes : 263437564 total updates : 526886863 total queries : 0 total ops : 526886863 find throughput : 0 rq throughput : 0 update throughput : 52688686 query throughput : 0 total throughput : 52688686 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=8.90819 PAPI_L3_TCM=0.000433681 PAPI_TOT_CYC=2398.33 PAPI_TOT_INS=1694.6 garbage=0 total_execution_walltime=11.437s REALTIME_MAIN_END_PERF_FORMAT=6990635.476107572 [time_cmd_output] time_elapsed_sec=11.55, faults_major=0, faults_minor=78738, mem_maxresident_kb=314364, user_cputime=561.60, sys_cputime=3.19, percent_cpu=4886% 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