__step=000443 __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_avl_kcas_validate.debra -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000443.txt __path_data=data/data000443.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x55c29f31e400 addrof(kcasDescriptors[1])=0x55c29f31ed00 addrof(rdcssDescriptors[0])=0x55c29f43e400 addrof(rdcssDescriptors[1])=0x55c29f43e4c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6984249.294994029 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=20000000 PREFILL_THREADS=96 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=96 WORK_THREADS=96 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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143 Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.041s prefilling_size=8306889 prefilling_elapsed_millis=1s prefilling_size=8563373 prefilling_elapsed_millis=1.1s prefilling_size=8779522 prefilling_elapsed_millis=1.201s prefilling_size=8963382 prefilling_elapsed_millis=1.301s prefilling_size=9117590 prefilling_elapsed_millis=1.401s prefilling_size=9250967 prefilling_elapsed_millis=1.501s prefilling_size=9360671 prefilling_elapsed_millis=1.601s prefilling_size=9455251 prefilling_elapsed_millis=1.701s prefilling_size=9534693 prefilling_elapsed_millis=1.802s prefilling_size=9602555 prefilling_elapsed_millis=1.902s prefilling_size=9660365 prefilling_elapsed_millis=2.002s prefilling_size=9707691 prefilling_elapsed_millis=2.102s prefilling_size=9750151 prefilling_elapsed_millis=2.202s prefilling_size=9786858 prefilling_elapsed_millis=2.302s prefilling_size=9820016 prefilling_elapsed_millis=2.403s finished prefilling to size 9820126 for expected size 10000000 keysum=98197133106590, performing 80164395 updates; total_prefilling_elapsed_ms=2504 ms) pref_size=9820126 pref_millis=2504 prefill_elapsed_ms=2528 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6984252.56155483 REALTIME_END_PERF_FORMAT=6984262.56239997 ############################################################################### ################################## TIME IS UP ################################# ############################################################################### joining threads... ############################################################################### ################################# END RUNNING ################################# ############################################################################### 10.1s 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.039s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131071 262059 519858 967543 1448562 1401456 711058 150851 9120 29 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 80 3880 62228 399033 1161717 1537029 884181 192515 11469 34 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262139 523738 1029771 1847595 2563173 2248087 1035032 201635 11498 34 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262139 523738 1029771 1847595 2563173 2248087 1035032 201635 11498 34 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99997 1.99825 1.9736 1.85461 1.60328 1.33031 1.14411 1.04907 1.01179 1.00043 1 tree_stats_height=28 tree_stats_numInternals=5732678 tree_stats_numLeaves=4252167 tree_stats_numNodes=9984845 tree_stats_numKeys=9984845 tree_stats_avgDegreeInternal=1.74174 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.42586 tree_stats_avgKeyDepth=21.6865 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:2 4:32 8:27345 16:530037 32:21368 (2^01, 2^02]: 2 (2^02, 2^03]: 32 (2^03, 2^04]: 27345 (2^04, 2^05]: 530037 (2^05, 2^06]: 21368 sum_limbo_reclamation_event_size_total=13283211 count_limbo_reclamation_event_size_by_thread=6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 count_limbo_reclamation_event_size_total=578784 sum_limbo_reclamation_event_count_total=578976 first_thread_announced_epoch_by_thread=13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 sum_num_inserts_by_thread=276500 277661 280925 279587 277979 274948 277269 277308 281104 281394 277984 275526 277057 278572 279560 280517 279523 277278 276334 278187 278905 279685 275742 276194 277646 277981 279784 280597 278641 276407 277878 278402 280958 280960 277236 276078 276093 277925 281450 280744 277710 276747 275335 276326 277473 279378 277256 274688 278088 278883 280192 280185 278401 277707 277317 277969 281531 281182 279822 278196 277884 279892 282529 282410 279166 276042 275468 277426 280056 279562 278792 276036 277886 277650 281102 279413 277521 276064 277950 278748 281423 281558 279514 277302 278646 279241 281376 280993 279182 276890 275990 277473 280408 280251 279372 276351 sum_num_inserts_total=26736472 sum_num_deletes_by_thread=277723 277896 280320 280412 279314 276452 276151 277541 281339 280475 277874 275119 277855 277910 280266 280840 278712 277573 275949 277328 278886 279641 277313 275756 276843 278338 279168 279768 278537 276198 277336 277190 280125 280819 278480 274760 276616 278056 279636 280047 278557 277184 276093 276991 278477 279695 278069 274606 277645 278635 281170 280093 278271 277012 278221 278599 280793 281982 278937 276859 278926 279213 282091 281603 280767 275780 275853 276398 280342 280284 278398 276665 276967 278498 281112 280428 277392 276344 277611 278373 281483 281609 279114 277383 278305 279595 281670 280279 279852 276267 276004 277374 281322 279665 279621 277356 sum_num_deletes_total=26738395 sum_num_searches_by_thread=4986185 5003905 5040221 5037054 5008516 4962467 4984675 5006898 5059107 5058824 5010324 4964310 4987924 5018086 5041255 5050672 5024525 4986179 4970067 4998273 5027004 5041867 4990474 4949958 4987648 5009040 5044317 5040940 5016239 4969952 4991044 5006834 5054617 5058607 5005629 4962859 4995182 5006828 5053327 5042006 5019252 4981878 4960030 4978428 5017105 5035841 4990085 4946740 4995020 5011104 5051423 5041388 5009418 4983748 5001284 5017676 5062136 5070773 5025985 4998450 5017643 5037621 5073511 5068801 5032689 4973774 4962023 4985265 5039143 5047279 5016338 4968680 4991730 5003206 5049293 5039802 5004107 4979908 4992847 5011479 5070270 5069896 5026112 4993956 5011974 5030995 5068889 5056403 5031430 4970885 4969633 4991076 5059732 5055530 5025578 4986855 sum_num_searches_total=481365956 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=5540408 5559462 5601466 5597053 5565809 5513867 5538095 5561747 5621550 5620693 5566182 5514955 5542836 5574568 5601081 5612029 5582760 5541030 5522350 5553788 5584795 5601193 5543529 5501908 5542137 5565359 5603269 5601305 5573417 5522557 5546258 5562426 5615700 5620386 5561345 5513697 5547891 5562809 5614413 5602797 5575519 5535809 5511458 5531745 5573055 5594914 5545410 5496034 5550753 5568622 5612785 5601666 5566090 5538467 5556822 5574244 5624460 5633937 5584744 5553505 5574453 5596726 5638131 5632814 5592622 5525596 5513344 5539089 5599541 5607125 5573528 5521381 5546583 5559354 5611507 5599643 5559020 5532316 5548408 5568600 5633176 5633063 5584740 5548641 5568925 5589831 5631935 5617675 5590464 5524042 5521627 5545923 5621462 5615446 5584571 5540562 average_num_operations_total=5571258 stdev_num_operations_total=3689 sum_num_operations_total=534840823 min_num_operations_total=5496034 max_num_operations_total=5638131 first_time_thread_terminate_by_thread=10000086 10000084 10000085 10000084 10000084 10000085 10000084 10000085 10000084 10000085 10000086 10000085 10000084 10000084 10000084 10000085 10000084 10000087 10000085 10000085 10000084 10000085 10000085 10000084 10000086 10000084 10000085 10000084 10000085 10000085 10000084 10000085 10000084 10000085 10000084 10000085 10000084 10000084 10000084 10000085 10000084 10000087 10000085 10000085 10000086 10000085 10000085 10000084 10000083 10000086 10000084 10000084 10000085 10000085 10000084 10000083 10000088 10000086 10000083 10000083 10000086 10000086 10000084 10000083 10000084 10000086 10000083 10000083 10000086 10000084 10000085 10000084 10000083 10000086 10000084 10000084 10000085 10000085 10000084 10000086 10000083 10000102 10000083 10000086 10000086 10000139 10000084 10000084 10000084 10000086 10000085 10000084 10000086 10000084 10000083 10000084 min_time_thread_terminate_total=10000083 max_time_thread_terminate_total=10000139 first_time_thread_start_by_thread=6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 5 6 6 5 6 6 5 6 5 6 6 6 5 6 5 6 5 6 5 5 5 6 5 6 5 6 6 5 6 6 5 6 5 6 6 6 10 6 5 6 5 6 5 5 5 6 5 min_time_thread_start_total=5 max_time_thread_start_total=10 sum_duration_all_ops_total= threads_final_keysum=99848635358304 threads_final_size=9984845 final_keysum=99848635358304 final_size=9984845 validate_result=success Validation OK. Structural validation OK. total_find=481365956 total_rq=0 total_inserts=26736472 total_deletes=26738395 total_updates=53474867 total_queries=481365956 total_ops=534840823 find_throughput=48136595 rq_throughput=0 update_throughput=5347486 query_throughput=48136595 total_throughput=53484082 total find : 481365956 total rq : 0 total inserts : 26736472 total deletes : 26738395 total updates : 53474867 total queries : 481365956 total ops : 534840823 find throughput : 48136595 rq throughput : 0 update throughput : 5347486 query throughput : 48136595 total throughput : 53484082 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=27.7395 PAPI_L3_TCM=10.1662 PAPI_TOT_CYC=4999.76 PAPI_TOT_INS=1380.79 garbage=2366322491277193 total_execution_walltime=12.981s REALTIME_MAIN_END_PERF_FORMAT=6984262.276978739 [time_cmd_output] time_elapsed_sec=13.15, faults_major=0, faults_minor=238113, mem_maxresident_kb=950076, user_cputime=1230.68, sys_cputime=3.98, percent_cpu=9387% 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