__step=000412 __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_bst_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=data000412.txt __path_data=data/data000412.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x558f37b81400 addrof(kcasDescriptors[1])=0x558f37b81d00 addrof(rdcssDescriptors[0])=0x558f37ca1400 addrof(rdcssDescriptors[1])=0x558f37ca14c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6983826.708130535 binary=./sigouin_int_bst_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_bst_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.011s prefilling_size=8891605 prefilling_elapsed_millis=1.001s prefilling_size=9080627 prefilling_elapsed_millis=1.101s prefilling_size=9236330 prefilling_elapsed_millis=1.201s prefilling_size=9366450 prefilling_elapsed_millis=1.302s prefilling_size=9473403 prefilling_elapsed_millis=1.402s prefilling_size=9561769 prefilling_elapsed_millis=1.502s prefilling_size=9634762 prefilling_elapsed_millis=1.602s prefilling_size=9695610 prefilling_elapsed_millis=1.702s prefilling_size=9746580 prefilling_elapsed_millis=1.803s prefilling_size=9787613 prefilling_elapsed_millis=1.903s prefilling_size=9823533 prefilling_elapsed_millis=2.003s finished prefilling to size 9823521 for expected size 10000000 keysum=98237715946129, performing 81163587 updates; total_prefilling_elapsed_ms=2105 ms) pref_size=9823521 pref_millis=2105 prefill_elapsed_ms=2132 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6983829.39852049 REALTIME_END_PERF_FORMAT=6983839.39996471 ############################################################################### ################################## 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 996 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.096s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 504 988 1914 3593 6510 11445 19563 32315 51394 78234 113571 158853 212847 272660 334832 396271 450187 491455 515458 519407 502258 467498 417844 358687 295851 235761 181271 134132 96040 65995 43590 27842 17145 10244 5898 3196 1721 946 520 260 128 52 22 6 1 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 6 8 30 122 364 859 1794 3673 7153 13384 23184 36961 56571 82033 112465 145710 181920 217284 247143 270907 282909 282712 271711 249940 220443 185955 151321 118841 89591 65415 45855 30770 19820 12399 7533 4471 2443 1284 703 399 190 114 44 20 7 1 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 510 996 1944 3715 6874 12304 21357 35988 58547 91618 136755 195814 269418 354693 447297 541981 632107 708739 762601 790314 785167 750210 689555 608627 516294 421716 332592 252973 185631 131410 89445 58612 36965 22643 13431 7667 4164 2230 1223 659 318 166 66 26 8 1 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 510 996 1944 3715 6874 12304 21357 35988 58547 91618 136755 195814 269418 354693 447297 541981 632107 708739 762601 790314 785167 750210 689555 608627 516294 421716 332592 252973 185631 131410 89445 58612 36965 22643 13431 7667 4164 2230 1223 659 318 166 66 26 8 1 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99219 1.96471 1.95984 1.92644 1.88318 1.84289 1.80559 1.76907 1.72891 1.68704 1.63875 1.60139 1.56464 1.52649 1.49236 1.46311 1.43514 1.40903 1.38258 1.36042 1.33627 1.3158 1.29599 1.27668 1.25895 1.24379 1.22961 1.21559 1.20358 1.19054 1.17845 1.16795 1.15565 1.14874 1.14075 1.13171 1.12626 1.12224 1.12422 1.11365 1.08801 1.1195 1.08434 1.06061 1.07692 1 1 tree_stats_height=55 tree_stats_numInternals=6539420 tree_stats_numLeaves=3446462 tree_stats_numNodes=9985882 tree_stats_numKeys=9985882 tree_stats_avgDegreeInternal=1.52703 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.34513 tree_stats_avgKeyDepth=28.4244 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:38 8:25956 16:493460 32:22466 (2^02, 2^03]: 38 (2^03, 2^04]: 25956 (2^04, 2^05]: 493460 (2^05, 2^06]: 22466 sum_limbo_reclamation_event_size_total=12496190 count_limbo_reclamation_event_size_by_thread=5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 5645 count_limbo_reclamation_event_size_total=541920 sum_limbo_reclamation_event_count_total=542112 first_thread_announced_epoch_by_thread=13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 13184 sum_num_inserts_by_thread=260318 261264 264776 263305 262736 259491 260510 261437 265478 264453 260437 259985 261016 261711 264423 265154 263009 259897 259415 261212 263327 263612 261059 258104 259864 261280 264065 262994 262968 260512 259743 262139 264448 264274 261367 260039 261623 263271 263902 263972 262327 260271 258948 261327 261894 263486 260300 259370 261207 261529 263825 263649 261275 259720 260267 261775 264636 264949 261995 260377 261431 263635 265564 266265 262617 260437 259190 261424 263399 264337 260962 260200 261156 262432 264248 263876 261223 260198 258990 261437 263900 266286 262920 260980 262207 263095 264630 264166 263119 260369 260823 261192 264234 263700 262675 261139 sum_num_inserts_total=25164173 sum_num_deletes_by_thread=260455 261053 263872 263499 261709 260229 260670 261474 264632 264704 261910 259904 261307 262843 263712 264387 261993 260671 260713 261014 262238 264477 260766 258516 260855 259703 263728 263235 263293 260782 261132 261956 264465 264148 260466 258923 261465 262651 264454 263465 261705 260849 258928 260243 263303 263985 260876 258638 261128 262113 264052 264025 261313 260012 260834 262241 264654 265220 262084 260901 261913 263809 265819 264966 262775 261096 259790 261670 263502 263871 262888 260374 260379 262415 264281 263673 262152 258813 259378 262701 264114 265997 262030 260497 261469 264035 264406 264690 262613 260229 258715 261471 264697 263453 262525 260085 sum_num_deletes_total=25165864 sum_num_searches_by_thread=4674729 4709499 4747117 4753057 4720130 4677992 4686730 4714108 4771408 4758554 4699541 4683200 4700984 4725378 4759799 4761225 4733858 4684673 4669330 4703391 4723690 4745399 4696788 4646048 4691842 4695275 4749882 4744127 4730484 4684104 4686979 4714815 4759346 4756111 4699974 4676565 4696686 4729924 4762623 4751949 4718343 4696174 4661411 4698496 4717613 4740051 4692861 4654864 4697037 4719886 4758795 4745252 4703641 4676968 4685831 4725674 4769148 4770282 4716852 4688221 4705258 4751547 4779847 4771776 4734071 4690517 4664554 4691971 4754143 4752018 4715180 4684568 4693326 4719737 4756638 4744826 4704669 4674648 4674024 4719116 4761301 4774201 4722213 4688138 4705167 4740665 4759267 4758700 4735176 4687793 4675393 4694001 4754593 4757062 4731221 4695793 sum_num_searches_total=452937832 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=5195502 5231816 5275765 5279861 5244575 5197712 5207910 5237019 5301518 5287711 5221888 5203089 5223307 5249932 5287934 5290766 5258860 5205241 5189458 5225617 5249255 5273488 5218613 5162668 5212561 5216258 5277675 5270356 5256745 5205398 5207854 5238910 5288259 5284533 5221807 5195527 5219774 5255846 5290979 5279386 5242375 5217294 5179287 5220066 5242810 5267522 5214037 5172872 5219372 5243528 5286672 5272926 5226229 5196700 5206932 5249690 5298438 5300451 5240931 5209499 5228602 5278991 5311230 5303007 5259463 5212050 5183534 5215065 5281044 5280226 5239030 5205142 5214861 5244584 5285167 5272375 5228044 5193659 5192392 5243254 5289315 5306484 5247163 5209615 5228843 5267795 5288303 5287556 5260908 5208391 5194931 5216664 5283524 5284215 5256421 5217017 average_num_operations_total=5242373 stdev_num_operations_total=3733 sum_num_operations_total=503267869 min_num_operations_total=5162668 max_num_operations_total=5311230 first_time_thread_terminate_by_thread=10000143 10000146 10000146 10000145 10000145 10000143 10000144 10000145 10000144 10000143 10000146 10000143 10000144 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000144 10000143 10000143 10000144 10000145 10000146 10000146 10000145 10000145 10000145 10000143 10000143 10000143 10000143 10000145 10000145 10000144 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000144 10000143 10000143 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000145 10000144 10000145 10000144 10000144 10000145 10000144 10000144 10000144 10000145 10000146 10000144 10000145 10000145 10000144 10000145 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000145 10000144 10000145 10000144 10000146 10000145 10000144 10000144 10000145 10000145 10000146 10000144 10000145 10000145 10000144 10000145 10000144 10000144 min_time_thread_terminate_total=10000143 max_time_thread_terminate_total=10000146 first_time_thread_start_by_thread=5 5 5 5 5 5 4 5 5 4 5 4 4 5 5 5 5 5 5 4 4 4 5 5 5 5 5 5 5 5 4 5 5 4 5 4 4 5 5 5 5 5 5 4 4 4 5 5 5 5 4 4 5 4 5 5 5 5 5 5 5 5 4 5 5 4 4 5 4 5 4 4 5 5 4 4 5 4 5 5 5 5 5 4 5 5 4 5 5 4 4 5 4 5 4 4 min_time_thread_start_total=4 max_time_thread_start_total=5 sum_duration_all_ops_total= threads_final_keysum=99868137729381 threads_final_size=9985882 final_keysum=99868137729381 final_size=9985882 validate_result=success Validation OK. Structural validation OK. total_find=452937832 total_rq=0 total_inserts=25164173 total_deletes=25165864 total_updates=50330037 total_queries=452937832 total_ops=503267869 find_throughput=45293783 rq_throughput=0 update_throughput=5033003 query_throughput=45293783 total_throughput=50326786 total find : 452937832 total rq : 0 total inserts : 25164173 total deletes : 25165864 total updates : 50330037 total queries : 452937832 total ops : 503267869 find throughput : 45293783 rq throughput : 0 update throughput : 5033003 query throughput : 45293783 total throughput : 50326786 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=31.067 PAPI_L3_TCM=10.8231 PAPI_TOT_CYC=5310.93 PAPI_TOT_INS=1528.27 garbage=2250075313669230 total_execution_walltime=12.539s REALTIME_MAIN_END_PERF_FORMAT=6983839.247818258 [time_cmd_output] time_elapsed_sec=12.71, faults_major=0, faults_minor=238499, mem_maxresident_kb=951684, user_cputime=1188.76, sys_cputime=3.76, percent_cpu=9376% timeout=false algorithm=sigouin_int_bst_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