diff options
author | initial.commit <initial.commit@0039d316-1c4b-4281-b951-d872f2087c98> | 2008-07-26 23:55:29 +0000 |
---|---|---|
committer | initial.commit <initial.commit@0039d316-1c4b-4281-b951-d872f2087c98> | 2008-07-26 23:55:29 +0000 |
commit | 09911bf300f1a419907a9412154760efd0b7abc3 (patch) | |
tree | f131325fb4e2ad12c6d3504ab75b16dd92facfed /chrome/common/ipc_logging.cc | |
parent | 586acc5fe142f498261f52c66862fa417c3d52d2 (diff) | |
download | chromium_src-09911bf300f1a419907a9412154760efd0b7abc3.zip chromium_src-09911bf300f1a419907a9412154760efd0b7abc3.tar.gz chromium_src-09911bf300f1a419907a9412154760efd0b7abc3.tar.bz2 |
Add chrome to the repository.
git-svn-id: svn://svn.chromium.org/chrome/trunk/src@15 0039d316-1c4b-4281-b951-d872f2087c98
Diffstat (limited to 'chrome/common/ipc_logging.cc')
-rw-r--r-- | chrome/common/ipc_logging.cc | 296 |
1 files changed, 296 insertions, 0 deletions
diff --git a/chrome/common/ipc_logging.cc b/chrome/common/ipc_logging.cc new file mode 100644 index 0000000..34c9274 --- /dev/null +++ b/chrome/common/ipc_logging.cc @@ -0,0 +1,296 @@ +// Copyright 2008, Google Inc. +// All rights reserved. +// +// Redistribution and use in source and binary forms, with or without +// modification, are permitted provided that the following conditions are +// met: +// +// * Redistributions of source code must retain the above copyright +// notice, this list of conditions and the following disclaimer. +// * Redistributions in binary form must reproduce the above +// copyright notice, this list of conditions and the following disclaimer +// in the documentation and/or other materials provided with the +// distribution. +// * Neither the name of Google Inc. nor the names of its +// contributors may be used to endorse or promote products derived from +// this software without specific prior written permission. +// +// THIS SOFTWARE IS PROVIDED BY THE COPYRIGHT HOLDERS AND CONTRIBUTORS +// "AS IS" AND ANY EXPRESS OR IMPLIED WARRANTIES, INCLUDING, BUT NOT +// LIMITED TO, THE IMPLIED WARRANTIES OF MERCHANTABILITY AND FITNESS FOR +// A PARTICULAR PURPOSE ARE DISCLAIMED. IN NO EVENT SHALL THE COPYRIGHT +// OWNER OR CONTRIBUTORS BE LIABLE FOR ANY DIRECT, INDIRECT, INCIDENTAL, +// SPECIAL, EXEMPLARY, OR CONSEQUENTIAL DAMAGES (INCLUDING, BUT NOT +// LIMITED TO, PROCUREMENT OF SUBSTITUTE GOODS OR SERVICES; LOSS OF USE, +// DATA, OR PROFITS; OR BUSINESS INTERRUPTION) HOWEVER CAUSED AND ON ANY +// THEORY OF LIABILITY, WHETHER IN CONTRACT, STRICT LIABILITY, OR TORT +// (INCLUDING NEGLIGENCE OR OTHERWISE) ARISING IN ANY WAY OUT OF THE USE +// OF THIS SOFTWARE, EVEN IF ADVISED OF THE POSSIBILITY OF SUCH DAMAGE. + +#include <windows.h> + +#include "chrome/common/ipc_logging.h" + +#include "base/command_line.h" +#include "base/logging.h" +#include "base/string_util.h" +#include "base/thread.h" +#include "base/time.h" +#include "chrome/common/chrome_switches.h" +#include "chrome/common/ipc_sync_message.h" +#include "chrome/common/render_messages.h" +#include "chrome/common/plugin_messages.h" + +#ifdef IPC_MESSAGE_LOG_ENABLED + +namespace IPC { + +const wchar_t kLoggingEventName[] = L"ChromeIPCLog.%d"; +const int kLogSendDelayMs = 100; + +scoped_refptr<Logging> Logging::current_; + +Lock Logging::logger_lock_; + +Logging::Logging() + : logging_event_on_(NULL), + logging_event_off_(NULL), + enabled_(false), + sender_(NULL), + consumer_(NULL), + queue_invoke_later_pending_(false), + main_thread_(MessageLoop::current()) { + // Create an event for this browser instance that's set when logging is + // enabled, so child processes can know when logging is enabled. + int browser_pid; + + CommandLine parsed_command_line; + std::wstring process_type = + parsed_command_line.GetSwitchValue(switches::kProcessType); + if (process_type.empty()) { + browser_pid = GetCurrentProcessId(); + } else { + std::wstring channel_name = + parsed_command_line.GetSwitchValue(switches::kProcessChannelID); + + browser_pid = _wtoi(channel_name.c_str()); + DCHECK(browser_pid != 0); + } + + std::wstring event_name = GetEventName(browser_pid, true); + logging_event_on_ = CreateEvent(NULL, TRUE, FALSE, event_name.c_str()); + + event_name = GetEventName(browser_pid, false); + logging_event_off_ = CreateEvent(NULL, TRUE, FALSE, event_name.c_str()); + + RegisterWaitForEvent(true); +} + +Logging::~Logging() { + CloseHandle(logging_event_on_); + CloseHandle(logging_event_off_); +} + +Logging* Logging::current() { + AutoLock lock(logger_lock_); + + if (!current_.get()) + current_ = new Logging(); + + return current_; +} + +void Logging::RegisterWaitForEvent(bool enabled) { + MessageLoop::current()->WatchObject( + enabled ? logging_event_off_ : logging_event_on_, NULL); + + MessageLoop::current()->WatchObject( + enabled ? logging_event_on_ : logging_event_off_, this); +} + +void Logging::OnObjectSignaled(HANDLE object) { + enabled_ = object == logging_event_on_; + RegisterWaitForEvent(!enabled_); +} + +std::wstring Logging::GetEventName(bool enabled) { + return Logging::current()->GetEventName(GetCurrentProcessId(), enabled); +} + +std::wstring Logging::GetEventName(int browser_pid, bool enabled) { + std::wstring result = StringPrintf(kLoggingEventName, browser_pid); + result += enabled ? L"on" : L"off"; + return result; +} + +void Logging::SetConsumer(Consumer* consumer) { + consumer_ = consumer; +} + +void Logging::Enable() { + ResetEvent(logging_event_off_); + SetEvent(logging_event_on_); +} + +void Logging::Disable() { + ResetEvent(logging_event_on_); + SetEvent(logging_event_off_); +} + +inline bool Logging::Enabled() const { + return enabled_; +} + +void Logging::OnSendLogs() { + queue_invoke_later_pending_ = false; + if (!sender_) + return; + + Message* msg = new Message( + MSG_ROUTING_CONTROL, IPC_LOGGING_ID, Message::PRIORITY_NORMAL); + WriteParam(msg, queued_logs_); + queued_logs_.clear(); + sender_->Send(msg); +} + +void Logging::SetIPCSender(IPC::Message::Sender* sender) { + sender_ = sender; +} + +void Logging::OnReceivedLoggingMessage(const Message& message) { + std::vector<LogData> data; + void* iter = NULL; + if (!ReadParam(&message, &iter, &data)) + return; + + for (size_t i = 0; i < data.size(); ++i) { + Log(data[i]); + } +} + +void Logging::OnSendMessage(Message* message, const std::wstring& channel_id) { + if (!Enabled()) + return; + + if (message->is_reply()) { + LogData* data = message->sync_log_data(); + if (!data) + return; + + // This is actually the delayed reply to a sync message. Create a string + // of the output parameters, add it to the LogData that was earlier stashed + // with the reply, and log the result. + data->channel = channel_id; + GenerateLogData(L"", *message, data); + Log(*data); + delete data; + message->set_sync_log_data(NULL); + } else { + // If the time has already been set (i.e. by ChannelProxy), keep that time + // instead as it's more accurate. + if (!message->sent_time()) + message->set_sent_time(Time::Now().ToInternalValue()); + } +} + +void Logging::OnPreDispatchMessage(const Message& message) { + message.set_received_time(Time::Now().ToInternalValue()); +} + +void Logging::OnPostDispatchMessage(const Message& message, + const std::wstring& channel_id) { + if (!Enabled() || !message.sent_time() || message.dont_log()) + return; + + LogData data; + GenerateLogData(channel_id, message, &data); + + if (MessageLoop::current() == main_thread_) { + Log(data); + } else { + main_thread_->PostTask(FROM_HERE, NewRunnableMethod( + this, &Logging::Log, data)); + } +} + +// static +LogFunction* g_log_function_mapping[16]; +void RegisterMessageLogger(int msg_start, LogFunction* func) { + int msg_class = msg_start >> 12; + if (msg_class > arraysize(g_log_function_mapping)) { + NOTREACHED(); + return; + } + + g_log_function_mapping[msg_class] = func; +} + +void Logging::GetMessageText(uint16 type, std::wstring* name, + const Message* message, + std::wstring* params) { + int message_class = type >> 12; + if (g_log_function_mapping[message_class] != NULL) { + g_log_function_mapping[message_class](type, name, message, params); + } else { + DLOG(INFO) << "No logger function associated with message class " << + message_class; + } +} + +void Logging::Log(const LogData& data) { + if (consumer_) { + // We're in the browser process. + consumer_->Log(data); + } else { + // We're in the renderer or plugin processes. + if (sender_) { + queued_logs_.push_back(data); + if (!queue_invoke_later_pending_) { + queue_invoke_later_pending_ = true; + MessageLoop::current()->PostDelayedTask(FROM_HERE, NewRunnableMethod( + this, &Logging::OnSendLogs), kLogSendDelayMs); + } + } + } +} + +void GenerateLogData(const std::wstring& channel, const Message& message, + LogData* data) { + if (message.is_reply()) { + // "data" should already be filled in. + std::wstring params; + Logging::GetMessageText(data->type, NULL, &message, ¶ms); + + if (!data->params.empty() && !params.empty()) + data->params += L", "; + + data->flags += L" DR"; + + data->params += params; + } else { + std::wstring flags; + if (message.is_sync()) + flags = L"S"; + + if (message.is_reply()) + flags += L"R"; + + if (message.is_reply_error()) + flags += L"E"; + + std::wstring params; + Logging::GetMessageText(message.type(), NULL, &message, ¶ms); + + data->channel = channel; + data->type = message.type(); + data->flags = flags; + data->sent = message.sent_time(); + data->receive = message.received_time(); + data->dispatch = Time::Now().ToInternalValue(); + data->params = params; + } +} + +} + +#endif // IPC_MESSAGE_LOG_ENABLED |