__step=000890 __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_avl_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 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000890.txt __path_data=data/data000890.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x564d0c5ac400 addrof(kcasDescriptors[1])=0x564d0c5acd00 addrof(rdcssDescriptors[0])=0x564d0c6cc400 addrof(rdcssDescriptors[1])=0x564d0c6cc4c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6989686.946299567 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=50 DEL_FRAC=50 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=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.004s prefilling_size=1000893 prefilling_elapsed_millis=1.001s finished prefilling to size 1000938 for expected size 1000000 keysum=1000990692007, performing 28562247 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=1000938 pref_millis=1102 prefill_elapsed_ms=1118 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6989688.239082029 REALTIME_END_PERF_FORMAT=6989698.239240326 ############################################################################### ################################## 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.031s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65347 122941 168734 118025 31284 2020 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 178 6947 63803 167309 144756 39952 2489 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65525 129888 232537 285334 176040 41972 2489 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65525 129888 232537 285334 176040 41972 2489 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99966 1.98498 1.84377 1.50143 1.20332 1.06071 1.01117 1 tree_stats_height=23 tree_stats_numInternals=573886 tree_stats_numLeaves=425434 tree_stats_numNodes=999320 tree_stats_numKeys=999320 tree_stats_avgDegreeInternal=1.74132 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.42572 tree_stats_avgKeyDepth=18.2504 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:0 16:2 32:253 64:465769 128:13880 (2^04, 2^05]: 2 (2^05, 2^06]: 253 (2^06, 2^07]: 465769 (2^07, 2^08]: 13880 sum_limbo_reclamation_event_size_total=52729464 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=611568 first_thread_announced_epoch_by_thread=28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 sum_num_inserts_by_thread=2781194 2794225 2816761 2812322 2811402 2786918 2788268 2804051 2820428 2828676 2810736 2791173 2801899 2798157 2806030 2812647 2805761 2793077 2791346 2799411 2814171 2813162 2784707 2784353 2790963 2798202 2817411 2816978 2800021 2774696 2788740 2771966 2815975 2815404 2796774 2778650 2777980 2802406 2803422 2820876 2803452 2792811 2774694 2787287 2805213 2817630 2803118 2784822 sum_num_inserts_total=134390366 sum_num_deletes_by_thread=2780583 2791950 2817530 2813988 2809769 2790335 2789413 2805187 2815818 2832402 2808301 2793641 2798843 2799661 2809438 2812826 2810744 2794562 2788510 2801773 2810080 2811211 2784786 2783307 2794297 2800192 2815830 2818043 2799795 2776730 2790477 2766856 2811836 2819714 2796944 2778273 2783035 2799779 2804333 2815910 2804305 2796212 2781481 2792677 2805572 2813251 2799567 2783877 sum_num_deletes_total=134403644 sum_num_searches_by_thread= sum_num_searches_total= sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=5561777 5586175 5634291 5626310 5621171 5577253 5577681 5609238 5636246 5661078 5619037 5584814 5600742 5597818 5615468 5625473 5616505 5587639 5579856 5601184 5624251 5624373 5569493 5567660 5585260 5598394 5633241 5635021 5599816 5551426 5579217 5538822 5627811 5635118 5593718 5556923 5561015 5602185 5607755 5636786 5607757 5589023 5556175 5579964 5610785 5630881 5602685 5568699 average_num_operations_total=5599875 stdev_num_operations_total=4041 sum_num_operations_total=268794010 min_num_operations_total=5538822 max_num_operations_total=5661078 first_time_thread_terminate_by_thread=10000158 10000157 10000158 10000158 10000158 10000160 10000158 10000158 10000161 10000157 10000157 10000158 10000157 10000158 10000157 10000158 10000157 10000158 10000157 10000159 10000158 10000160 10000158 10000157 10000158 10000157 10000159 10000158 10000158 10000158 10000158 10000159 10000161 10000157 10000157 10000158 10000157 10000158 10000158 10000158 10000158 10000158 10000157 10000159 10000158 10000157 10000157 10000157 min_time_thread_terminate_total=10000157 max_time_thread_terminate_total=10000161 first_time_thread_start_by_thread=5 5 5 5 5 5 5 5 6 6 5 5 5 5 6 5 5 5 5 5 5 6 5 5 5 5 5 5 5 5 5 5 6 6 5 5 5 5 6 5 5 5 5 5 5 6 5 5 min_time_thread_start_total=5 max_time_thread_start_total=6 sum_duration_all_ops_total= threads_final_keysum=999367124096 threads_final_size=999320 final_keysum=999367124096 final_size=999320 validate_result=success Validation OK. Structural validation OK. total_find=0 total_rq=0 total_inserts=134390366 total_deletes=134403644 total_updates=268794010 total_queries=0 total_ops=268794010 find_throughput=0 rq_throughput=0 update_throughput=26879401 query_throughput=0 total_throughput=26879401 total find : 0 total rq : 0 total inserts : 134390366 total deletes : 134403644 total updates : 268794010 total queries : 0 total ops : 268794010 find throughput : 0 rq throughput : 0 update throughput : 26879401 query throughput : 0 total throughput : 26879401 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=16.6686 PAPI_L3_TCM=3.07986 PAPI_TOT_CYC=4833.83 PAPI_TOT_INS=2981.48 garbage=0 total_execution_walltime=11.444s REALTIME_MAIN_END_PERF_FORMAT=6989698.391899994 [time_cmd_output] time_elapsed_sec=11.57, faults_major=0, faults_minor=91758, mem_maxresident_kb=368692, user_cputime=561.02, sys_cputime=3.05, percent_cpu=4874% 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=2