__step=000634 __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 5.0 5.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000634.txt __path_data=data/data000634.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x560c561a1400 addrof(kcasDescriptors[1])=0x560c561a1d00 addrof(rdcssDescriptors[0])=0x560c562c1400 addrof(rdcssDescriptors[1])=0x560c562c14c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6986492.764492152 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=5 DEL_FRAC=5 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=5.0 5.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.005s prefilling_size=99557 prefilling_elapsed_millis=1.001s finished prefilling to size 99578 for expected size 100000 keysum=9964717292, performing 56075910 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=99578 pref_millis=1102 prefill_elapsed_ms=1126 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6986494.62605475 REALTIME_END_PERF_FORMAT=6986504.62756038 ############################################################################### ################################## 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 837 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.038s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 125 239 446 780 1286 1986 2956 4058 5219 6307 7054 7434 7000 6027 4885 3688 2475 1627 999 534 243 93 28 7 3 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 7 26 57 152 330 550 999 1587 2205 2956 3541 4171 4159 3760 3142 2545 1729 1154 762 417 196 82 27 6 3 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 126 246 472 837 1438 2316 3506 5057 6806 8512 10010 10975 11171 10186 8645 6830 5020 3356 2153 1296 660 289 110 34 9 3 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 126 246 472 837 1438 2316 3506 5057 6806 8512 10010 10975 11171 10186 8645 6830 5020 3356 2153 1296 660 289 110 34 9 3 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.96875 1.96032 1.94715 1.82839 1.78614 1.71627 1.6563 1.59926 1.54341 1.48384 1.43503 1.39171 1.3405 1.2852 1.25702 1.22499 1.19502 1.1755 1.15673 1.13795 1.09722 1.0697 1.05882 1.05455 1.05882 1 1 tree_stats_height=33 tree_stats_numInternals=65626 tree_stats_numLeaves=34564 tree_stats_numNodes=100190 tree_stats_numKeys=100190 tree_stats_avgDegreeInternal=1.52668 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.34498 tree_stats_avgKeyDepth=18.404 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:74 2:1502 4:50643 8:374824 16:52851 32:3 [2^00, 2^01]: 74 (2^01, 2^02]: 1502 (2^02, 2^03]: 50643 (2^03, 2^04]: 374824 (2^04, 2^05]: 52851 (2^05, 2^06]: 3 sum_limbo_reclamation_event_size_total=5489119 count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9997 9998 9998 9997 9996 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 count_limbo_reclamation_event_size_total=479897 sum_limbo_reclamation_event_count_total=1759344 first_thread_announced_epoch_by_thread=78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 78564 sum_num_inserts_by_thread=827429 831742 835513 843108 839744 827594 827049 835279 847993 848194 836636 832059 831069 834909 843645 845415 845348 838531 834271 836222 846790 850438 837601 828108 828616 838758 842378 845010 837170 829699 828446 836913 847317 848787 841268 838262 837818 840909 845050 846829 841098 836301 830248 835255 848618 853809 845149 831834 sum_num_inserts_total=40260229 sum_num_deletes_by_thread=828276 831400 837384 843879 837637 826835 826695 834212 847695 848846 837111 828956 830137 835388 841242 845233 842993 837740 832646 837551 846353 849413 838555 827210 827198 837682 840914 845090 836584 830540 827581 836751 846495 850616 841138 837775 836152 840812 845137 847760 841118 837432 829973 835045 845695 852659 846674 832940 sum_num_deletes_total=40243148 sum_num_searches_by_thread=14905114 14970555 15066509 15188070 15121594 14900696 14914309 15019030 15271712 15279700 15056713 14962446 14948072 15025150 15163237 15225877 15184287 15095364 15001572 15074335 15234040 15304375 15092270 14902111 14897959 15070419 15150349 15202987 15066790 14955928 14886366 15071902 15230722 15304629 15136468 15076696 15075270 15140891 15221553 15258076 15145457 15054070 14966755 15032237 15241801 15351924 15194071 14969162 sum_num_searches_total=724609620 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=16560819 16633697 16739406 16875057 16798975 16555125 16568053 16688521 16967400 16976740 16730460 16623461 16609278 16695447 16848124 16916525 16872628 16771635 16668489 16748108 16927183 17004226 16768426 16557429 16553773 16746859 16833641 16893087 16740544 16616167 16542393 16745566 16924534 17004032 16818874 16752733 16749240 16822612 16911740 16952665 16827673 16727803 16626976 16702537 16936114 17058392 16885894 16633936 average_num_operations_total=16773187 stdev_num_operations_total=20543 sum_num_operations_total=805112997 min_num_operations_total=16542393 max_num_operations_total=17058392 first_time_thread_terminate_by_thread=10000149 10000149 10000150 10000150 10000149 10000149 10000149 10000149 10000149 10000149 10000148 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000150 10000149 10000149 10000149 10000150 10000150 10000149 10000149 10000149 10000149 10000149 10000149 10000148 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000150 10000149 10000150 10000149 min_time_thread_terminate_total=10000148 max_time_thread_terminate_total=10000150 first_time_thread_start_by_thread=6 7 6 7 6 6 7 6 6 6 7 6 7 7 7 7 6 7 6 7 7 6 6 7 6 7 6 7 6 6 7 6 6 6 7 6 7 7 7 7 6 7 6 7 7 6 6 7 min_time_thread_start_total=6 max_time_thread_start_total=7 sum_duration_all_ops_total= threads_final_keysum=10012286774 threads_final_size=100190 final_keysum=10012286774 final_size=100190 validate_result=success Validation OK. Structural validation OK. total_find=724609620 total_rq=0 total_inserts=40260229 total_deletes=40243148 total_updates=80503377 total_queries=724609620 total_ops=805112997 find_throughput=72460962 rq_throughput=0 update_throughput=8050337 query_throughput=72460962 total_throughput=80511299 total find : 724609620 total rq : 0 total inserts : 40260229 total deletes : 40243148 total updates : 80503377 total queries : 724609620 total ops : 805112997 find throughput : 72460962 rq throughput : 0 update throughput : 8050337 query throughput : 72460962 total throughput : 80511299 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=6.46359 PAPI_L3_TCM=0.000192346 PAPI_TOT_CYC=1626.79 PAPI_TOT_INS=1108.21 garbage=36243419188824 total_execution_walltime=11.448s REALTIME_MAIN_END_PERF_FORMAT=6986504.213135403 [time_cmd_output] time_elapsed_sec=11.57, faults_major=0, faults_minor=77241, mem_maxresident_kb=310716, user_cputime=561.08, sys_cputime=1.53, percent_cpu=4862% 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