__step=000977 __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" ./brown_ext_chromatic_lf.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=data000977.txt __path_data=data/data000977.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6990705.953276093 binary=./brown_ext_chromatic_lf.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=brown_ext_chromatic_lf 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 descriptor=128 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=100077 prefilling_elapsed_millis=1.001s finished prefilling to size 100053 for expected size 100000 keysum=10007793089, performing 28588157 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=100053 pref_millis=1102 prefill_elapsed_ms=1131 4NodeIxPvE_object_size=56 4NodeIxPvE_allocated_count=0 4NodeIxPvE_allocated_size=0MB 4NodeIxPvE_get_from_pool=0 4NodeIxPvE_deallocated=0 4NodeIxPvE_limbo_count=0 4NodeIxPvE_limbo_details=0 0 0 global_epoch_counter=2128 9SCXRecordIxPvE_object_size=128 9SCXRecordIxPvE_allocated_count=0 9SCXRecordIxPvE_allocated_size=0MB 9SCXRecordIxPvE_get_from_pool=0 9SCXRecordIxPvE_deallocated=0 9SCXRecordIxPvE_limbo_count=0 9SCXRecordIxPvE_limbo_details=0 0 0 global_epoch_counter=0 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6990707.234187334 REALTIME_END_PERF_FORMAT=6990717.234326991 ############################################################################### ################################## TIME IS UP ################################# ############################################################################### joining threads... ############################################################################### ################################# END RUNNING ################################# ############################################################################### 10.1s 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.038s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2046 4055 7851 13982 20353 21823 16264 8108 2712 591 97 11 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 2 37 259 1720 7611 18883 27382 24420 13504 4833 1085 183 22 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4092 8110 15702 27964 40706 43646 32528 16216 5424 1182 194 22 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 2 37 259 1720 7611 18883 27382 24420 13504 4833 1085 183 22 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 1.99902 1.99096 1.96806 1.89046 1.72783 1.53611 1.37263 1.24926 1.16724 1.10896 1.08206 1.0567 1 tree_stats_height=24 tree_stats_numInternals=99940 tree_stats_numLeaves=99941 tree_stats_numNodes=199881 tree_stats_numKeys=99941 tree_stats_avgDegreeInternal=2.00001 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.5 tree_stats_avgKeyDepth=17.3083 tree_stats_bytesAtDepth=56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229152 454160 879312 1565984 2279536 2444176 1821568 908096 303744 66192 10864 1232 tree_stats_sizeInBytes=11193336 4NodeIxPvE_object_size=56 4NodeIxPvE_allocated_count=0 4NodeIxPvE_allocated_size=0MB 4NodeIxPvE_get_from_pool=0 4NodeIxPvE_deallocated=0 4NodeIxPvE_limbo_count=0 4NodeIxPvE_limbo_details=0 0 0 global_epoch_counter=22933 9SCXRecordIxPvE_object_size=128 9SCXRecordIxPvE_allocated_count=0 9SCXRecordIxPvE_allocated_size=0MB 9SCXRecordIxPvE_get_from_pool=0 9SCXRecordIxPvE_deallocated=0 9SCXRecordIxPvE_limbo_count=0 9SCXRecordIxPvE_limbo_details=0 0 0 global_epoch_counter=0 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:6680 2:5040 4:2766 8:5906 16:13604 32:33161 64:74512 128:185317 256:138585 512:867 [2^00, 2^01]: 6680 (2^01, 2^02]: 5040 (2^02, 2^03]: 2766 (2^03, 2^04]: 5906 (2^04, 2^05]: 13604 (2^05, 2^06]: 33161 (2^06, 2^07]: 74512 (2^07, 2^08]: 185317 (2^08, 2^09]: 138585 (2^09, 2^10]: 867 sum_limbo_reclamation_event_size_total=99866834 count_limbo_reclamation_event_size_by_thread=9730 9755 9733 9694 9647 9729 9675 9729 9709 9699 9714 9672 9723 9763 9704 9714 9713 9737 9711 9717 9710 9763 9691 9768 9708 9748 9758 9731 9670 9748 9699 9720 9716 9702 9745 9702 9725 9712 9693 9717 9708 9697 9713 9748 9705 9709 9696 9768 count_limbo_reclamation_event_size_total=466438 sum_limbo_reclamation_event_count_total=1997200 first_thread_announced_epoch_by_thread=45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 45866 sum_num_inserts_by_thread=2834830 2862007 2869335 2869634 2858432 2858787 2850609 2861505 2868538 2895750 2856677 2853314 2851489 2893658 2875591 2875761 2890737 2867114 2839632 2874084 2869657 2890652 2863975 2845392 2857825 2866093 2869970 2874495 2863457 2869617 2853736 2859764 2868378 2886021 2859174 2868912 2854980 2870653 2867260 2887875 2874051 2863307 2840880 2862582 2864747 2873680 2870264 2860963 sum_num_inserts_total=137565844 sum_num_deletes_by_thread=2836552 2862482 2868505 2871138 2855722 2857592 2849007 2864030 2865926 2893099 2856528 2855813 2854772 2895118 2880560 2879270 2890085 2867813 2844180 2870753 2870142 2890443 2862552 2847080 2860667 2868316 2869360 2875440 2862602 2865561 2859389 2857798 2869709 2888080 2857786 2870955 2856419 2872054 2867779 2886620 2877660 2864253 2840562 2864198 2864841 2872276 2865548 2864606 sum_num_deletes_total=137591641 sum_num_searches_by_thread= sum_num_searches_total= sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=5671382 5724489 5737840 5740772 5714154 5716379 5699616 5725535 5734464 5788849 5713205 5709127 5706261 5788776 5756151 5755031 5780822 5734927 5683812 5744837 5739799 5781095 5726527 5692472 5718492 5734409 5739330 5749935 5726059 5735178 5713125 5717562 5738087 5774101 5716960 5739867 5711399 5742707 5735039 5774495 5751711 5727560 5681442 5726780 5729588 5745956 5735812 5725569 average_num_operations_total=5732447 stdev_num_operations_total=3830 sum_num_operations_total=275157485 min_num_operations_total=5671382 max_num_operations_total=5788849 first_time_thread_terminate_by_thread=10000287 10000338 10000155 10000311 10000196 10000405 10000324 10000303 10000313 10000422 10000371 10000162 10000311 10000265 10000245 10000408 10000330 10000137 10000137 10000293 10000361 10000309 10000419 10000368 10000222 10000334 10000281 10000316 10000178 10000416 10000301 10000223 10000289 10000400 10000277 10000231 10000415 10000248 10000244 10000424 10000368 10000382 10000263 10000246 10000400 10000363 10000432 10000333 min_time_thread_terminate_total=10000137 max_time_thread_terminate_total=10000432 first_time_thread_start_by_thread=4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 4 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 min_time_thread_start_total=3 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=9998920243 threads_final_size=99941 final_keysum=9998920243 final_size=99941 validate_result=success Validation OK. Structural validation OK. total_find=0 total_rq=0 total_inserts=137565844 total_deletes=137591641 total_updates=275157485 total_queries=0 total_ops=275157485 find_throughput=0 rq_throughput=0 update_throughput=27515748 query_throughput=0 total_throughput=27515748 total find : 0 total rq : 0 total inserts : 137565844 total deletes : 137591641 total updates : 275157485 total queries : 0 total ops : 275157485 find throughput : 0 rq throughput : 0 update throughput : 27515748 query throughput : 0 total throughput : 27515748 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=30.9908 PAPI_L3_TCM=0.383821 PAPI_TOT_CYC=4789.38 PAPI_TOT_INS=1636.63 garbage=0 total_execution_walltime=11.528s REALTIME_MAIN_END_PERF_FORMAT=6990717.482514125 [time_cmd_output] time_elapsed_sec=11.63, faults_major=0, faults_minor=82696, mem_maxresident_kb=332312, user_cputime=555.30, sys_cputime=6.47, percent_cpu=4827% timeout=false algorithm=brown_ext_chromatic_lf.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=1