__step=000171 __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.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=data000171.txt __path_data=data/data000171.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x55c0e6ad6400 addrof(kcasDescriptors[1])=0x55c0e6ad6d00 addrof(rdcssDescriptors[0])=0x55c0e6bf6400 addrof(rdcssDescriptors[1])=0x55c0e6bf64c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6996455.234259002 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.009s prefilling_size=8842793 prefilling_elapsed_millis=1.001s prefilling_size=9039098 prefilling_elapsed_millis=1.101s prefilling_size=9200181 prefilling_elapsed_millis=1.201s prefilling_size=9331788 prefilling_elapsed_millis=1.301s prefilling_size=9442655 prefilling_elapsed_millis=1.402s prefilling_size=9533799 prefilling_elapsed_millis=1.502s prefilling_size=9611784 prefilling_elapsed_millis=1.602s prefilling_size=9677332 prefilling_elapsed_millis=1.702s prefilling_size=9729257 prefilling_elapsed_millis=1.803s prefilling_size=9772604 prefilling_elapsed_millis=1.903s prefilling_size=9810276 prefilling_elapsed_millis=2.003s finished prefilling to size 9810286 for expected size 10000000 keysum=98112868192684, performing 80599969 updates; total_prefilling_elapsed_ms=2105 ms) pref_size=9810286 pref_millis=2105 prefill_elapsed_ms=2124 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6996457.548952057 REALTIME_END_PERF_FORMAT=6996467.549110081 ############################################################################### ################################## 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 1015 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.141s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 510 1004 1950 3701 6865 12232 20860 33968 53064 79079 113265 155945 206286 260859 318036 372139 419958 457008 479937 486234 476759 452377 414649 367920 315705 261162 209955 162957 122674 89602 63189 43326 29051 18588 11596 7106 4184 2440 1345 762 427 241 131 53 20 5 1 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 2 11 33 112 305 859 1991 4303 8186 14692 24236 37994 56573 81907 108514 140430 172785 203879 230074 250294 261769 264192 257934 241749 220227 193855 163408 134000 105818 80930 60023 42984 29719 20499 13219 8224 5213 3055 1829 994 564 302 184 101 46 18 5 2 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1015 1983 3813 7170 13091 22851 38271 61250 93771 137501 193939 262859 342766 426550 512569 592743 660887 710011 736528 738528 716569 672583 609669 535932 455017 373363 296957 228492 170532 123212 86310 58770 39087 24815 15330 9397 5495 3174 1756 991 543 315 154 66 23 6 2 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1015 1983 3813 7170 13091 22851 38271 61250 93771 137501 193939 262859 342766 426550 512569 592743 660887 710011 736528 738528 716569 672583 609669 535932 455017 373363 296957 228492 170532 123212 86310 58770 39087 24815 15330 9397 5495 3174 1756 991 543 315 154 66 23 6 2 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 1.98633 1.96453 1.93949 1.90978 1.86834 1.81117 1.76194 1.71286 1.6646 1.62303 1.58672 1.55128 1.51921 1.48339 1.45606 1.43039 1.40646 1.38282 1.36139 1.34255 1.32471 1.30731 1.28996 1.27558 1.25994 1.24659 1.23302 1.22069 1.20945 1.19709 1.18765 1.17894 1.17077 1.15931 1.15047 1.14945 1.13951 1.13358 1.12949 1.13041 1.11705 1.13628 1.07302 1.08442 1.04545 1.04348 1.16667 1 tree_stats_height=57 tree_stats_numInternals=6539636 tree_stats_numLeaves=3448043 tree_stats_numNodes=9987679 tree_stats_numKeys=9987679 tree_stats_avgDegreeInternal=1.52725 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.34523 tree_stats_avgKeyDepth=28.8048 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:42 8:26063 16:492646 32:22304 64:184 128:9 (2^02, 2^03]: 42 (2^03, 2^04]: 26063 (2^04, 2^05]: 492646 (2^05, 2^06]: 22304 (2^06, 2^07]: 184 (2^07, 2^08]: 9 sum_limbo_reclamation_event_size_total=12483306 count_limbo_reclamation_event_size_by_thread=5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 5638 count_limbo_reclamation_event_size_total=541248 sum_limbo_reclamation_event_count_total=541440 first_thread_announced_epoch_by_thread=13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 13160 sum_num_inserts_by_thread=258897 261923 264661 262284 262532 259765 262211 260236 265227 263350 262490 258521 262656 263838 264952 263132 261809 259082 259823 261754 262454 265003 260598 260110 261400 261431 263009 264110 261527 259218 261465 260695 264510 264013 262069 258830 260551 261925 263736 263763 261413 259923 258507 260889 262330 263058 261392 258829 259319 262235 263505 265416 261758 260154 260444 261890 266499 264552 263750 262379 261003 262030 265456 263117 262091 258558 258063 261550 264001 264987 260649 261488 261356 261709 265760 262900 262736 259919 261311 262428 264686 266250 261932 261837 261731 262556 265433 265160 262638 261501 257997 259655 264510 265226 262804 259097 sum_num_inserts_total=25161927 sum_num_deletes_by_thread=259465 260548 263636 262562 262552 259702 260638 260099 265130 263711 262728 259608 261981 263056 264465 263689 262609 260238 258842 261453 261738 264007 260468 258653 261721 262392 263705 263994 261226 259015 262266 260000 264178 263581 261981 258970 261129 261496 264175 262508 261630 259979 258390 261421 263099 262030 261286 259573 259833 260625 262704 264480 261979 259294 260400 260918 265961 264702 263411 261173 261513 261945 265093 263681 263166 258560 258569 261597 263825 264063 260054 260470 260296 261256 263761 263286 262849 259507 263152 261497 264829 265639 262278 262463 261101 262540 265128 264791 262352 260528 257489 259561 264057 264889 263622 258537 sum_num_deletes_total=25144747 sum_num_searches_by_thread=4667794 4703452 4753421 4723808 4732019 4681085 4706117 4698690 4773980 4759030 4724296 4671937 4722680 4747998 4749552 4743981 4716492 4684644 4657683 4710194 4721413 4767588 4687457 4671872 4705417 4707006 4727611 4750785 4698719 4661166 4706996 4704109 4746102 4747414 4708883 4662323 4714801 4710682 4740529 4744115 4704148 4679073 4652504 4705948 4724932 4732382 4701058 4672142 4679135 4699279 4741039 4766668 4707098 4673206 4682320 4708043 4788756 4765007 4749462 4711382 4697521 4723300 4773076 4742946 4713528 4662630 4650569 4701027 4755301 4766583 4688904 4697353 4697243 4706298 4775628 4739267 4719941 4669175 4705059 4726400 4754898 4782283 4715041 4717854 4700880 4728000 4781551 4778565 4721080 4692641 4641630 4671255 4756796 4770007 4733151 4670365 sum_num_searches_total=452785169 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=5186156 5225923 5281718 5248654 5257103 5200552 5228966 5219025 5304337 5286091 5249514 5190066 5247317 5274892 5278969 5270802 5240910 5203964 5176348 5233401 5245605 5296598 5208523 5190635 5228538 5230829 5254325 5278889 5221472 5179399 5230727 5224804 5274790 5275008 5232933 5180123 5236481 5234103 5268440 5270386 5227191 5198975 5169401 5228258 5250361 5257470 5223736 5190544 5198287 5222139 5267248 5296564 5230835 5192654 5203164 5230851 5321216 5294261 5276623 5234934 5220037 5247275 5303625 5269744 5238785 5179748 5167201 5224174 5283127 5295633 5209607 5219311 5218895 5229263 5305149 5265453 5245526 5188601 5229522 5250325 5284413 5314172 5239251 5242154 5223712 5253096 5312112 5308516 5246070 5214670 5157116 5190471 5285363 5300122 5259577 5187999 average_num_operations_total=5240540 stdev_num_operations_total=3975 sum_num_operations_total=503091843 min_num_operations_total=5157116 max_num_operations_total=5321216 first_time_thread_terminate_by_thread=10000158 10000157 10000157 10000157 10000157 10000159 10000158 10000157 10000157 10000157 10000158 10000158 10000157 10000157 10000157 10000157 10000158 10000157 10000157 10000157 10000157 10000157 10000158 10000157 10000158 10000158 10000157 10000157 10000157 10000158 10000158 10000157 10000157 10000157 10000158 10000157 10000157 10000157 10000157 10000158 10000158 10000156 10000157 10000157 10000157 10000157 10000157 10000157 10000159 10000157 10000157 10000157 10000157 10000159 10000158 10000159 10000157 10000158 10000159 10000158 10000157 10000158 10000157 10000159 10000157 10000158 10000157 10000158 10000157 10000158 10000159 10000159 10000157 10000157 10000157 10000157 10000157 10000159 10000157 10000157 10000159 10000158 10000157 10000157 10000157 10000158 10000159 10000157 10000157 10000157 10000157 10000158 10000158 10000158 10000159 10000159 min_time_thread_terminate_total=10000156 max_time_thread_terminate_total=10000159 first_time_thread_start_by_thread=3 3 3 3 4 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 4 4 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 4 4 3 3 3 3 4 3 3 3 3 3 3 min_time_thread_start_total=3 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=99877646717945 threads_final_size=9987679 final_keysum=99877646717945 final_size=9987679 validate_result=success Validation OK. Structural validation OK. total_find=452785169 total_rq=0 total_inserts=25161927 total_deletes=25144747 total_updates=50306674 total_queries=452785169 total_ops=503091843 find_throughput=45278516 rq_throughput=0 update_throughput=5030667 query_throughput=45278516 total_throughput=50309184 total find : 452785169 total rq : 0 total inserts : 25161927 total deletes : 25144747 total updates : 50306674 total queries : 452785169 total ops : 503091843 find throughput : 45278516 rq throughput : 0 update throughput : 5030667 query throughput : 45278516 total throughput : 50309184 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=31.1625 PAPI_L3_TCM=10.8267 PAPI_TOT_CYC=5312.46 PAPI_TOT_INS=1544.12 garbage=2248813329867005 total_execution_walltime=12.553s REALTIME_MAIN_END_PERF_FORMAT=6996467.787779556 [time_cmd_output] time_elapsed_sec=12.73, faults_major=0, faults_minor=238952, mem_maxresident_kb=953728, user_cputime=1189.10, sys_cputime=3.92, percent_cpu=9368% 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=1