__step=000180 __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_bst_kcas_validate_htm.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=data000180.txt __path_data=data/data000180.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x55e4c74af400 addrof(kcasDescriptors[1])=0x55e4c74afd00 addrof(rdcssDescriptors[0])=0x55e4c75cf400 addrof(rdcssDescriptors[1])=0x55e4c75cf4c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6996572.151704897 binary=./sigouin_int_bst_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_bst_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=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.009s prefilling_size=8927268 prefilling_elapsed_millis=1.001s prefilling_size=9114955 prefilling_elapsed_millis=1.101s prefilling_size=9269807 prefilling_elapsed_millis=1.201s prefilling_size=9395604 prefilling_elapsed_millis=1.302s prefilling_size=9497496 prefilling_elapsed_millis=1.402s prefilling_size=9586158 prefilling_elapsed_millis=1.502s prefilling_size=9656278 prefilling_elapsed_millis=1.602s prefilling_size=9715716 prefilling_elapsed_millis=1.702s prefilling_size=9764286 prefilling_elapsed_millis=1.803s prefilling_size=9803893 prefilling_elapsed_millis=1.903s finished prefilling to size 9803892 for expected size 10000000 keysum=98037574774875, performing 78825179 updates; total_prefilling_elapsed_ms=2004 ms) pref_size=9803892 pref_millis=2004 prefill_elapsed_ms=2027 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6996574.352541162 REALTIME_END_PERF_FORMAT=6996584.352673530 ############################################################################### ################################## 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 972 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.074s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 127 250 493 954 1787 3288 5866 10173 17221 28551 46092 72138 108299 155548 212725 277584 345407 410147 465009 502837 521683 519674 498760 459949 409510 351830 290945 232037 177707 132654 95862 66894 44934 29109 18093 10806 6107 3361 1782 911 453 241 120 57 26 15 4 2 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 2 4 18 64 162 397 851 1717 3235 6034 10865 19499 32915 52959 79332 112494 149760 188880 226878 256155 276840 284790 282119 267704 244679 215901 182944 149151 115992 88084 64974 46037 31543 20668 13169 8004 4531 2520 1336 686 339 194 93 46 16 14 2 2 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 252 497 972 1851 3450 6263 11024 18938 31786 52126 83003 127798 188463 265684 356916 457901 559907 653889 729715 777838 796514 783550 742068 677214 596509 506846 414981 326858 248646 183946 131868 90971 60652 38761 23975 14111 7892 4302 2247 1139 580 314 150 72 31 18 4 2 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 252 497 972 1851 3450 6263 11024 18938 31786 52126 83003 127798 188463 265684 356916 457901 559907 653889 729715 777838 796514 783550 742068 677214 596509 506846 414981 326858 248646 183946 131868 90971 60652 38761 23975 14111 7892 4302 2247 1139 580 314 150 72 31 18 4 2 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.97656 1.98016 1.96378 1.92284 1.89843 1.86232 1.82357 1.79508 1.76909 1.74168 1.70811 1.67058 1.62727 1.58439 1.54272 1.50521 1.46844 1.43533 1.40482 1.37686 1.35333 1.33129 1.31052 1.29278 1.27613 1.25987 1.24472 1.22849 1.21703 1.20629 1.19574 1.18258 1.17278 1.15914 1.15175 1.13785 1.1265 1.11923 1.10809 1.10147 1.1115 1.12586 1.09554 1.1 1.06944 1.09677 1 1 1 tree_stats_height=56 tree_stats_numInternals=6538149 tree_stats_numLeaves=3444600 tree_stats_numNodes=9982749 tree_stats_numKeys=9982749 tree_stats_avgDegreeInternal=1.52685 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.34506 tree_stats_avgKeyDepth=28.4243 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:37 8:26027 16:493071 32:22689 (2^02, 2^03]: 37 (2^03, 2^04]: 26027 (2^04, 2^05]: 493071 (2^05, 2^06]: 22689 sum_limbo_reclamation_event_size_total=12491767 count_limbo_reclamation_event_size_by_thread=5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 5644 count_limbo_reclamation_event_size_total=541824 sum_limbo_reclamation_event_count_total=542016 first_thread_announced_epoch_by_thread=13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 13128 sum_num_inserts_by_thread=261312 262217 264063 264386 262175 259477 259945 260904 264909 265509 262757 260320 261715 262928 264055 264699 262486 260341 258520 260922 263142 263944 260128 259415 260774 262351 263706 264425 263073 259601 260884 261594 265922 264902 262183 260530 260961 263288 264036 263159 262415 260958 258458 259894 261406 262867 260658 257530 260932 261348 263681 264515 261697 260261 260551 263355 265205 265870 263264 260237 263087 263125 265281 266267 263587 260214 258783 260831 264699 264678 261995 260983 260033 262664 264446 264413 261103 260099 260155 261616 264856 264212 263219 259869 261625 262676 264789 265274 262498 260195 259195 260220 264711 263876 262593 260293 sum_num_inserts_total=25174920 sum_num_deletes_by_thread=259744 262241 264413 263824 262835 259901 259864 262831 264648 265236 261490 260229 261452 262915 265077 264985 262648 261394 259379 261657 264270 263508 260691 259370 260503 262134 264458 263979 263370 260131 260732 261698 265460 264522 261229 260471 261003 263206 263753 263405 263365 260665 259696 260181 263085 263987 261106 258802 260440 261105 263330 264183 261893 260529 259362 262907 265476 265204 262860 260418 262122 263675 265340 265445 263179 260437 258800 260308 263995 263592 262046 259324 261076 261482 264935 264213 261750 260678 260073 262420 265203 264726 262111 260844 261441 263311 264807 264801 262448 259661 259552 260334 263792 264454 261511 260187 sum_num_deletes_total=25177323 sum_num_searches_by_thread=4684716 4717260 4751767 4741144 4719242 4669389 4686606 4714207 4756323 4771737 4716493 4682040 4702107 4733541 4755936 4753427 4721843 4697366 4665168 4702692 4731658 4752486 4684919 4660716 4691625 4713161 4753624 4752607 4726374 4672363 4689784 4715664 4767100 4767270 4712555 4681337 4706140 4730689 4760805 4735696 4726028 4692932 4671123 4690984 4717702 4744912 4690700 4655960 4687658 4708304 4749577 4749477 4708521 4690723 4697378 4725495 4767964 4774851 4741344 4703804 4720403 4734985 4771551 4772450 4735704 4678938 4668663 4687618 4748650 4747840 4712455 4679316 4688808 4715698 4748174 4751947 4708008 4685853 4682988 4723247 4762923 4765107 4728225 4701539 4708513 4735270 4765525 4768144 4727401 4682338 4676634 4698321 4755492 4753959 4717977 4680697 sum_num_searches_total=453036375 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=5205772 5241718 5280243 5269354 5244252 5188767 5206415 5237942 5285880 5302482 5240740 5202589 5225274 5259384 5285068 5283111 5246977 5219101 5183067 5225271 5259070 5279938 5205738 5179501 5212902 5237646 5281788 5281011 5252817 5192095 5211400 5238956 5298482 5296694 5235967 5202338 5228104 5257183 5288594 5262260 5251808 5214555 5189277 5211059 5242193 5271766 5212464 5172292 5209030 5230757 5276588 5278175 5232111 5211513 5217291 5251757 5298645 5305925 5267468 5224459 5245612 5261785 5302172 5304162 5262470 5199589 5186246 5208757 5277344 5276110 5236496 5199623 5209917 5239844 5277555 5280573 5230861 5206630 5203216 5247283 5292982 5294045 5253555 5222252 5231579 5261257 5295121 5298219 5252347 5202194 5195381 5218875 5283995 5282289 5242081 5201177 average_num_operations_total=5243631 stdev_num_operations_total=3648 sum_num_operations_total=503388618 min_num_operations_total=5172292 max_num_operations_total=5305925 first_time_thread_terminate_by_thread=10000133 10000133 10000132 10000132 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000132 10000132 10000133 10000133 10000133 10000132 10000133 10000132 10000134 10000134 10000133 10000133 10000132 10000133 10000133 10000133 10000132 10000133 10000132 10000133 10000133 10000133 10000133 10000133 10000133 10000132 10000132 10000133 10000133 10000132 10000133 10000134 10000134 10000134 10000132 10000133 10000132 10000133 10000134 10000135 10000133 10000133 10000132 10000133 10000135 10000135 10000134 10000134 10000132 10000134 10000132 10000134 10000135 10000134 10000133 10000133 10000133 10000133 10000134 10000132 10000135 10000133 10000134 10000135 10000134 10000133 10000132 10000133 10000135 10000135 10000134 10000134 10000135 10000134 10000132 10000134 10000135 10000134 10000133 10000133 10000134 10000133 10000134 10000132 10000135 min_time_thread_terminate_total=10000132 max_time_thread_terminate_total=10000135 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 3 3 3 3 3 3 3 3 3 3 2 2 2 3 3 2 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 2 2 2 3 3 2 3 3 3 3 2 3 3 3 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=99849862963941 threads_final_size=9982749 final_keysum=99849862963941 final_size=9982749 validate_result=success Validation OK. Structural validation OK. total_find=453036375 total_rq=0 total_inserts=25174920 total_deletes=25177323 total_updates=50352243 total_queries=453036375 total_ops=503388618 find_throughput=45303637 rq_throughput=0 update_throughput=5035224 query_throughput=45303637 total_throughput=50338861 total find : 453036375 total rq : 0 total inserts : 25174920 total deletes : 25177323 total updates : 50352243 total queries : 453036375 total ops : 503388618 find throughput : 45303637 rq throughput : 0 update throughput : 5035224 query throughput : 45303637 total throughput : 50338861 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=31.1121 PAPI_L3_TCM=10.8263 PAPI_TOT_CYC=5309.59 PAPI_TOT_INS=1503.23 garbage=2249114631248832 total_execution_walltime=12.379s REALTIME_MAIN_END_PERF_FORMAT=6996584.531884167 [time_cmd_output] time_elapsed_sec=12.55, faults_major=0, faults_minor=238371, mem_maxresident_kb=951208, user_cputime=1180.15, sys_cputime=4.38, percent_cpu=9432% timeout=false algorithm=sigouin_int_bst_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