Changeset 65606 in vbox for trunk/src/VBox/Devices/Audio/DrvHostValidationKit.cpp

Timestamp:

Feb 3, 2017 7:00:44 PM (8 years ago)

Author:

vboxsync

Message:

Audio/ValKit: Saving buffer submittions timings for each .wav file, bugref:7673

File:

• trunk/src/VBox/Devices/Audio/DrvHostValidationKit.cpp (modified) (7 diffs)

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

@@ -37 +37 @@
     /** Audio file to dump output to or read input from. */
     PDMAUDIOFILE       File;
+    /** Text file to store timing of audio buffers submittions**/
+    RTFILE             hFileTiming;
+    /** Timestamp of the first play or record request**/
+    uint64_t           tsStarted;
+    /** Total number of samples played or recorded so far**/
+    uint32_t           uSamplesSinceStarted;
     union
     {
@@ -152 +158 @@
     if (RT_SUCCESS(rc))
     {
+        pDbgStream->tsStarted                   = 0;
+        pDbgStream->uSamplesSinceStarted        = 0;
         pDbgStream->Out.tsLastPlayed            = 0;
-        pDbgStream->Out.cMaxSamplesInPlayBuffer = _1K;
+        pDbgStream->Out.cMaxSamplesInPlayBuffer = 16 * _1K;
         pDbgStream->Out.pu8PlayBuffer           = (uint8_t *)RTMemAlloc(pDbgStream->Out.cMaxSamplesInPlayBuffer << Props.cShift);
         if (!pDbgStream->Out.pu8PlayBuffer)
@@ -163 +171 @@
         char szTemp[RTPATH_MAX];
         rc = RTPathTemp(szTemp, sizeof(szTemp));
+
+        RTPathAppend(szTemp, sizeof(szTemp), "VBoxAudioValKit");
+
         if (RT_SUCCESS(rc))
         {
@@ -175 +186 @@
                 if (RT_FAILURE(rc))
                     LogRel(("DebugAudio: Creating output file '%s' failed with %Rrc\n", szFile, rc));
+
+                RTStrCat(szFile, sizeof(szFile), ".timing");
+                rc = RTFileOpen(&pDbgStream->hFileTiming, szFile, RTFILE_O_WRITE | RTFILE_O_DENY_WRITE | RTFILE_O_CREATE_REPLACE);
+                
+
+                if (RT_FAILURE(rc))
+                    LogRel(("DebugAudio: Creating output file '%s' failed with %Rrc\n", szFile, rc));
             }
             else
@@ -245 +263 @@
         cSamplesPlayed = cLive;*/
 
+    uint64_t tsSinceStart;
+    size_t cch;
+    char szTimingInfo[128];
+
+    if (pDbgStream->tsStarted == 0)
+    {
+        pDbgStream->tsStarted = RTTimeNanoTS();
+        tsSinceStart = 0;
+    }
+    else
+    {
+        tsSinceStart = RTTimeNanoTS() - pDbgStream->tsStarted;
+    }
+
+    uint32_t uSamplesReady = AudioMixBufUsed(&pStream->MixBuf);
+    cch = RTStrPrintf(szTimingInfo, sizeof(szTimingInfo), "%d %d %d %d\n", 
+        // Host time (in mcs) elapsed since Guest submitted the first buffer for playback
+        (uint32_t)(tsSinceStart / 1000),
+        // how long (in mcs) all the samples submitted previously were played
+        (uint32_t)(pDbgStream->uSamplesSinceStarted * 1.0E6 / pStream->Cfg.uHz),
+        // how long (in mcs) a new uSamplesReady samples should\will be played
+        (uint32_t)(uSamplesReady * 1.0E6 / pStream->Cfg.uHz),
+        uSamplesReady);
+    RTFileWrite(pDbgStream->hFileTiming, szTimingInfo, cch, NULL);
+    pDbgStream->uSamplesSinceStarted += uSamplesReady;
+
     uint32_t cSamplesPlayed = 0;
     uint32_t cSamplesAvail  = RT_MIN(AudioMixBufUsed(&pStream->MixBuf), pDbgStream->Out.cMaxSamplesInPlayBuffer);
+
     while (cSamplesAvail)
     {
@@ -327 +372 @@
 
     int rc = DrvAudioHlpWAVFileClose(&pDbgStream->File);
+
+    RTFileClose(pDbgStream->hFileTiming);
+
     if (RT_SUCCESS(rc))
     {
@@ -335 +383 @@
             && fDeleteEmptyFiles)
         {
-            rc = RTFileDelete(pDbgStream->File.szName);
+            char szFile[RTPATH_MAX];
+
+            RTStrCopy(szFile, sizeof(szFile), pDbgStream->File.szName);
+            rc = RTFileDelete(szFile);
+
+            RTStrCat(szFile, sizeof(szFile), ".timing");
+            rc = RTFileDelete(szFile);
         }
         else