__step=000108 __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 0.5 0.5 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000108.txt __path_data=data/data000108.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x55abf9bd7400 addrof(kcasDescriptors[1])=0x55abf9bd7d00 addrof(rdcssDescriptors[0])=0x55abf9cf7400 addrof(rdcssDescriptors[1])=0x55abf9cf74c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6980135.478094230 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=0.5 DEL_FRAC=0.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=0.5 0.5 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.011s prefilling_size=8302340 prefilling_elapsed_millis=1.001s prefilling_size=8556701 prefilling_elapsed_millis=1.101s prefilling_size=8770818 prefilling_elapsed_millis=1.201s prefilling_size=8949968 prefilling_elapsed_millis=1.302s prefilling_size=9103503 prefilling_elapsed_millis=1.402s prefilling_size=9232898 prefilling_elapsed_millis=1.502s prefilling_size=9340850 prefilling_elapsed_millis=1.602s prefilling_size=9434548 prefilling_elapsed_millis=1.702s prefilling_size=9516440 prefilling_elapsed_millis=1.803s prefilling_size=9585958 prefilling_elapsed_millis=1.903s prefilling_size=9645359 prefilling_elapsed_millis=2.003s prefilling_size=9696613 prefilling_elapsed_millis=2.103s prefilling_size=9739413 prefilling_elapsed_millis=2.203s prefilling_size=9774158 prefilling_elapsed_millis=2.304s prefilling_size=9806590 prefilling_elapsed_millis=2.404s finished prefilling to size 9806591 for expected size 10000000 keysum=98066685654228, performing 80557775 updates; total_prefilling_elapsed_ms=2505 ms) pref_size=9806591 pref_millis=2505 prefill_elapsed_ms=2529 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6980138.200968785 REALTIME_END_PERF_FORMAT=6980148.201137962 ############################################################################### ################################## 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.059s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262097 520602 972601 1457087 1393057 662853 120823 5375 10 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 45 3300 59497 400614 1182730 1557506 831470 154224 6693 12 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262142 523902 1032098 1857701 2575787 2220359 952293 159599 6703 12 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262142 523902 1032098 1857701 2575787 2220359 952293 159599 6703 12 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99998 1.99871 1.97632 1.85757 1.6022 1.32118 1.13036 1.04072 1.00832 1.0003 1 tree_stats_height=28 tree_stats_numInternals=5656648 tree_stats_numLeaves=4196091 tree_stats_numNodes=9852739 tree_stats_numKeys=9852739 tree_stats_avgDegreeInternal=1.7418 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.42588 tree_stats_avgKeyDepth=21.6464 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:143978 2:292951 4:121428 8:1620 16:42 [2^00, 2^01]: 143978 (2^01, 2^02]: 292951 (2^02, 2^03]: 121428 (2^03, 2^04]: 1620 (2^04, 2^05]: 42 sum_limbo_reclamation_event_size_total=1427498 count_limbo_reclamation_event_size_by_thread=5832 5879 5838 5866 5846 5799 5793 5822 5838 5818 5805 5793 5900 5852 5822 5797 5852 5836 5826 5877 5894 5841 5814 5835 5828 5819 5848 5864 5823 5799 5785 5812 5843 5831 5791 5825 5832 5811 5842 5825 5840 5851 5841 5840 5785 5854 5862 5883 5837 5798 5857 5835 5762 5822 5814 5824 5875 5890 5884 5833 5829 5820 5872 5884 5811 5797 5784 5825 5867 5770 5800 5844 5795 5883 5861 5827 5809 5845 5828 5796 5821 5816 5832 5796 5822 5862 5843 5871 5855 5830 5848 5869 5862 5828 5839 5838 count_limbo_reclamation_event_size_total=560019 sum_limbo_reclamation_event_count_total=622464 first_thread_announced_epoch_by_thread=14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 sum_num_inserts_by_thread=29788 29952 30282 30461 30339 29932 30142 30462 30535 30411 30116 29942 29959 30640 30602 30607 30386 29826 29722 30393 30364 30387 30050 29947 29867 30024 30237 30568 29862 29749 30149 30392 30561 30712 30191 30116 30480 30395 30631 30497 30181 29825 30092 30400 30623 30360 29780 29482 30281 30152 30615 30100 30247 29887 30184 30137 30876 30494 30336 29985 30148 30414 30395 30638 30004 30101 30016 30248 30600 30492 30033 29835 29918 30303 30106 30194 30484 30053 30283 30192 30534 30621 30041 30245 30479 30548 30038 30493 30096 30100 29846 30171 30421 30064 30299 30269 sum_num_inserts_total=2902435 sum_num_deletes_by_thread=30038 30172 30398 30480 30041 29907 30141 30478 30148 30671 30031 29998 30312 30634 30255 30441 30356 30079 30030 30074 30260 30624 30100 29997 30129 30177 30358 30771 30294 29769 30239 29953 30032 30520 30020 29993 30259 30448 30681 30622 30507 30096 29865 30115 30386 30385 29787 30101 30063 30227 30777 30754 30155 30005 30340 30299 30629 30774 30340 30146 30400 30602 30460 30869 29924 29985 30151 29849 30063 30283 29855 30226 29913 29951 30392 30408 30398 30026 29954 30474 30477 30453 30173 30166 30244 30475 30478 30713 30303 30162 29928 30007 30269 30312 30245 30038 sum_num_deletes_total=2904307 sum_num_searches_by_thread=5936450 5978415 6023000 6018307 5980015 5957493 5982297 5999269 6031601 6066676 5960756 5958828 5968881 6025694 6039189 6054537 5983332 5936035 5900499 5956201 5992601 6011409 5946663 5930693 5942147 5968950 6019037 6040340 5980118 5941690 5977965 5987075 6025449 6042793 5991648 5953030 5982718 6025522 6057724 6015621 6011170 5972655 5932734 5941499 6010165 5995381 5934887 5902439 5974456 5981557 6057300 6014829 6000191 5951713 5984897 5985203 6046355 6055340 5994887 5972752 5977925 6005752 6030858 6053863 5977867 5922710 5939580 5933888 6007884 6036242 5953662 5944454 5965011 5970498 6024695 6035220 6007633 5926072 5950713 5999459 6064662 6069790 5986951 5978275 6008414 6002590 6029844 6038144 6019018 5924390 5929748 5940716 6016861 6020930 5969393 5967361 sum_num_searches_total=574942151 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=5996276 6038539 6083680 6079248 6040395 6017332 6042580 6060209 6092284 6127758 6020903 6018768 6029152 6086968 6100046 6115585 6044074 5995940 5960251 6016668 6053225 6072420 6006813 5990637 6002143 6029151 6079632 6101679 6040274 6001208 6038353 6047420 6086042 6104025 6051859 6013139 6043457 6086365 6119036 6076740 6071858 6032576 5992691 6002014 6071174 6056126 5994454 5962022 6034800 6041936 6118692 6075683 6060593 6011605 6045421 6045639 6107860 6116608 6055563 6032883 6038473 6066768 6091713 6115370 6037795 5982796 5999747 5993985 6068547 6097017 6013550 6004515 6024842 6030752 6085193 6095822 6068515 5986151 6010950 6060125 6125673 6130864 6047165 6038686 6069137 6063613 6090360 6099350 6079417 5984652 5989522 6000894 6077551 6081306 6029937 6027668 average_num_operations_total=6049467 stdev_num_operations_total=4223 sum_num_operations_total=580748893 min_num_operations_total=5960251 max_num_operations_total=6130864 first_time_thread_terminate_by_thread=10000169 10000170 10000170 10000169 10000169 10000170 10000169 10000169 10000169 10000169 10000169 10000170 10000170 10000169 10000169 10000169 10000169 10000169 10000169 10000168 10000169 10000170 10000170 10000170 10000169 10000170 10000170 10000169 10000169 10000170 10000169 10000169 10000169 10000169 10000169 10000170 10000170 10000169 10000169 10000169 10000169 10000169 10000169 10000168 10000169 10000169 10000170 10000170 10000169 10000168 10000168 10000169 10000169 10000171 10000169 10000169 10000169 10000169 10000169 10000169 10000170 10000169 10000170 10000169 10000168 10000168 10000169 10000168 10000169 10000170 10000168 10000169 10000169 10000168 10000168 10000169 10000169 10000170 10000169 10000169 10000169 10000169 10000169 10000169 10000170 10000169 10000170 10000169 10000168 10000168 10000169 10000168 10000169 10000170 10000168 10000169 min_time_thread_terminate_total=10000168 max_time_thread_terminate_total=10000171 first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 4 3 3 4 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 4 3 3 4 min_time_thread_start_total=3 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=98513644571415 threads_final_size=9852739 final_keysum=98513644571415 final_size=9852739 validate_result=success Validation OK. Structural validation OK. total_find=574942151 total_rq=0 total_inserts=2902435 total_deletes=2904307 total_updates=5806742 total_queries=574942151 total_ops=580748893 find_throughput=57494215 rq_throughput=0 update_throughput=580674 query_throughput=57494215 total_throughput=58074889 total find : 574942151 total rq : 0 total inserts : 2902435 total deletes : 2904307 total updates : 5806742 total queries : 574942151 total ops : 580748893 find throughput : 57494215 rq throughput : 0 update throughput : 580674 query throughput : 57494215 total throughput : 58074889 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=27.4982 PAPI_L3_TCM=10.2893 PAPI_TOT_CYC=4601.29 PAPI_TOT_INS=1208.52 garbage=2828134341712826 total_execution_walltime=12.877s REALTIME_MAIN_END_PERF_FORMAT=6980148.355811080 [time_cmd_output] time_elapsed_sec=13.05, faults_major=0, faults_minor=236029, mem_maxresident_kb=941772, user_cputime=1229.24, sys_cputime=3.58, percent_cpu=9442% 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=2