__step=000185 __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 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000185.txt __path_data=data/data000185.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x558bc7da3400 addrof(kcasDescriptors[1])=0x558bc7da3d00 addrof(rdcssDescriptors[0])=0x558bc7ec3400 addrof(rdcssDescriptors[1])=0x558bc7ec34c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6981041.550554638 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=0.5 DEL_FRAC=0.5 RQ=0 RQSIZE=0 MAXKEY=2000000 PREFILL_THREADS=48 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=48 WORK_THREADS=48 RQ_THREADS=0 distribution=0 INS_DEL_FRAC=0.5 0.5 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 Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.005s prefilling_size=999694 prefilling_elapsed_millis=1.001s finished prefilling to size 999675 for expected size 1000000 keysum=999884918367, performing 38321690 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=999675 pref_millis=1102 prefill_elapsed_ms=1122 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6981042.842145926 REALTIME_END_PERF_FORMAT=6981052.842284899 ############################################################################### ################################## 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 938 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.031s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 126 249 480 912 1681 3008 5139 8280 12721 18504 25708 33754 42203 50280 56531 59946 59875 56914 51109 43407 35088 26999 19977 14290 9942 6607 4423 2775 1645 970 513 233 106 34 17 1 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 2 2 11 26 75 203 493 1099 2091 3773 6112 9478 13621 18266 23272 28165 31865 33165 33108 30775 27076 22451 17605 13379 9689 6893 4511 3129 2016 1188 739 409 188 101 21 21 1 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 251 491 938 1756 3211 5632 9379 14812 22277 31820 43232 55824 68546 79803 88111 91740 90079 84217 74182 62164 49450 37582 27669 19631 13500 8934 5904 3661 2158 1252 642 294 135 38 22 1 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 251 491 938 1756 3211 5632 9379 14812 22277 31820 43232 55824 68546 79803 88111 91740 90079 84217 74182 62164 49450 37582 27669 19631 13500 8934 5904 3661 2158 1252 642 294 135 38 22 1 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.97656 1.96414 1.93279 1.89979 1.8713 1.81719 1.75284 1.69645 1.64515 1.59775 1.55072 1.5105 1.47189 1.4307 1.39572 1.36084 1.32923 1.3031 1.27397 1.25285 1.23103 1.21401 1.20467 1.19303 1.18124 1.17237 1.16577 1.15007 1.14013 1.13068 1.10304 1.09502 1.09864 1.02963 1.13158 1 1 tree_stats_height=44 tree_stats_numInternals=654574 tree_stats_numLeaves=345019 tree_stats_numNodes=999593 tree_stats_numKeys=999593 tree_stats_avgDegreeInternal=1.52709 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.34516 tree_stats_avgKeyDepth=23.3539 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:174376 2:138662 4:13754 8:16 [2^00, 2^01]: 174376 (2^01, 2^02]: 138662 (2^02, 2^03]: 13754 (2^03, 2^04]: 16 sum_limbo_reclamation_event_size_total=548729 count_limbo_reclamation_event_size_by_thread=6793 6826 6870 6853 6769 6687 6741 6802 6790 6854 6884 6702 6699 6853 6779 6764 6857 6877 6806 6785 6809 6959 6834 6741 6792 6773 6853 6755 6846 6758 6786 6794 6897 6814 6883 6763 6729 6842 6919 6757 6794 6778 6764 6788 6852 6833 6851 6853 count_limbo_reclamation_event_size_total=326808 sum_limbo_reclamation_event_count_total=1046736 first_thread_announced_epoch_by_thread=47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 47178 sum_num_inserts_by_thread=49292 49882 50202 49812 49875 48760 49514 49477 50411 50554 49667 49520 49990 49968 50447 50478 50237 49263 49021 49846 50377 50426 49832 49037 49260 49578 49687 50329 50221 49395 49507 49747 50039 50315 49836 49826 49909 49809 50032 50809 50510 49947 49419 49781 50088 50629 49593 49636 sum_num_inserts_total=2393790 sum_num_deletes_by_thread=49399 49540 50057 49990 49728 48860 49028 49689 50171 50442 50027 49484 49548 50228 50501 50395 50341 49595 49504 49716 50425 50583 49651 49471 49276 49804 50165 50596 50456 49614 49313 49853 50252 50191 49808 49572 49642 50171 50567 50380 50185 49525 49028 49715 49929 50776 50287 49530 sum_num_deletes_total=2395008 sum_num_searches_by_thread=9769618 9833949 9903600 9913690 9881734 9657788 9802601 9863332 9963745 9990012 9867621 9826084 9841219 9894404 9989362 9954283 9923505 9797184 9799585 9849185 9940898 9991445 9856173 9767440 9753810 9849595 9907119 9954360 9912327 9781548 9824933 9878059 9967312 9999187 9850140 9820121 9864236 9907000 9987219 9954122 9923239 9815902 9774300 9845303 9934818 10000099 9872224 9770982 sum_num_searches_total=474026412 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=9868309 9933371 10003859 10013492 9981337 9755408 9901143 9962498 10064327 10091008 9967315 9925088 9940757 9994600 10090310 10055156 10024083 9896042 9898110 9948747 10041700 10092454 9955656 9865948 9852346 9948977 10006971 10055285 10013004 9880557 9923753 9977659 10067603 10099693 9949784 9919519 9963787 10006980 10087818 10055311 10023934 9915374 9872747 9944799 10034835 10101504 9972104 9870148 average_num_operations_total=9975316 stdev_num_operations_total=11508 sum_num_operations_total=478815210 min_num_operations_total=9755408 max_num_operations_total=10101504 first_time_thread_terminate_by_thread=10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 min_time_thread_terminate_total=10000138 max_time_thread_terminate_total=10000138 first_time_thread_start_by_thread=6 5 5 5 5 5 6 6 6 5 6 6 5 6 5 5 6 6 5 6 5 6 6 6 6 5 5 5 5 5 6 6 6 5 6 6 5 6 5 5 6 6 5 6 5 6 6 6 min_time_thread_start_total=5 max_time_thread_start_total=6 sum_duration_all_ops_total= threads_final_keysum=999944804771 threads_final_size=999593 final_keysum=999944804771 final_size=999593 validate_result=success Validation OK. Structural validation OK. total_find=474026412 total_rq=0 total_inserts=2393790 total_deletes=2395008 total_updates=4788798 total_queries=474026412 total_ops=478815210 find_throughput=47402641 rq_throughput=0 update_throughput=478879 query_throughput=47402641 total_throughput=47881521 total find : 474026412 total rq : 0 total inserts : 2393790 total deletes : 2395008 total updates : 4788798 total queries : 474026412 total ops : 478815210 find throughput : 47402641 rq throughput : 0 update throughput : 478879 query throughput : 47402641 total throughput : 47881521 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=16.3717 PAPI_L3_TCM=2.10704 PAPI_TOT_CYC=2779.02 PAPI_TOT_INS=1256.18 garbage=236940375008750 total_execution_walltime=11.415s REALTIME_MAIN_END_PERF_FORMAT=6981052.966108566 [time_cmd_output] time_elapsed_sec=11.55, faults_major=0, faults_minor=91486, mem_maxresident_kb=367836, user_cputime=559.68, sys_cputime=1.82, percent_cpu=4859% 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