log telemetry introspection init time

Author: planetchili

IntelPresentMon/AppCef/source/winmain.cpp

@@ -246,7 +246,8 @@ int APIENTRY WinMain(HINSTANCE hInstance, HINSTANCE hPrevInstance, LPSTR lpCmdLi
                 "--intro-nsm"s, *opt.shmName,
                 "--etw-session-name"s, *opt.etwSessionName,
                 "--log-level"s, std::to_string((int)log::GlobalPolicy::Get().GetLogLevel()),
-                "--log-pipe-name"s, *logSvcPipe);
+                "--log-pipe-name"s, *logSvcPipe,
+                "--enable-stdio-log");
 
             if (!pmon::util::win::WaitForNamedPipe(*opt.controlPipe, 1500)) {
                 pmlog_error("timeout waiting for child service control pipe to go online");

IntelPresentMon/PresentMonService/PMMainThread.cpp

@@ -94,14 +94,16 @@ void PowerTelemetryThreadEntry_(Service* const srv, PresentMon* const pm,
         if ((waitResult - WAIT_OBJECT_0) == 1) {
             return;
         }
+        pmon::util::QpcTimer timer;
         ptc->Repopulate();
         for (auto& adapter : ptc->GetPowerTelemetryAdapters()) {
-            // sample 2x here as workaround/kludge because Intel provider mispreports 1st sample
+            // sample 2x here as workaround/kludge because Intel provider misreports 1st sample
             adapter->Sample();
             adapter->Sample();
             pComms->RegisterGpuDevice(adapter->GetVendor(), adapter->GetName(), adapter->GetPowerTelemetryCapBits());
         }
         pComms->FinalizeGpuDevices();
+        pmlog_info(std::format("Finished populating GPU telemetry introspection, {} seconds elapsed", timer.Mark()));
     }
 
 	// only start periodic polling when streaming starts