Changeset 91532 in vbox

Timestamp:

Oct 4, 2021 6:12:29 AM (3 years ago)

Author:

vboxsync

Message:

Audio/Validation Kit: Logging tweaks. ​bugref:10008

Location:

trunk/src/VBox

Files:

• Devices/Audio/DrvHostAudioValidationKit.cpp (modified) (4 diffs)
• ValidationKit/utils/audio/vkatCommon.cpp (modified) (1 diff)

trunk/src/VBox/Devices/Audio/DrvHostAudioValidationKit.cpp

@@ -860 +860 @@
     bool const fIsSilence = PDMAudioPropsIsBufferSilence(&pStream->pStream->Cfg.Props, pvBuf, cbBuf);
 
-    LogRel2(("ValKit: Playing stream '%s' ...\n", pStream->pStream->Cfg.szName));
+    LogRel2(("ValKit: Playing stream '%s' (%RU32 bytes / %RU64ms -- %RU64 bytes / %RU64ms total so far) ...\n",
+             pStream->pStream->Cfg.szName,
+             cbBuf, PDMAudioPropsBytesToMilli(&pStream->pStream->Cfg.Props, cbBuf),
+             pThis->cbPlayedTotal, PDMAudioPropsBytesToMilli(&pStream->pStream->Cfg.Props, pThis->cbPlayedTotal)));
 
     int rc = RTCritSectEnter(&pThis->CritSect);
@@ -882 +885 @@
     if (pTst == NULL) /* Empty list? */
     {
-        LogRel2(("ValKit: Warning: Guest is playing back audio (%RU32 bytes, %RU64ms) when no playback test is active\n",
-                 cbBuf, PDMAudioPropsBytesToMilli(&pStream->pStream->Cfg.Props, cbBuf)));
+        LogRel2(("ValKit: Warning: Guest is playing back audio when no playback test is active\n"));
 
         pThis->cbPlayedNoTest += cbBuf;
@@ -1012 +1014 @@
     PVALKITTESTDATA     pTst        = NULL;
 
-    LogRel2(("ValKit: Capturing stream '%s' ...\n", pStream->pStream->Cfg.szName));
+    LogRel2(("ValKit: Capturing stream '%s' (%RU32 bytes / %RU64ms -- %RU64 bytes / %RU64ms total so far) ...\n",
+             pStream->pStream->Cfg.szName,
+             cbBuf, PDMAudioPropsBytesToMilli(&pStream->pStream->Cfg.Props, cbBuf),
+             pThis->cbRecordedTotal, PDMAudioPropsBytesToMilli(&pStream->pStream->Cfg.Props, pThis->cbRecordedTotal)));
 
     int rc = RTCritSectEnter(&pThis->CritSect);
@@ -1034 +1039 @@
     if (pTst == NULL) /* Empty list? */
     {
-        LogRel(("ValKit: Warning: Guest is trying to record %RU32 bytes (%RU32ms) of audio data when no recording test is active (%RU32 bytes available)\n",
-                cbBuf, PDMAudioPropsBytesToMilli(&pStream->pStream->Cfg.Props, cbBuf), pStrmValKit->cbAvail));
+        LogRel(("ValKit: Warning: Guest is trying to record audio data when no recording test is active (%RU32 bytes available)\n",
+                pStrmValKit->cbAvail));
 
         /** @todo Not sure yet why this happens after all data has been captured sometimes,

trunk/src/VBox/ValidationKit/utils/audio/vkatCommon.cpp

@@ -274 +274 @@
         uint32_t       cbBeaconPlayed = 0;
 
-        RTTestPrintf(g_hTest, RTTESTLVL_DEBUG, "Playing %RU32 bytes total\n", cbToPlayTotal);
+        RTTestPrintf(g_hTest, RTTESTLVL_ALWAYS, "Playing %RU32 bytes total\n", cbToPlayTotal);
         if (cbBeaconToPlay)
         {
-            RTTestPrintf(g_hTest, RTTESTLVL_DEBUG, "Playing 2 x %RU32 bytes pre/post beacons\n", cbBeaconToPlay);
+            RTTestPrintf(g_hTest, RTTESTLVL_ALWAYS, "Playing 2 x %RU32 bytes pre/post beacons\n", cbBeaconToPlay);
             cbToPlayTotal += cbBeacon * 2 /* Pre + post beacon */;
         }