Cast: Log audio received events for audio

media/cast/audio_sender/audio_sender.cc

 // Copyright 2013 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 "media/cast/audio_sender/audio_sender.h"
 
 #include "base/bind.h"
 #include "base/logging.h"
 #include "base/message_loop/message_loop.h"
 #include "media/cast/audio_sender/audio_encoder.h"
@@ skipping 37 matching lines @@
   }
 
   media::cast::transport::CastTransportAudioConfig transport_config;
   transport_config.codec = audio_config.codec;
   transport_config.rtp.config = audio_config.rtp_config;
   transport_config.frequency = audio_config.frequency;
   transport_config.channels = audio_config.channels;
   transport_config.rtp.max_outstanding_frames =
       audio_config.rtp_config.max_delay_ms / 100 + 1;
   transport_sender_->InitializeAudio(transport_config);
+
+  memset(frame_id_to_rtp_timestamp_, 0, sizeof(frame_id_to_rtp_timestamp_));
 }
 
 AudioSender::~AudioSender() {}
 
 void AudioSender::InsertAudio(scoped_ptr<AudioBus> audio_bus,
                               const base::TimeTicks& recorded_time) {
   DCHECK(cast_environment_->CurrentlyOn(CastEnvironment::MAIN));
   DCHECK(audio_encoder_.get()) << "Invalid internal state";
   audio_encoder_->InsertAudio(audio_bus.Pass(), recorded_time);
 }
@@ skipping 13 matching lines @@
   if (num_aggressive_rtcp_reports_sent_ < kNumAggressiveReportsSentAtStart) {
     // SendRtcpReport() will schedule future reports to be made if this is the
     // last "aggressive report."
     ++num_aggressive_rtcp_reports_sent_;
     const bool is_last_aggressive_report =
         (num_aggressive_rtcp_reports_sent_ == kNumAggressiveReportsSentAtStart);
     VLOG_IF(1, is_last_aggressive_report) << "Sending last aggressive report.";
     SendRtcpReport(is_last_aggressive_report);
   }
 
+  frame_id_to_rtp_timestamp_[audio_frame->frame_id & 0xff] =
+      audio_frame->rtp_timestamp;
   transport_sender_->InsertCodedAudioFrame(*audio_frame);
 }
 
 void AudioSender::ResendPackets(
     const MissingFramesAndPacketsMap& missing_frames_and_packets) {
   DCHECK(cast_environment_->CurrentlyOn(CastEnvironment::MAIN));
   transport_sender_->ResendPackets(true, missing_frames_and_packets);
 }
 
 void AudioSender::IncomingRtcpPacket(scoped_ptr<Packet> packet) {
@@ skipping 44 matching lines @@
       VLOG(1) << "No longer a need to send reports aggressively (sent "
               << num_aggressive_rtcp_reports_sent_ << ").";
       num_aggressive_rtcp_reports_sent_ = kNumAggressiveReportsSentAtStart;
       ScheduleNextRtcpReport();
     }
   }
 
   if (!cast_feedback.missing_frames_and_packets_.empty()) {
     ResendPackets(cast_feedback.missing_frames_and_packets_);
   }
-  VLOG(2) << "Received audio ACK "
-          << static_cast<int>(cast_feedback.ack_frame_id_);
+  uint32 acked_frame_id = static_cast<uint32>(cast_feedback.ack_frame_id_);
+  VLOG(2) << "Received audio ACK: " << acked_frame_id;
+  cast_environment_->Logging()->InsertFrameEvent(
+        cast_environment_->Clock()->NowTicks(),
+        FRAME_ACK_RECEIVED, AUDIO_EVENT,
+        frame_id_to_rtp_timestamp_[acked_frame_id & 0xff], acked_frame_id);
 }
 
 }  // namespace cast
 }  // namespace media