__step=000633 __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 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=data000633.txt __path_data=data/data000633.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x55a4ea352400 addrof(kcasDescriptors[1])=0x55a4ea352d00 addrof(rdcssDescriptors[0])=0x55a4ea472400 addrof(rdcssDescriptors[1])=0x55a4ea4724c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6986481.161381231 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=200000 PREFILL_THREADS=48 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=48 WORK_THREADS=48 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 Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.005s prefilling_size=100088 prefilling_elapsed_millis=1.001s finished prefilling to size 100123 for expected size 100000 keysum=10010095666, performing 54963777 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=100123 pref_millis=1102 prefill_elapsed_ms=1133 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6986482.441726795 REALTIME_END_PERF_FORMAT=6986492.441870911 ############################################################################### ################################## 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 830 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.037s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 63 125 244 448 767 1220 1831 2539 3378 4102 4717 5131 5505 5697 5605 5305 4798 4038 3159 2349 1681 1076 732 426 211 93 32 9 3 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 2 21 63 170 335 615 924 1444 1868 2356 2477 2798 3036 3096 3024 2924 2563 2051 1560 1161 752 528 339 170 75 31 9 4 tree_stats_numNodesAtDepth=1 2 4 8 16 32 63 125 246 469 830 1390 2166 3154 4302 5546 6585 7487 7982 8495 8641 8401 7822 6962 5722 4400 3241 2237 1484 954 550 263 107 40 12 4 tree_stats_numKeysAtDepth=1 2 4 8 16 32 63 125 246 469 830 1390 2166 3154 4302 5546 6585 7487 7982 8495 8641 8401 7822 6962 5722 4400 3241 2237 1484 954 550 263 107 40 12 4 tree_stats_avgDegreeAtDepth=2 2 2 2 2 1.96875 1.98413 1.968 1.91463 1.8145 1.7506 1.68058 1.6108 1.55897 1.50395 1.44771 1.42065 1.38079 1.37459 1.34656 1.32357 1.29961 1.27666 1.24188 1.21688 1.20273 1.17155 1.18239 1.1496 1.12998 1.09455 1.05323 1.07477 1.075 1.08333 1 tree_stats_height=36 tree_stats_numInternals=65347 tree_stats_numLeaves=34396 tree_stats_numNodes=99743 tree_stats_numKeys=99743 tree_stats_avgDegreeInternal=1.52636 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.34485 tree_stats_avgKeyDepth=19.5706 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:70 2:1362 4:50592 8:374927 16:52875 32:26 64:36 128:11 [2^00, 2^01]: 70 (2^01, 2^02]: 1362 (2^02, 2^03]: 50592 (2^03, 2^04]: 374927 (2^04, 2^05]: 52875 (2^05, 2^06]: 26 (2^06, 2^07]: 36 (2^07, 2^08]: 11 sum_limbo_reclamation_event_size_total=5497847 count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 count_limbo_reclamation_event_size_total=479899 sum_limbo_reclamation_event_count_total=1732512 first_thread_announced_epoch_by_thread=77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 77328 sum_num_inserts_by_thread=820645 801699 831392 834492 828167 814238 818112 824963 837567 840082 831106 824466 824612 823295 835374 834734 834207 824216 818754 825940 835874 832676 825656 820199 819028 824636 835100 833490 829091 820760 823922 829436 837042 837995 828515 822468 823053 824581 835480 832044 833786 824761 815521 822086 831966 835902 827782 822950 sum_num_inserts_total=39713861 sum_num_deletes_by_thread=818394 801247 831753 833671 828029 816815 818110 824922 838617 838215 830306 823518 823327 826525 835225 834162 834305 822424 819572 825203 836073 834900 826673 821022 820086 824596 834219 834542 830019 820958 822146 829320 837244 838793 826509 823520 822139 822993 835546 833537 834764 827942 815539 820960 831987 834490 829337 822755 sum_num_deletes_total=39716949 sum_num_searches_by_thread=14726641 14418944 14964258 15003389 14900690 14689145 14724869 14845927 15071416 15117274 14949849 14821978 14834358 14847006 15039585 15022016 15019882 14811974 14746932 14864268 15024098 15027225 14897170 14758434 14724556 14853187 15006095 15009962 14920490 14781383 14826174 14911723 15067740 15076888 14898739 14814778 14805099 14841207 15038304 15002280 15014365 14858042 14654164 14810386 14996264 15030434 14923475 14840665 sum_num_searches_total=714833728 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=16365680 16021890 16627403 16671552 16556886 16320198 16361091 16495812 16747600 16795571 16611261 16469962 16482297 16496826 16710184 16690912 16688394 16458614 16385258 16515411 16696045 16694801 16549499 16399655 16363670 16502419 16675414 16677994 16579600 16423101 16472242 16570479 16742026 16753676 16553763 16460766 16450291 16488781 16709330 16667861 16682915 16510745 16285224 16453432 16660217 16700826 16580594 16486370 average_num_operations_total=16547177 stdev_num_operations_total=22093 sum_num_operations_total=794264538 min_num_operations_total=16021890 max_num_operations_total=16795571 first_time_thread_terminate_by_thread=10000142 10000142 10000142 10000143 10000142 10000142 10000142 10000143 10000142 10000142 10000142 10000142 10000142 10000142 10000142 10000142 10000142 10000143 10000142 10000142 10000142 10000143 10000142 10000142 10000142 10000142 10000142 10000143 10000142 10000142 10000142 10000143 10000142 10000142 10000142 10000142 10000142 10000142 10000142 10000142 10000142 10000143 10000142 10000142 10000142 10000143 10000142 10000142 min_time_thread_terminate_total=10000142 max_time_thread_terminate_total=10000143 first_time_thread_start_by_thread=4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 min_time_thread_start_total=4 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=9980800332 threads_final_size=99743 final_keysum=9980800332 final_size=99743 validate_result=success Validation OK. Structural validation OK. total_find=714833728 total_rq=0 total_inserts=39713861 total_deletes=39716949 total_updates=79430810 total_queries=714833728 total_ops=794264538 find_throughput=71483372 rq_throughput=0 update_throughput=7943081 query_throughput=71483372 total_throughput=79426453 total find : 714833728 total rq : 0 total inserts : 39713861 total deletes : 39716949 total updates : 79430810 total queries : 714833728 total ops : 794264538 find throughput : 71483372 rq throughput : 0 update throughput : 7943081 query throughput : 71483372 total throughput : 79426453 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=6.51365 PAPI_L3_TCM=0.000173365 PAPI_TOT_CYC=1645.63 PAPI_TOT_INS=1158.62 garbage=35729215831492 total_execution_walltime=11.421s REALTIME_MAIN_END_PERF_FORMAT=6986492.583453580 [time_cmd_output] time_elapsed_sec=11.53, faults_major=0, faults_minor=78430, mem_maxresident_kb=312440, user_cputime=558.24, sys_cputime=2.15, 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