मेन्यू खोलने के लिए विंडोज एक सौ हजार बार फाइल क्यों पढ़ता है?

"एक्सप्लोरर टास्कबार के संदर्भ मेनू को खोलने के लिए 700 एमएस खर्च करता है। इस समय का 75%, यह एक फ़ाइल से 114,801 रीड ऑपरेशन करता है, रीड डेटा की औसत मात्रा 68 बाइट्स है।

क्या मुझे इस बारे में पोस्ट लिखनी चाहिए, या व्यंग्यात्मक ट्वीट? "

मैं एक कंप्यूटर पर जल्दी से काम करता हूं, और इसलिए यह मुझे परेशान करता है जब मुझे एक ऑपरेशन के पूरा होने का इंतजार करना पड़ता है, जिसे तुरंत प्रदर्शन किया जाना चाहिए। मेरे भारी शुल्क होम लैपटॉप पर एक निरंतर बाधा टास्कबार पर खिड़कियों की धीमी गति से बंद होना था। मैं आइकन पर राइट-क्लिक करता हूं, मेनू के खुलने का इंतजार करता हूं और फिर "क्लोज विंडो" का चयन करता हूं। इस प्रक्रिया में सबसे धीमा माउस मूवमेंट होना चाहिए, लेकिन यह पता चलता है कि मेनू प्रदर्शित होने से पहले सबसे लंबा घटक देरी है।

इसने मुझे लंबे समय तक परेशान किया, लेकिन मैंने अदम्य आत्म-नियंत्रण दिखाया और खुद को जलन से बचाए रखा। यह आज तक था, जब मैंने आखिरकार ETW ट्रैसर को तोड़ दिया और पकड़ लिया।

इस पोस्ट को स्पीड ब्लॉगिंग के लिए एक चेक के रूप में लिखा गया है। इस समस्या को पाए जाने के लगभग 90 मिनट बीत गए और पोस्ट प्रकाशित होने तक इसके बारे में व्यंग्यात्मक ट्वीट किया।

ETW ट्रेसर ने तय किया कि कैसे मैं टास्कबार पर राइट-क्लिक करें और दो एक्सप्लोरर विंडो बंद करें। मैंने डिफ़ॉल्ट विकल्पों के साथ फ़ंक्शन करने के लिए UIforETW ट्रेसिंग का उपयोग किया, जिसके परिणामस्वरूप 20.9 एमबी का निदान लॉग हुआ ।

कभी-कभी ट्रेस का विश्लेषण करने में सबसे कठिन हिस्सा समस्या का स्थान ढूंढ रहा है, लेकिन इस मामले में विश्लेषण का यह हिस्सा तुच्छ है। तीन असंदिग्ध संकेत सही जगह का संकेत देते थे, और अपराध के स्पष्ट रूप से स्पष्ट अपराधी।

पहला संकेत इनपुट इवेंट था। UIforETW में एक एकीकृत इनपुट लकड़हारा होता है (यह अज्ञात रूप से पर्याप्त है ताकि मैं गलती से पासवर्ड या व्यक्तिगत जानकारी चोरी न करूँ), इसलिए मुझे सिर्फ माउस माउस और बटन प्रकार की घटनाओं का सही माउस बटन के अनुरूप 2 के मूल्य के साथ अध्ययन करना था। उसी समय, WPA समयरेखा पर निशान तब दिखाई देते हैं जब ये घटनाएँ होती हैं - स्क्रीनशॉट में लंबवत रेखाएँ देखें:


इससे मुझे यह स्पष्ट हो गया कि जब मैं सही माउस बटन छोड़ता हूं, तो 600 एमएस के बाद विंडो फ़ोकस में बदलाव होता है, जो कि मेरी राय में, उस क्षण से मेल खाता है जो मेनू प्रदर्शित होता है। इसके अलावा, RuntimeBroker.exe में माउस बटन को जारी करने और विंडो के फोकस को बदलने की घटनाओं के बीच सीपीयू गतिविधि का एक स्पष्ट ब्लॉक है।

यह साबित नहीं हुआ है कि विंडो फ़ोकस और सीपीयू गतिविधि में परिवर्तन संबंधित हैं, लेकिन स्क्रीन रिकॉर्डिंग एप्लिकेशन का उपयोग करके माप लेने के बाद, मैंने देखा कि मेनू को प्रदर्शित करने में लगभग 660 एमएस लगते हैं, इसलिए मुझे इस पर भरोसा है।

अगला चरण यह सीखना है कि RuntimeBroker.exe क्या कर रहा है। हालांकि CPU उपयोग (सटीक) यह देखने का एक बहुत अच्छा काम करता है कि CPU समय कितनी प्रक्रिया का उपयोग करता है और यह निष्क्रिय क्यों है, CPU उपयोग (नमूना) तालिका यह पता लगाने के लिए एक अच्छा उपकरण है कि CPU समय क्या बर्बाद कर रहा है । मैंने ध्यान से इसका अध्ययन किया और जल्दी से पाया कि 264 नमूने कर्नेलबेसडेल से थे ! ReadFile :


थोड़ा और खोज करने के बाद, मुझे अन्य कॉल स्टैक्स मिले जो इस फ़ंक्शन को भी प्रभावित करते थे, इसलिए मैंने इसे राइट-क्लिक किया और व्यू कॉलर-> बाय फंक्शन को चुना । जिस मोड को चालू किया गया था (उल्टे ढेर के साथ) से पता चला कि इस प्रक्रिया के 899 नमूनों में से 628 नमूने, या 70%, अलग-अलग कॉल स्टैक से, इस फ़ंक्शन से गुजरे हैं:


इस धारा में 271 नमूने फ़ंक्शन से नहीं गुजरे, और शेष नमूने (नहीं दिखाए गए) अन्य धाराओं में थे।

ध्यान दें कि 10 252 की धारा में 899 नमूने दो माउस क्लिक का प्रतिनिधित्व करते हैं, यानी लगभग 450 नमूने या 450 एमएस (1 kHz की मानक नमूना आवृत्ति पर) प्रति माउस क्लिक।

कभी-कभी फ़ाइल I / O CPU समय होता है

सीपीयू उपयोग (नमूना) सीपीयू समय दिखाता है, इसलिए डिस्क I / O आमतौर पर यहां प्रदर्शित नहीं होता है, क्योंकि इन क्षणों में धारा सो जाती है और डिस्क का इंतजार करती है। तथ्य यह है कि I / O संचालन को CPU समय के रूप में प्रदर्शित किया जाता है इसका मतलब है कि सभी रीड सिस्टम कैश पर गिर गए और CPU समय कैश से डेटा प्राप्त करने पर खर्च किए गए अतिरिक्त कर्नेल संसाधन (पहले नमूना कॉल स्टैक में ntoskrnl.exe देखें)।

अब वह फाइल I / O संदेह के घेरे में आ गई है, हमें ग्राफ एक्सप्लोरर-> स्टोरेज-> फाइल I / O पर जाने की जरूरत है। कॉलम की उपस्थिति को थोड़ा समायोजित करने के बाद, हमें निम्नलिखित प्रभावशाली परिणाम मिले:


, 10 252 RuntimeBroker.exe 229 604 ReadFile, 15 686 586 . 68 .

.

, — . , RuntimeBroker.exe . 4 027 904 , , , 1,9 .

, . , ( ):

%appdata%\Microsoft\Windows\Recent\AutomaticDestinations\f01b4d95cf55d32a.automaticDestinations-ms

WPA. — , . :


« „“, ( ) ( ) „“/ . , ». , !

, . , , , .

• ReadFile, 68 . , , . , 4 , .
• , - , — .
• , - , . , ETW !
• https://aka.ms/AA60dfg
• , UIforETW ,
• , ( , ), shift+ . , .
• Hacker news
• Reddit
• Twitter