__step=000179 __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=data000179.txt __path_data=data/data000179.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x55abd59ba400 addrof(kcasDescriptors[1])=0x55abd59bad00 addrof(rdcssDescriptors[0])=0x55abd5ada400 addrof(rdcssDescriptors[1])=0x55abd5ada4c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6996559.276879933 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.022s prefilling_size=8871422 prefilling_elapsed_millis=1.001s prefilling_size=9060126 prefilling_elapsed_millis=1.101s prefilling_size=9219030 prefilling_elapsed_millis=1.201s prefilling_size=9351065 prefilling_elapsed_millis=1.301s prefilling_size=9458886 prefilling_elapsed_millis=1.402s prefilling_size=9546952 prefilling_elapsed_millis=1.502s prefilling_size=9622514 prefilling_elapsed_millis=1.602s prefilling_size=9683912 prefilling_elapsed_millis=1.702s prefilling_size=9735581 prefilling_elapsed_millis=1.802s prefilling_size=9780562 prefilling_elapsed_millis=1.903s prefilling_size=9818341 prefilling_elapsed_millis=2.003s finished prefilling to size 9818366 for expected size 10000000 keysum=98178801666987, performing 81729593 updates; total_prefilling_elapsed_ms=2104 ms) pref_size=9818366 pref_millis=2104 prefill_elapsed_ms=2128 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6996561.620465472 REALTIME_END_PERF_FORMAT=6996571.620542099 ############################################################################### ################################## 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 994 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.187s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 504 975 1842 3342 5883 9854 15827 24489 36195 51968 73251 100739 135550 177354 226128 280973 337068 390697 436571 472369 493042 494583 478313 446127 399678 345013 287776 230060 178214 132498 94766 65069 42950 27384 16709 9875 5816 3177 1726 930 495 273 124 49 21 8 3 1 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 5 19 69 191 449 1103 2129 3956 6896 11101 16527 24716 35501 50324 68961 91691 120106 151019 183602 212750 239468 259920 269161 268703 259052 237911 210916 180661 146996 116642 88683 64652 45215 30350 19704 12045 7114 4366 2349 1313 711 364 216 101 44 18 8 2 1 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 509 994 1911 3533 6332 10957 17956 28445 43091 63069 89778 125455 171051 227678 295089 372664 457174 541716 620173 685119 732510 754503 747474 714830 658730 582924 498692 410721 325210 249140 183449 129721 88165 57734 36413 21920 12930 7543 4075 2243 1206 637 340 150 65 26 11 3 1 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 509 994 1911 3533 6332 10957 17956 28445 43091 63069 89778 125455 171051 227678 295089 372664 457174 541716 620173 685119 732510 754503 747474 714830 658730 582924 498692 410721 325210 249140 183449 129721 88165 57734 36413 21920 12930 7543 4075 2243 1206 637 340 150 65 26 11 3 1 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.98828 1.96267 1.94165 1.88488 1.84631 1.80133 1.73944 1.70272 1.65396 1.62366 1.5995 1.58148 1.56046 1.5386 1.51711 1.49658 1.47281 1.44764 1.42361 1.40077 1.3797 1.35694 1.33518 1.31642 1.29742 1.27818 1.26363 1.24653 1.23167 1.21809 1.20451 1.19054 1.17804 1.16769 1.15639 1.14311 1.13937 1.13357 1.11905 1.12687 1.12305 1.11774 1.10518 1.07647 1.10667 1.07692 1.11538 1 1 1 tree_stats_height=58 tree_stats_numInternals=6536770 tree_stats_numLeaves=3447801 tree_stats_numNodes=9984571 tree_stats_numKeys=9984571 tree_stats_avgDegreeInternal=1.52745 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.34531 tree_stats_avgKeyDepth=30.0847 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:43 8:26051 16:490330 32:22328 (2^02, 2^03]: 43 (2^03, 2^04]: 26051 (2^04, 2^05]: 490330 (2^05, 2^06]: 22328 sum_limbo_reclamation_event_size_total=12409909 count_limbo_reclamation_event_size_by_thread=5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 5612 count_limbo_reclamation_event_size_total=538752 sum_limbo_reclamation_event_count_total=538944 first_thread_announced_epoch_by_thread=13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 13136 sum_num_inserts_by_thread=256850 259962 261586 261097 260202 258354 258069 260147 263780 262127 259287 257521 259608 260817 262077 262147 261722 258155 257781 258686 261834 261783 260413 257448 257383 259893 262427 262885 260892 257495 258059 259429 263643 263352 259988 258827 259110 260556 261702 263385 262008 258662 257821 257480 260638 262259 259148 258738 258919 259124 263226 262511 261600 257166 259166 261553 263531 264498 261774 259528 259180 261585 263759 263967 260601 258291 256563 258620 263021 261772 261040 257559 258515 259174 262926 261818 260251 259025 259455 261136 263042 262115 258858 260797 261105 260690 262532 261627 261519 259342 257851 258409 263980 261696 261425 259694 sum_num_inserts_total=25002769 sum_num_deletes_by_thread=257296 259079 260540 261031 259181 258514 258123 261545 263518 263042 260530 257193 259757 260259 262566 261074 261637 258229 256814 258614 261488 260467 259553 257754 257939 258779 263243 261068 259874 256809 257726 259068 263814 261757 258573 259873 258603 260527 262863 264118 261410 258847 258088 259221 261306 262303 259061 257140 258980 260407 263384 262734 260354 256694 259107 261683 264232 263842 261087 259897 258758 261570 263894 263454 259977 258871 257068 257441 263607 260812 260283 257719 258656 260516 263529 262118 261108 259195 259539 261794 263322 262548 260827 259046 260342 260026 262558 262388 260137 258671 258032 256923 262896 261885 260896 259969 sum_num_deletes_total=24992590 sum_num_searches_by_thread=4641887 4674082 4704170 4697549 4679866 4651830 4647035 4694064 4751967 4725579 4677043 4649096 4680865 4688384 4718872 4717250 4712533 4651558 4629575 4656571 4715734 4702720 4674973 4639303 4640850 4669801 4730654 4718435 4677305 4628005 4633505 4670440 4748241 4725717 4673416 4665802 4659676 4687885 4715962 4743488 4705574 4655989 4654646 4653825 4692197 4732881 4648943 4638591 4658723 4680077 4738809 4717297 4695591 4627406 4651543 4700922 4743140 4761304 4706034 4678632 4667582 4719645 4742630 4736665 4685961 4665952 4614199 4646946 4736527 4706892 4689737 4639125 4652687 4677597 4746198 4720595 4701223 4658478 4683794 4707026 4734056 4725867 4685003 4679591 4693474 4690060 4714469 4707751 4684845 4660695 4636257 4649031 4739077 4715936 4707117 4675674 sum_num_searches_total=450012174 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=5156033 5193123 5226296 5219677 5199249 5168698 5163227 5215756 5279265 5250748 5196860 5163810 5200230 5209460 5243515 5240471 5235892 5167942 5144170 5173871 5239056 5224970 5194939 5154505 5156172 5188473 5256324 5242388 5198071 5142309 5149290 5188937 5275698 5250826 5191977 5184502 5177389 5208968 5240527 5270991 5228992 5173498 5170555 5170526 5214141 5257443 5167152 5154469 5176622 5199608 5265419 5242542 5217545 5141266 5169816 5224158 5270903 5289644 5228895 5198057 5185520 5242800 5270283 5264086 5206539 5183114 5127830 5163007 5263155 5229476 5211060 5154403 5169858 5197287 5272653 5244531 5222582 5176698 5202788 5229956 5260420 5250530 5204688 5199434 5214921 5210776 5239559 5231766 5206501 5178708 5152140 5164363 5265953 5239517 5229438 5195337 average_num_operations_total=5208411 stdev_num_operations_total=3978 sum_num_operations_total=500007533 min_num_operations_total=5127830 max_num_operations_total=5289644 first_time_thread_terminate_by_thread=10000076 10000075 10000075 10000078 10000078 10000076 10000076 10000075 10000078 10000077 10000075 10000077 10000078 10000076 10000078 10000077 10000075 10000076 10000076 10000077 10000075 10000078 10000078 10000076 10000077 10000075 10000078 10000078 10000078 10000076 10000075 10000075 10000078 10000076 10000075 10000077 10000078 10000076 10000077 10000077 10000078 10000077 10000076 10000076 10000075 10000078 10000077 10000076 10000076 10000076 10000078 10000078 10000077 10000076 10000075 10000078 10000075 10000076 10000079 10000076 10000076 10000076 10000076 10000076 10000078 10000075 10000076 10000075 10000077 10000076 10000076 10000076 10000076 10000076 10000078 10000076 10000077 10000076 10000077 10000078 10000078 10000076 10000079 10000076 10000076 10000077 10000076 10000076 10000078 10000075 10000078 10000075 10000077 10000076 10000076 10000076 min_time_thread_terminate_total=10000075 max_time_thread_terminate_total=10000079 first_time_thread_start_by_thread=5 4 5 5 5 5 5 4 5 5 5 4 5 5 5 5 5 5 5 4 5 5 5 5 5 4 5 5 5 5 5 4 5 5 5 4 5 5 5 5 5 5 5 4 5 5 5 5 5 5 4 4 4 4 4 5 5 4 4 4 5 4 4 4 4 5 4 4 4 4 5 4 5 5 4 4 4 4 4 5 5 4 4 4 5 4 4 4 4 5 4 4 4 4 5 4 min_time_thread_start_total=4 max_time_thread_start_total=5 sum_duration_all_ops_total= threads_final_keysum=99838078087999 threads_final_size=9984571 final_keysum=99838078087999 final_size=9984571 validate_result=success Validation OK. Structural validation OK. total_find=450012174 total_rq=0 total_inserts=25002769 total_deletes=24992590 total_updates=49995359 total_queries=450012174 total_ops=500007533 find_throughput=45001217 rq_throughput=0 update_throughput=4999535 query_throughput=45001217 total_throughput=50000753 total find : 450012174 total rq : 0 total inserts : 25002769 total deletes : 24992590 total updates : 49995359 total queries : 450012174 total ops : 500007533 find throughput : 45001217 rq throughput : 0 update throughput : 4999535 query throughput : 45001217 total throughput : 50000753 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=31.3651 PAPI_L3_TCM=10.8127 PAPI_TOT_CYC=5346.47 PAPI_TOT_INS=1572.5 garbage=2235444665482383 total_execution_walltime=12.639s REALTIME_MAIN_END_PERF_FORMAT=6996571.917249480 [time_cmd_output] time_elapsed_sec=12.82, faults_major=0, faults_minor=238400, mem_maxresident_kb=951488, user_cputime=1192.94, sys_cputime=3.04, percent_cpu=9325% 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=1