__step=000633 __cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 180 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_avl_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=data000633.txt __path_data=data/data000633.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x56125a594400 addrof(kcasDescriptors[1])=0x56125a594d00 addrof(rdcssDescriptors[0])=0x56125a6b4400 addrof(rdcssDescriptors[1])=0x56125a6b44c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=7002419.948132492 binary=./sigouin_int_avl_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_avl_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.006s prefilling_size=100164 prefilling_elapsed_millis=1.001s finished prefilling to size 100191 for expected size 100000 keysum=10014319278, performing 35320416 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=100191 pref_millis=1102 prefill_elapsed_ms=1123 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=7002421.218258252 REALTIME_END_PERF_FORMAT=7002431.218395964 ############################################################################### ################################## 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 1024 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.037s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8181 15239 17943 7343 532 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 11 1033 10294 21005 9442 644 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16272 28237 28348 9974 644 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16272 28237 28348 9974 644 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 1.98767 1.7988 1.36849 1.09281 1.01123 1 tree_stats_height=19 tree_stats_numInternals=57429 tree_stats_numLeaves=42429 tree_stats_numNodes=99858 tree_stats_numKeys=99858 tree_stats_avgDegreeInternal=1.73881 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.42489 tree_stats_avgKeyDepth=14.848 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:87 2:1715 4:59179 8:380393 16:38522 32:1 [2^00, 2^01]: 87 (2^01, 2^02]: 1715 (2^02, 2^03]: 59179 (2^03, 2^04]: 380393 (2^04, 2^05]: 38522 (2^05, 2^06]: 1 sum_limbo_reclamation_event_size_total=5284316 count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9996 9998 9997 9998 9998 9996 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 count_limbo_reclamation_event_size_total=479897 sum_limbo_reclamation_event_count_total=1722096 first_thread_announced_epoch_by_thread=75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 75174 sum_num_inserts_by_thread=784163 787280 796433 797659 792065 782478 784626 783104 800848 801225 795039 787383 787456 788868 796269 795329 797351 787132 784510 789400 796911 801835 792576 781658 782341 784443 798248 794300 791121 781970 785184 789627 803404 799156 793371 789025 787068 792205 799511 800658 794726 790456 786613 788423 799183 803031 788868 786937 sum_num_inserts_total=38001467 sum_num_deletes_by_thread=782100 785850 798553 798165 792484 781083 783607 782891 801202 800874 794312 786818 788903 788149 793065 794342 798294 786713 784521 791460 796406 801529 793166 783440 782919 783684 799304 795830 791080 783013 785062 787270 804024 799830 793643 788070 787518 792353 797776 799484 793680 789580 784680 787433 799159 803796 790475 786798 sum_num_deletes_total=37994388 sum_num_searches_by_thread=14098104 14168296 14368036 14362892 14273058 14084817 14117198 14088469 14420076 14424780 14288454 14176719 14188599 14193920 14304520 14324973 14357919 14162540 14133527 14249918 14346975 14438324 14277457 14099064 14077660 14121842 14364272 14306382 14247629 14087889 14126608 14184180 14449468 14397097 14293364 14183933 14168068 14274734 14351254 14397611 14316324 14206782 14144290 14183105 14379573 14454575 14221051 14174854 sum_num_searches_total=684061180 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=15664367 15741426 15963022 15958716 15857607 15648378 15685431 15654464 16022126 16026879 15877805 15750920 15764958 15770937 15893854 15914644 15953564 15736385 15702558 15830778 15940292 16041688 15863199 15664162 15642920 15689969 15961824 15896512 15829830 15652872 15696854 15761077 16056896 15996083 15880378 15761028 15742654 15859292 15948541 15997753 15904730 15786818 15715583 15758961 15977915 16061402 15800394 15748589 average_num_operations_total=15834521 stdev_num_operations_total=18534 sum_num_operations_total=760057035 min_num_operations_total=15642920 max_num_operations_total=16061402 first_time_thread_terminate_by_thread=10000137 10000138 10000137 10000138 10000137 10000137 10000137 10000137 10000137 10000138 10000137 10000137 10000137 10000137 10000137 10000138 10000137 10000137 10000138 10000137 10000137 10000137 10000137 10000137 10000137 10000138 10000137 10000138 10000137 10000137 10000137 10000137 10000137 10000138 10000137 10000137 10000137 10000137 10000137 10000138 10000137 10000137 10000139 10000138 10000139 10000137 10000137 10000137 min_time_thread_terminate_total=10000137 max_time_thread_terminate_total=10000139 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=9997713197 threads_final_size=99858 final_keysum=9997713197 final_size=99858 validate_result=success Validation OK. Structural validation OK. total_find=684061180 total_rq=0 total_inserts=38001467 total_deletes=37994388 total_updates=75995855 total_queries=684061180 total_ops=760057035 find_throughput=68406118 rq_throughput=0 update_throughput=7599585 query_throughput=68406118 total_throughput=76005703 total find : 684061180 total rq : 0 total inserts : 38001467 total deletes : 37994388 total updates : 75995855 total queries : 684061180 total ops : 760057035 find throughput : 68406118 rq throughput : 0 update throughput : 7599585 query throughput : 68406118 total throughput : 76005703 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=6.45727 PAPI_L3_TCM=0.00018704 PAPI_TOT_CYC=1721.36 PAPI_TOT_INS=1093.31 garbage=34200546879067 total_execution_walltime=11.399s REALTIME_MAIN_END_PERF_FORMAT=7002431.347889955 [time_cmd_output] time_elapsed_sec=11.53, faults_major=0, faults_minor=76916, mem_maxresident_kb=309544, user_cputime=559.66, sys_cputime=2.24, percent_cpu=4871% timeout=false algorithm=sigouin_int_avl_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