__step=000969 __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 50.0 50.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000969.txt __path_data=data/data000969.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x562a4f7b4400 addrof(kcasDescriptors[1])=0x562a4f7b4d00 addrof(rdcssDescriptors[0])=0x562a4f8d4400 addrof(rdcssDescriptors[1])=0x562a4f8d44c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6990612.440135268 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=50 DEL_FRAC=50 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=50.0 50.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=100194 prefilling_elapsed_millis=1.001s finished prefilling to size 100169 for expected size 100000 keysum=10015013027, performing 55841195 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=100169 pref_millis=1102 prefill_elapsed_ms=1122 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6990613.710686426 REALTIME_END_PERF_FORMAT=6990623.710814285 ############################################################################### ################################## 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 875 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.036s tree_stats_numInternalsAtDepth=1 2 4 7 14 27 50 89 157 268 467 791 1303 2058 3008 4040 5021 5789 6285 6389 6063 5502 4614 3834 3075 2333 1624 1067 589 310 171 86 49 24 8 0 tree_stats_numLeavesAtDepth=0 0 0 1 0 1 2 5 11 25 35 84 157 301 616 1072 1651 2271 2836 3314 3589 3544 3399 2840 2350 1998 1603 1107 797 426 228 136 69 37 19 10 tree_stats_numNodesAtDepth=1 2 4 8 14 28 52 94 168 293 502 875 1460 2359 3624 5112 6672 8060 9121 9703 9652 9046 8013 6674 5425 4331 3227 2174 1386 736 399 222 118 61 27 10 tree_stats_numKeysAtDepth=1 2 4 8 14 28 52 94 168 293 502 875 1460 2359 3624 5112 6672 8060 9121 9703 9652 9046 8013 6674 5425 4331 3227 2174 1386 736 399 222 118 61 27 10 tree_stats_avgDegreeAtDepth=2 2 2 1.875 2 1.89286 1.84615 1.84043 1.80952 1.79863 1.81275 1.76457 1.72329 1.66384 1.58057 1.51487 1.45549 1.4134 1.37474 1.33629 1.30906 1.27758 1.25708 1.23839 1.23152 1.20642 1.17044 1.14673 1.10606 1.12092 1.12782 1.14414 1.10169 1.04918 1.07407 1 tree_stats_height=36 tree_stats_numInternals=65119 tree_stats_numLeaves=34534 tree_stats_numNodes=99653 tree_stats_numKeys=99653 tree_stats_avgDegreeInternal=1.53032 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.34654 tree_stats_avgKeyDepth=19.7452 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:1 2:0 4:0 8:1 16:4 32:533 64:462344 128:17021 [2^00, 2^01]: 1 (2^01, 2^02]: 0 (2^02, 2^03]: 0 (2^03, 2^04]: 1 (2^04, 2^05]: 4 (2^05, 2^06]: 533 (2^06, 2^07]: 462344 (2^07, 2^08]: 17021 sum_limbo_reclamation_event_size_total=53314967 count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 count_limbo_reclamation_event_size_total=479904 sum_limbo_reclamation_event_count_total=1177248 first_thread_announced_epoch_by_thread=54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 54290 sum_num_inserts_by_thread=5378549 5458860 5388079 5238495 5481911 5439947 5431392 5450317 5451449 5516291 5430101 5475723 5459292 5429745 5522117 5512668 5511458 5460806 5386940 5392786 5509852 5533005 5460624 5370878 5370281 5370734 5420145 5508773 5484770 5446030 5384365 5414764 5542036 5512980 5437405 5463997 5461533 5451679 5407150 5516194 5442810 5476081 5454608 5467715 5509936 5545530 5487340 5434105 sum_num_inserts_total=261702246 sum_num_deletes_by_thread=5379558 5465441 5388002 5234921 5483525 5434752 5434127 5450015 5451846 5515285 5435633 5469319 5462061 5432988 5523533 5509969 5512634 5456521 5389210 5391570 5508474 5535240 5468804 5372206 5366420 5371939 5421705 5507106 5485641 5444585 5380206 5413303 5542404 5516734 5439188 5469379 5456177 5447531 5410553 5523999 5443410 5473708 5447223 5469266 5508477 5547505 5489067 5428739 sum_num_deletes_total=261709899 sum_num_searches_by_thread= sum_num_searches_total= sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=10758107 10924301 10776081 10473416 10965436 10874699 10865519 10900332 10903295 11031576 10865734 10945042 10921353 10862733 11045650 11022637 11024092 10917327 10776150 10784356 11018326 11068245 10929428 10743084 10736701 10742673 10841850 11015879 10970411 10890615 10764571 10828067 11084440 11029714 10876593 10933376 10917710 10899210 10817703 11040193 10886220 10949789 10901831 10936981 11018413 11093035 10976407 10862844 average_num_operations_total=10904419 stdev_num_operations_total=16923 sum_num_operations_total=523412145 min_num_operations_total=10473416 max_num_operations_total=11093035 first_time_thread_terminate_by_thread=10000127 10000127 10000127 10000127 10000127 10000127 10000127 10000126 10000127 10000126 10000127 10000127 10000126 10000127 10000127 10000127 10000127 10000127 10000127 10000127 10000126 10000126 10000127 10000126 10000127 10000127 10000127 10000126 10000127 10000127 10000127 10000126 10000126 10000127 10000127 10000127 10000126 10000127 10000127 10000127 10000127 10000127 10000128 10000127 10000126 10000126 10000127 10000127 min_time_thread_terminate_total=10000126 max_time_thread_terminate_total=10000128 first_time_thread_start_by_thread=3 3 3 3 3 3 3 2 3 3 3 3 3 2 3 2 3 2 3 3 3 2 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 2 3 2 3 2 3 3 3 2 3 3 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=9964974019 threads_final_size=99653 final_keysum=9964974019 final_size=99653 validate_result=success Validation OK. Structural validation OK. total_find=0 total_rq=0 total_inserts=261702246 total_deletes=261709899 total_updates=523412145 total_queries=0 total_ops=523412145 find_throughput=0 rq_throughput=0 update_throughput=52341214 query_throughput=0 total_throughput=52341214 total find : 0 total rq : 0 total inserts : 261702246 total deletes : 261709899 total updates : 523412145 total queries : 0 total ops : 523412145 find throughput : 0 rq throughput : 0 update throughput : 52341214 query throughput : 0 total throughput : 52341214 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=8.80665 PAPI_L3_TCM=0.000266299 PAPI_TOT_CYC=2413.2 PAPI_TOT_INS=1746.83 garbage=0 total_execution_walltime=11.416s REALTIME_MAIN_END_PERF_FORMAT=6990623.856627298 [time_cmd_output] time_elapsed_sec=11.53, faults_major=0, faults_minor=77464, mem_maxresident_kb=311816, user_cputime=560.53, sys_cputime=3.18, percent_cpu=4885% 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