__step=000642 __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_htm.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=data000642.txt __path_data=data/data000642.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x561d3ec85400 addrof(kcasDescriptors[1])=0x561d3ec85d00 addrof(rdcssDescriptors[0])=0x561d3eda5400 addrof(rdcssDescriptors[1])=0x561d3eda54c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=7002525.273357092 binary=./sigouin_int_avl_kcas_validate_htm.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_htm 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=100074 prefilling_elapsed_millis=1.001s finished prefilling to size 100060 for expected size 100000 keysum=10019525832, performing 45811158 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=100060 pref_millis=1102 prefill_elapsed_ms=1123 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=7002526.577699720 REALTIME_END_PERF_FORMAT=7002536.577836594 ############################################################################### ################################## 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.043s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8151 15147 17901 7517 667 10 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 39 1020 10215 20884 9600 846 12 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8190 16167 28116 28401 10267 856 12 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8190 16167 28116 28401 10267 856 12 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99951 1.97875 1.80219 1.37345 1.09683 1.01841 1.00234 1 tree_stats_height=20 tree_stats_numInternals=57584 tree_stats_numLeaves=42616 tree_stats_numNodes=100200 tree_stats_numKeys=100200 tree_stats_avgDegreeInternal=1.74007 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.42531 tree_stats_avgKeyDepth=14.8628 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:47 2:1485 4:53164 8:375788 16:49397 32:13 [2^00, 2^01]: 47 (2^01, 2^02]: 1485 (2^02, 2^03]: 53164 (2^03, 2^04]: 375788 (2^04, 2^05]: 49397 (2^05, 2^06]: 13 sum_limbo_reclamation_event_size_total=5434014 count_limbo_reclamation_event_size_by_thread=9997 9998 9998 9998 9997 9998 9997 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9996 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9997 9998 9998 9998 9998 9998 9997 9998 count_limbo_reclamation_event_size_total=479894 sum_limbo_reclamation_event_count_total=1806720 first_thread_announced_epoch_by_thread=79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 79630 sum_num_inserts_by_thread=836889 852322 861983 856651 845629 850609 849380 858112 866730 862434 860948 854233 844624 843591 854556 857244 850736 846471 843380 848713 853750 866521 850881 835639 836853 843393 854220 857093 859216 851932 843867 851115 871500 863282 851734 846871 846411 851163 855084 857717 851355 844344 849615 852477 861894 860251 860300 847009 sum_num_inserts_total=40920722 sum_num_deletes_by_thread=837179 852450 863507 855902 846825 849062 850049 856727 867675 860488 859736 854471 843411 842748 851851 858500 851524 845369 843699 849869 853064 866173 852294 835327 836421 842695 855738 856524 859495 853552 843955 852260 872097 863004 853154 849106 844791 849728 855852 857019 850325 845532 848331 854664 862387 861203 858702 845798 sum_num_deletes_total=40920233 sum_num_searches_by_thread=15048785 15359061 15504890 15407012 15244196 15303889 15309038 15427999 15628550 15505195 15495694 15360876 15169843 15195674 15332003 15434163 15356585 15224172 15172100 15276352 15381545 15586308 15315605 15063420 15069934 15179588 15416001 15437146 15455003 15343134 15170199 15321661 15675133 15543444 15340229 15251982 15211522 15294479 15373707 15438239 15323219 15206219 15284962 15362346 15520707 15504930 15478545 15222286 sum_num_searches_total=736527570 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=16722853 17063833 17230380 17119565 16936650 17003560 17008467 17142838 17362955 17228117 17216378 17069580 16857878 16882013 17038410 17149907 17058845 16916012 16859179 16974934 17088359 17319002 17018780 16734386 16743208 16865676 17125959 17150763 17173714 17048618 16858021 17025036 17418730 17269730 17045117 16947959 16902724 16995370 17084643 17152975 17024899 16896095 16982908 17069487 17244988 17226384 17197547 16915093 average_num_operations_total=17049344 stdev_num_operations_total=23342 sum_num_operations_total=818368525 min_num_operations_total=16722853 max_num_operations_total=17418730 first_time_thread_terminate_by_thread=10000136 10000136 10000136 10000136 10000135 10000135 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000135 10000136 10000136 10000136 10000136 10000135 10000135 10000136 10000136 10000136 10000136 10000135 10000135 10000136 10000136 10000136 10000136 10000136 10000136 10000135 10000136 10000136 10000136 10000136 10000135 10000136 10000136 10000136 10000136 10000135 10000135 min_time_thread_terminate_total=10000135 max_time_thread_terminate_total=10000136 first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 2 3 3 2 3 3 3 2 2 2 3 2 3 3 3 2 3 3 3 3 3 3 3 3 2 3 3 2 3 3 3 2 2 2 3 2 3 3 3 2 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=10023385273 threads_final_size=100200 final_keysum=10023385273 final_size=100200 validate_result=success Validation OK. Structural validation OK. total_find=736527570 total_rq=0 total_inserts=40920722 total_deletes=40920233 total_updates=81840955 total_queries=736527570 total_ops=818368525 find_throughput=73652757 rq_throughput=0 update_throughput=8184095 query_throughput=73652757 total_throughput=81836852 total find : 736527570 total rq : 0 total inserts : 40920722 total deletes : 40920233 total updates : 81840955 total queries : 736527570 total ops : 818368525 find throughput : 73652757 rq throughput : 0 update throughput : 8184095 query throughput : 73652757 total throughput : 81836852 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=6.31095 PAPI_L3_TCM=0.000176887 PAPI_TOT_CYC=1599.98 PAPI_TOT_INS=1008.74 garbage=36823881361717 total_execution_walltime=11.435s REALTIME_MAIN_END_PERF_FORMAT=7002536.709713403 [time_cmd_output] time_elapsed_sec=11.56, faults_major=0, faults_minor=76998, mem_maxresident_kb=309604, user_cputime=561.73, sys_cputime=2.42, percent_cpu=4879% timeout=false algorithm=sigouin_int_avl_kcas_validate_htm.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=2