[Chromecast] Move audio logging from PushFrame to Start.

chromecast/media/audio/cast_audio_output_stream.cc

 // Copyright 2015 The Chromium Authors. All rights reserved.
 // Use of this source code is governed by a BSD-style license that can be
 // found in the LICENSE file.
 
 #include "chromecast/media/audio/cast_audio_output_stream.h"
 
 #include "base/bind.h"
 #include "base/thread_task_runner_handle.h"
 #include "chromecast/base/metrics/cast_metrics_helper.h"
 #include "chromecast/media/audio/cast_audio_manager.h"
@@ skipping 134 matching lines @@
   AudioPipelineDevice* audio_device = media_pipeline_backend_->GetAudio();
   DCHECK(audio_device);
   if (!audio_device->SetState(AudioPipelineDevice::kStateRunning)) {
     LOG(WARNING) << "Failed to run audio device.";
     return;
   }
 
   VLOG(1) << __FUNCTION__ << " : " << this;
   audio_worker_->Start(base::Bind(&CastAudioOutputStream::PushFrame,
                                   weak_factory_.GetWeakPtr(), source_callback));
+
+  metrics::CastMetricsHelper::GetInstance()->LogTimeToFirstAudio();
 }
 
 void CastAudioOutputStream::Stop() {
   VLOG(1) << __FUNCTION__ << " : " << this;
 
   MediaClockDevice* clock_device = media_pipeline_backend_->GetClock();
   DCHECK(clock_device);
   clock_device->SetState(MediaClockDevice::kStateIdle);
   clock_device->SetRate(0.0f);
 
@@ skipping 17 matching lines @@
 
 void CastAudioOutputStream::PushFrame(AudioSourceCallback* source_callback) {
   DCHECK(source_callback);
   if (audio_device_busy_) {
     // Skip pulling data if audio device is still busy.
     LOG(WARNING) << __FUNCTION__ << " : " << this
                  << " skipped because audio device is busy.";
     return;
   }
 
-  metrics::CastMetricsHelper::GetInstance()->LogTimeToFirstAudio();
-
   int frame_count = source_callback->OnMoreData(audio_bus_.get(), 0);
   DCHECK_EQ(frame_count, audio_bus_->frames());
   int buffer_size = frame_count * audio_params_.GetBytesPerFrame();
   scoped_refptr<::media::DecoderBuffer> decoder_buffer(
       new ::media::DecoderBuffer(buffer_size));
   audio_bus_->ToInterleaved(frame_count, audio_params_.bits_per_sample() / 8,
                             decoder_buffer->writable_data());
 
   AudioPipelineDevice* audio_device = media_pipeline_backend_->GetAudio();
   DCHECK(audio_device);
@@ skipping 31 matching lines @@
 void CastAudioOutputStream::OnPushFrameError(
     AudioSourceCallback* source_callback) {
   LOG(WARNING) << __FUNCTION__ << " : " << this;
   // Inform audio source about the error and stop pulling data.
   audio_worker_->Stop();
   source_callback->OnError(this);
 }
 
 }  // namespace media
 }  // namespace chromecast