__step=000635 __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.debra -nwork 96 -nprefill 96 -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=data000635.txt __path_data=data/data000635.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x55beddb33400 addrof(kcasDescriptors[1])=0x55beddb33d00 addrof(rdcssDescriptors[0])=0x55beddc53400 addrof(rdcssDescriptors[1])=0x55beddc534c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=7002443.129291943 binary=./sigouin_int_avl_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_avl_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=200000 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.01s prefilling_size=99692 prefilling_elapsed_millis=1.001s finished prefilling to size 99697 for expected size 100000 keysum=9976649225, performing 38341799 updates; total_prefilling_elapsed_ms=1103 ms) pref_size=99697 pref_millis=1103 prefill_elapsed_ms=1126 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=7002444.435887192 REALTIME_END_PERF_FORMAT=7002454.436043973 ############################################################################### ################################## 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.035s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8176 15121 17638 7613 634 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 16 1117 10385 20476 9817 771 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16238 28023 28089 10451 771 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16238 28023 28089 10451 771 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 1.98413 1.79456 1.37294 1.10104 1.01311 1 tree_stats_height=19 tree_stats_numInternals=57373 tree_stats_numLeaves=42582 tree_stats_numNodes=99955 tree_stats_numKeys=99955 tree_stats_avgDegreeInternal=1.7422 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.42601 tree_stats_avgKeyDepth=14.8592 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:5 2:14 4:202 8:65083 16:877765 32:16237 64:368 128:35 256:60 [2^00, 2^01]: 5 (2^01, 2^02]: 14 (2^02, 2^03]: 202 (2^03, 2^04]: 65083 (2^04, 2^05]: 877765 (2^05, 2^06]: 16237 (2^06, 2^07]: 368 (2^07, 2^08]: 35 (2^08, 2^09]: 60 sum_limbo_reclamation_event_size_total=21001814 count_limbo_reclamation_event_size_by_thread=9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9997 9997 9998 9998 9998 9998 9998 9997 9997 9997 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9997 9998 9997 9997 9998 9998 9998 9998 9998 9997 9997 9997 9997 9998 9997 9997 9997 9998 9998 9998 9998 9997 9997 9998 9997 9998 9998 9997 9997 9998 9998 9997 9998 9997 9998 9997 9997 9998 9997 9997 9997 9997 9998 9997 9997 9998 9996 9997 9997 9998 9998 9998 9997 9998 9998 9997 count_limbo_reclamation_event_size_total=959769 sum_limbo_reclamation_event_count_total=1486826 first_thread_announced_epoch_by_thread=31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 31964 sum_num_inserts_by_thread=672415 677916 679694 679576 673573 669623 672008 670452 680672 678833 676548 671686 671584 674297 676066 677324 678387 675236 669852 674317 677532 678830 677132 670887 671814 677629 677664 679835 674164 666381 668716 670486 680319 681539 672052 670832 672083 671998 676745 674388 677005 672737 666335 669415 673668 674715 670793 662549 673171 674218 684319 684819 675427 679608 678275 678431 685106 689161 684176 680578 678400 682880 687063 683298 679556 672679 672914 674684 680589 681958 678494 673182 674776 673977 682846 681299 678207 676073 675544 678419 686365 687535 683046 682047 679286 682691 687900 690579 687487 681904 682751 680483 691686 693253 691317 689034 sum_num_inserts_total=65069793 sum_num_deletes_by_thread=673154 675344 678542 678900 673607 670059 670163 672859 682189 680080 675240 671947 672015 674496 676508 677143 677981 674553 668998 672295 678250 680506 677596 670874 671852 676843 677437 681784 674131 666469 668503 671308 680962 680152 673445 669648 672726 673986 676108 676276 678036 672776 666555 668086 673166 676204 670623 663545 675473 674215 685422 685072 677298 679297 678368 678547 685675 689035 685638 680789 677684 681630 685413 683967 679594 672361 673062 675262 680387 681432 679229 674639 674345 674375 683722 680052 679483 677005 675721 678204 686702 685473 681613 681773 679604 682699 689165 689974 687363 681833 683306 678391 692062 692536 690252 685570 sum_num_deletes_total=65074632 sum_num_searches_by_thread=12099660 12167797 12220526 12195031 12139396 12060155 12079485 12089041 12257183 12241846 12181041 12095364 12096300 12132141 12165454 12199516 12200920 12142305 12054986 12103906 12191774 12213286 12209915 12094213 12096620 12181028 12210669 12241361 12138259 11984837 12041473 12100094 12256526 12247128 12119417 12058919 12080534 12105474 12159227 12155364 12188486 12090679 12011805 12012819 12124900 12160586 12084980 11939082 12134530 12138297 12337819 12333129 12185998 12241049 12202365 12230701 12347446 12416703 12322590 12256585 12217132 12285564 12339964 12322092 12240718 12096493 12120633 12153781 12270021 12289490 12199925 12124704 12141289 12137834 12306121 12253195 12221417 12173577 12163014 12212921 12339082 12367588 12283534 12291366 12239437 12298111 12398114 12430173 12368117 12281190 12285742 12225795 12457809 12486132 12443444 12349609 sum_num_searches_total=1171383848 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=13445229 13521057 13578762 13553507 13486576 13399837 13421656 13432352 13620044 13600759 13532829 13438997 13439899 13480934 13518028 13553983 13557288 13492094 13393836 13450518 13547556 13572622 13564643 13435974 13440286 13535500 13565770 13602980 13486554 13317687 13378692 13441888 13617807 13608819 13464914 13399399 13425343 13451458 13512080 13506028 13543527 13436192 13344695 13350320 13471734 13511505 13426396 13265176 13483174 13486730 13707560 13703020 13538723 13599954 13559008 13587679 13718227 13794899 13692404 13617952 13573216 13650074 13712440 13689357 13599868 13441533 13466609 13503727 13630997 13652880 13557648 13472525 13490410 13486186 13672689 13614546 13579107 13526655 13514279 13569544 13712149 13740596 13648193 13655186 13598327 13663501 13775179 13810726 13742967 13644927 13651799 13584669 13841557 13871921 13825013 13724213 average_num_operations_total=13557586 stdev_num_operations_total=12498 sum_num_operations_total=1301528273 min_num_operations_total=13265176 max_num_operations_total=13871921 first_time_thread_terminate_by_thread=10000156 10000155 10000155 10000156 10000156 10000157 10000155 10000157 10000157 10000155 10000155 10000155 10000155 10000156 10000157 10000157 10000156 10000157 10000157 10000157 10000157 10000155 10000157 10000155 10000156 10000155 10000155 10000156 10000157 10000157 10000155 10000157 10000157 10000155 10000155 10000155 10000155 10000156 10000157 10000157 10000156 10000156 10000157 10000157 10000157 10000155 10000158 10000155 10000156 10000155 10000156 10000158 10000155 10000158 10000156 10000158 10000158 10000157 10000155 10000156 10000156 10000155 10000157 10000156 10000157 10000155 10000156 10000155 10000156 10000158 10000155 10000158 10000156 10000155 10000156 10000158 10000155 10000158 10000159 10000158 10000159 10000157 10000155 10000156 10000156 10000155 10000157 10000158 10000157 10000155 10000156 10000155 10000157 10000158 10000155 10000158 min_time_thread_terminate_total=10000155 max_time_thread_terminate_total=10000159 first_time_thread_start_by_thread=4 3 3 4 3 3 3 4 3 4 4 3 4 4 3 3 3 3 4 4 3 3 4 4 4 3 3 4 3 3 3 4 3 4 4 3 4 4 3 3 3 3 4 4 3 3 4 4 4 4 3 4 4 3 4 4 3 4 3 4 4 4 3 3 4 4 3 4 4 3 3 3 4 4 3 4 4 3 4 4 3 4 3 4 4 4 3 3 4 4 3 4 4 3 3 3 min_time_thread_start_total=3 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=9987854749 threads_final_size=99955 final_keysum=9987854749 final_size=99955 validate_result=success Validation OK. Structural validation OK. total_find=1171383848 total_rq=0 total_inserts=65069793 total_deletes=65074632 total_updates=130144425 total_queries=1171383848 total_ops=1301528273 find_throughput=117138384 rq_throughput=0 update_throughput=13014442 query_throughput=117138384 total_throughput=130152827 total find : 1171383848 total rq : 0 total inserts : 65069793 total deletes : 65074632 total updates : 130144425 total queries : 1171383848 total ops : 1301528273 find throughput : 117138384 rq throughput : 0 update throughput : 13014442 query throughput : 117138384 total throughput : 130152827 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=7.18995 PAPI_L3_TCM=0.579926 PAPI_TOT_CYC=2023.36 PAPI_TOT_INS=1094.67 garbage=58573310545192 total_execution_walltime=11.472s REALTIME_MAIN_END_PERF_FORMAT=7002454.602336816 [time_cmd_output] time_elapsed_sec=11.59, faults_major=0, faults_minor=80396, mem_maxresident_kb=318688, user_cputime=1091.13, sys_cputime=4.19, percent_cpu=9450% timeout=false algorithm=sigouin_int_avl_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