OLD | NEW |
1 // Copyright (c) 2012 The Chromium Authors. All rights reserved. | 1 // Copyright (c) 2012 The Chromium Authors. All rights reserved. |
2 // Use of this source code is governed by a BSD-style license that can be | 2 // Use of this source code is governed by a BSD-style license that can be |
3 // found in the LICENSE file. | 3 // found in the LICENSE file. |
4 | 4 |
5 #include "build/build_config.h" | 5 #include "ipc/ipc_perftest_support.h" |
6 | 6 |
7 #include <algorithm> | 7 #include <algorithm> |
8 #include <string> | 8 #include <string> |
9 | 9 |
10 #include "base/basictypes.h" | 10 #include "base/basictypes.h" |
11 #include "base/logging.h" | 11 #include "base/logging.h" |
12 #include "base/memory/scoped_ptr.h" | 12 #include "base/memory/scoped_ptr.h" |
13 #include "base/pickle.h" | 13 #include "base/pickle.h" |
14 #include "base/strings/stringprintf.h" | 14 #include "base/strings/stringprintf.h" |
15 #include "base/test/perf_time_logger.h" | 15 #include "base/test/perf_time_logger.h" |
16 #include "base/test/test_io_thread.h" | 16 #include "base/test/test_io_thread.h" |
17 #include "base/threading/thread.h" | 17 #include "base/threading/thread.h" |
18 #include "base/time/time.h" | 18 #include "base/time/time.h" |
| 19 #include "build/build_config.h" |
19 #include "ipc/ipc_channel.h" | 20 #include "ipc/ipc_channel.h" |
20 #include "ipc/ipc_channel_proxy.h" | 21 #include "ipc/ipc_channel_proxy.h" |
21 #include "ipc/ipc_descriptors.h" | 22 #include "ipc/ipc_descriptors.h" |
22 #include "ipc/ipc_message_utils.h" | 23 #include "ipc/ipc_message_utils.h" |
23 #include "ipc/ipc_sender.h" | 24 #include "ipc/ipc_sender.h" |
24 #include "ipc/ipc_test_base.h" | |
25 | 25 |
26 namespace { | 26 namespace IPC { |
27 | 27 namespace test { |
28 // This test times the roundtrip IPC message cycle. | |
29 // | |
30 // TODO(brettw): Make this test run by default. | |
31 | |
32 class IPCChannelPerfTest : public IPCTestBase { | |
33 }; | |
34 | 28 |
35 // This class simply collects stats about abstract "events" (each of which has a | 29 // This class simply collects stats about abstract "events" (each of which has a |
36 // start time and an end time). | 30 // start time and an end time). |
37 class EventTimeTracker { | 31 class EventTimeTracker { |
38 public: | 32 public: |
39 explicit EventTimeTracker(const char* name) | 33 explicit EventTimeTracker(const char* name) |
40 : name_(name), | 34 : name_(name), |
41 count_(0) { | 35 count_(0) { |
42 } | 36 } |
43 | 37 |
(...skipping 28 matching lines...) Expand all Loading... |
72 uint64 count_; | 66 uint64 count_; |
73 base::TimeDelta total_duration_; | 67 base::TimeDelta total_duration_; |
74 base::TimeDelta max_duration_; | 68 base::TimeDelta max_duration_; |
75 | 69 |
76 DISALLOW_COPY_AND_ASSIGN(EventTimeTracker); | 70 DISALLOW_COPY_AND_ASSIGN(EventTimeTracker); |
77 }; | 71 }; |
78 | 72 |
79 // This channel listener just replies to all messages with the exact same | 73 // This channel listener just replies to all messages with the exact same |
80 // message. It assumes each message has one string parameter. When the string | 74 // message. It assumes each message has one string parameter. When the string |
81 // "quit" is sent, it will exit. | 75 // "quit" is sent, it will exit. |
82 class ChannelReflectorListener : public IPC::Listener { | 76 class ChannelReflectorListener : public Listener { |
83 public: | 77 public: |
84 ChannelReflectorListener() | 78 ChannelReflectorListener() |
85 : channel_(NULL), | 79 : channel_(NULL), |
86 latency_tracker_("Client messages") { | 80 latency_tracker_("Client messages") { |
87 VLOG(1) << "Client listener up"; | 81 VLOG(1) << "Client listener up"; |
88 } | 82 } |
89 | 83 |
90 virtual ~ChannelReflectorListener() { | 84 virtual ~ChannelReflectorListener() { |
91 VLOG(1) << "Client listener down"; | 85 VLOG(1) << "Client listener down"; |
92 latency_tracker_.ShowResults(); | 86 latency_tracker_.ShowResults(); |
93 } | 87 } |
94 | 88 |
95 void Init(IPC::Channel* channel) { | 89 void Init(Channel* channel) { |
96 DCHECK(!channel_); | 90 DCHECK(!channel_); |
97 channel_ = channel; | 91 channel_ = channel; |
98 } | 92 } |
99 | 93 |
100 virtual bool OnMessageReceived(const IPC::Message& message) OVERRIDE { | 94 virtual bool OnMessageReceived(const Message& message) OVERRIDE { |
101 CHECK(channel_); | 95 CHECK(channel_); |
102 | 96 |
103 PickleIterator iter(message); | 97 PickleIterator iter(message); |
104 int64 time_internal; | 98 int64 time_internal; |
105 EXPECT_TRUE(iter.ReadInt64(&time_internal)); | 99 EXPECT_TRUE(iter.ReadInt64(&time_internal)); |
106 int msgid; | 100 int msgid; |
107 EXPECT_TRUE(iter.ReadInt(&msgid)); | 101 EXPECT_TRUE(iter.ReadInt(&msgid)); |
108 std::string payload; | 102 std::string payload; |
109 EXPECT_TRUE(iter.ReadString(&payload)); | 103 EXPECT_TRUE(iter.ReadString(&payload)); |
110 | 104 |
111 // Include message deserialization in latency. | 105 // Include message deserialization in latency. |
112 base::TimeTicks now = base::TimeTicks::Now(); | 106 base::TimeTicks now = base::TimeTicks::Now(); |
113 | 107 |
114 if (payload == "hello") { | 108 if (payload == "hello") { |
115 latency_tracker_.Reset(); | 109 latency_tracker_.Reset(); |
116 } else if (payload == "quit") { | 110 } else if (payload == "quit") { |
117 latency_tracker_.ShowResults(); | 111 latency_tracker_.ShowResults(); |
118 base::MessageLoop::current()->QuitWhenIdle(); | 112 base::MessageLoop::current()->QuitWhenIdle(); |
119 return true; | 113 return true; |
120 } else { | 114 } else { |
121 // Don't track hello and quit messages. | 115 // Don't track hello and quit messages. |
122 latency_tracker_.AddEvent( | 116 latency_tracker_.AddEvent( |
123 base::TimeTicks::FromInternalValue(time_internal), now); | 117 base::TimeTicks::FromInternalValue(time_internal), now); |
124 } | 118 } |
125 | 119 |
126 IPC::Message* msg = new IPC::Message(0, 2, IPC::Message::PRIORITY_NORMAL); | 120 Message* msg = new Message(0, 2, Message::PRIORITY_NORMAL); |
127 msg->WriteInt64(base::TimeTicks::Now().ToInternalValue()); | 121 msg->WriteInt64(base::TimeTicks::Now().ToInternalValue()); |
128 msg->WriteInt(msgid); | 122 msg->WriteInt(msgid); |
129 msg->WriteString(payload); | 123 msg->WriteString(payload); |
130 channel_->Send(msg); | 124 channel_->Send(msg); |
131 return true; | 125 return true; |
132 } | 126 } |
133 | 127 |
134 private: | 128 private: |
135 IPC::Channel* channel_; | 129 Channel* channel_; |
136 EventTimeTracker latency_tracker_; | 130 EventTimeTracker latency_tracker_; |
137 }; | 131 }; |
138 | 132 |
139 class PerformanceChannelListener : public IPC::Listener { | 133 class PerformanceChannelListener : public Listener { |
140 public: | 134 public: |
141 explicit PerformanceChannelListener(const std::string& label) | 135 explicit PerformanceChannelListener(const std::string& label) |
142 : label_(label), | 136 : label_(label), |
143 sender_(NULL), | 137 sender_(NULL), |
144 msg_count_(0), | 138 msg_count_(0), |
145 msg_size_(0), | 139 msg_size_(0), |
146 count_down_(0), | 140 count_down_(0), |
147 latency_tracker_("Server messages") { | 141 latency_tracker_("Server messages") { |
148 VLOG(1) << "Server listener up"; | 142 VLOG(1) << "Server listener up"; |
149 } | 143 } |
150 | 144 |
151 virtual ~PerformanceChannelListener() { | 145 virtual ~PerformanceChannelListener() { |
152 VLOG(1) << "Server listener down"; | 146 VLOG(1) << "Server listener down"; |
153 } | 147 } |
154 | 148 |
155 void Init(IPC::Sender* sender) { | 149 void Init(Sender* sender) { |
156 DCHECK(!sender_); | 150 DCHECK(!sender_); |
157 sender_ = sender; | 151 sender_ = sender; |
158 } | 152 } |
159 | 153 |
160 // Call this before running the message loop. | 154 // Call this before running the message loop. |
161 void SetTestParams(int msg_count, size_t msg_size) { | 155 void SetTestParams(int msg_count, size_t msg_size) { |
162 DCHECK_EQ(0, count_down_); | 156 DCHECK_EQ(0, count_down_); |
163 msg_count_ = msg_count; | 157 msg_count_ = msg_count; |
164 msg_size_ = msg_size; | 158 msg_size_ = msg_size; |
165 count_down_ = msg_count_; | 159 count_down_ = msg_count_; |
166 payload_ = std::string(msg_size_, 'a'); | 160 payload_ = std::string(msg_size_, 'a'); |
167 } | 161 } |
168 | 162 |
169 virtual bool OnMessageReceived(const IPC::Message& message) OVERRIDE { | 163 virtual bool OnMessageReceived(const Message& message) OVERRIDE { |
170 CHECK(sender_); | 164 CHECK(sender_); |
171 | 165 |
172 PickleIterator iter(message); | 166 PickleIterator iter(message); |
173 int64 time_internal; | 167 int64 time_internal; |
174 EXPECT_TRUE(iter.ReadInt64(&time_internal)); | 168 EXPECT_TRUE(iter.ReadInt64(&time_internal)); |
175 int msgid; | 169 int msgid; |
176 EXPECT_TRUE(iter.ReadInt(&msgid)); | 170 EXPECT_TRUE(iter.ReadInt(&msgid)); |
177 std::string reflected_payload; | 171 std::string reflected_payload; |
178 EXPECT_TRUE(iter.ReadString(&reflected_payload)); | 172 EXPECT_TRUE(iter.ReadString(&reflected_payload)); |
179 | 173 |
(...skipping 19 matching lines...) Expand all Loading... |
199 CHECK(count_down_ > 0); | 193 CHECK(count_down_ > 0); |
200 count_down_--; | 194 count_down_--; |
201 if (count_down_ == 0) { | 195 if (count_down_ == 0) { |
202 perf_logger_.reset(); // Stop the perf timer now. | 196 perf_logger_.reset(); // Stop the perf timer now. |
203 latency_tracker_.ShowResults(); | 197 latency_tracker_.ShowResults(); |
204 base::MessageLoop::current()->QuitWhenIdle(); | 198 base::MessageLoop::current()->QuitWhenIdle(); |
205 return true; | 199 return true; |
206 } | 200 } |
207 } | 201 } |
208 | 202 |
209 IPC::Message* msg = new IPC::Message(0, 2, IPC::Message::PRIORITY_NORMAL); | 203 Message* msg = new Message(0, 2, Message::PRIORITY_NORMAL); |
210 msg->WriteInt64(base::TimeTicks::Now().ToInternalValue()); | 204 msg->WriteInt64(base::TimeTicks::Now().ToInternalValue()); |
211 msg->WriteInt(count_down_); | 205 msg->WriteInt(count_down_); |
212 msg->WriteString(payload_); | 206 msg->WriteString(payload_); |
213 sender_->Send(msg); | 207 sender_->Send(msg); |
214 return true; | 208 return true; |
215 } | 209 } |
216 | 210 |
217 private: | 211 private: |
218 std::string label_; | 212 std::string label_; |
219 IPC::Sender* sender_; | 213 Sender* sender_; |
220 int msg_count_; | 214 int msg_count_; |
221 size_t msg_size_; | 215 size_t msg_size_; |
222 | 216 |
223 int count_down_; | 217 int count_down_; |
224 std::string payload_; | 218 std::string payload_; |
225 EventTimeTracker latency_tracker_; | 219 EventTimeTracker latency_tracker_; |
226 scoped_ptr<base::PerfTimeLogger> perf_logger_; | 220 scoped_ptr<base::PerfTimeLogger> perf_logger_; |
227 }; | 221 }; |
228 | 222 |
229 TEST_F(IPCChannelPerfTest, ChannelPingPong) { | 223 std::vector<PingPongTestParams> |
| 224 IPCChannelPerfTestBase::GetDefaultTestParams() { |
| 225 // Test several sizes. We use 12^N for message size, and limit the message |
| 226 // count to keep the test duration reasonable. |
| 227 std::vector<PingPongTestParams> list; |
| 228 list.push_back(PingPongTestParams(12, 50000)); |
| 229 list.push_back(PingPongTestParams(144, 50000)); |
| 230 list.push_back(PingPongTestParams(1728, 50000)); |
| 231 list.push_back(PingPongTestParams(20736, 12000)); |
| 232 list.push_back(PingPongTestParams(248832, 100)); |
| 233 return list; |
| 234 } |
| 235 |
| 236 void IPCChannelPerfTestBase::RunTestChannelPingPong( |
| 237 const std::vector<PingPongTestParams>& params) { |
230 Init("PerformanceClient"); | 238 Init("PerformanceClient"); |
231 | 239 |
232 // Set up IPC channel and start client. | 240 // Set up IPC channel and start client. |
233 PerformanceChannelListener listener("Channel"); | 241 PerformanceChannelListener listener("Channel"); |
234 CreateChannel(&listener); | 242 CreateChannel(&listener); |
235 listener.Init(channel()); | 243 listener.Init(channel()); |
236 ASSERT_TRUE(ConnectChannel()); | 244 ASSERT_TRUE(ConnectChannel()); |
237 ASSERT_TRUE(StartClient()); | 245 ASSERT_TRUE(StartClient()); |
238 | 246 |
239 // Test several sizes. We use 12^N for message size, and limit the message | 247 for (size_t i = 0; i < params.size(); i++) { |
240 // count to keep the test duration reasonable. | 248 listener.SetTestParams(params[i].message_count(), |
241 const size_t kMsgSize[5] = {12, 144, 1728, 20736, 248832}; | 249 params[i].message_size()); |
242 const int kMessageCount[5] = {50000, 50000, 50000, 12000, 1000}; | |
243 | |
244 for (size_t i = 0; i < 5; i++) { | |
245 listener.SetTestParams(kMessageCount[i], kMsgSize[i]); | |
246 | 250 |
247 // This initial message will kick-start the ping-pong of messages. | 251 // This initial message will kick-start the ping-pong of messages. |
248 IPC::Message* message = | 252 Message* message = |
249 new IPC::Message(0, 2, IPC::Message::PRIORITY_NORMAL); | 253 new Message(0, 2, Message::PRIORITY_NORMAL); |
250 message->WriteInt64(base::TimeTicks::Now().ToInternalValue()); | 254 message->WriteInt64(base::TimeTicks::Now().ToInternalValue()); |
251 message->WriteInt(-1); | 255 message->WriteInt(-1); |
252 message->WriteString("hello"); | 256 message->WriteString("hello"); |
253 sender()->Send(message); | 257 sender()->Send(message); |
254 | 258 |
255 // Run message loop. | 259 // Run message loop. |
256 base::MessageLoop::current()->Run(); | 260 base::MessageLoop::current()->Run(); |
257 } | 261 } |
258 | 262 |
259 // Send quit message. | 263 // Send quit message. |
260 IPC::Message* message = new IPC::Message(0, 2, IPC::Message::PRIORITY_NORMAL); | 264 Message* message = new Message(0, 2, Message::PRIORITY_NORMAL); |
261 message->WriteInt64(base::TimeTicks::Now().ToInternalValue()); | 265 message->WriteInt64(base::TimeTicks::Now().ToInternalValue()); |
262 message->WriteInt(-1); | 266 message->WriteInt(-1); |
263 message->WriteString("quit"); | 267 message->WriteString("quit"); |
264 sender()->Send(message); | 268 sender()->Send(message); |
265 | 269 |
266 EXPECT_TRUE(WaitForClientShutdown()); | 270 EXPECT_TRUE(WaitForClientShutdown()); |
267 DestroyChannel(); | 271 DestroyChannel(); |
268 } | 272 } |
269 | 273 |
270 // This message loop bounces all messages back to the sender. | 274 void IPCChannelPerfTestBase::RunTestChannelProxyPingPong( |
271 MULTIPROCESS_IPC_TEST_CLIENT_MAIN(PerformanceClient) { | 275 const std::vector<PingPongTestParams>& params) { |
272 base::MessageLoopForIO main_message_loop; | |
273 ChannelReflectorListener listener; | |
274 scoped_ptr<IPC::Channel> channel(IPC::Channel::CreateClient( | |
275 IPCTestBase::GetChannelName("PerformanceClient"), &listener)); | |
276 listener.Init(channel.get()); | |
277 CHECK(channel->Connect()); | |
278 | |
279 base::MessageLoop::current()->Run(); | |
280 return 0; | |
281 } | |
282 | |
283 TEST_F(IPCChannelPerfTest, ChannelProxyPingPong) { | |
284 InitWithCustomMessageLoop("PerformanceClient", | 276 InitWithCustomMessageLoop("PerformanceClient", |
285 make_scoped_ptr(new base::MessageLoop())); | 277 make_scoped_ptr(new base::MessageLoop())); |
286 | 278 |
287 base::TestIOThread io_thread(base::TestIOThread::kAutoStart); | 279 base::TestIOThread io_thread(base::TestIOThread::kAutoStart); |
288 | 280 |
289 // Set up IPC channel and start client. | 281 // Set up IPC channel and start client. |
290 PerformanceChannelListener listener("ChannelProxy"); | 282 PerformanceChannelListener listener("ChannelProxy"); |
291 CreateChannelProxy(&listener, io_thread.task_runner()); | 283 CreateChannelProxy(&listener, io_thread.task_runner()); |
292 listener.Init(channel_proxy()); | 284 listener.Init(channel_proxy()); |
293 ASSERT_TRUE(StartClient()); | 285 ASSERT_TRUE(StartClient()); |
294 | 286 |
295 // Test several sizes. We use 12^N for message size, and limit the message | 287 for (size_t i = 0; i < params.size(); i++) { |
296 // count to keep the test duration reasonable. | 288 listener.SetTestParams(params[i].message_count(), |
297 const size_t kMsgSize[5] = {12, 144, 1728, 20736, 248832}; | 289 params[i].message_size()); |
298 const int kMessageCount[5] = {50000, 50000, 50000, 12000, 1000}; | |
299 | |
300 for (size_t i = 0; i < 5; i++) { | |
301 listener.SetTestParams(kMessageCount[i], kMsgSize[i]); | |
302 | 290 |
303 // This initial message will kick-start the ping-pong of messages. | 291 // This initial message will kick-start the ping-pong of messages. |
304 IPC::Message* message = | 292 Message* message = |
305 new IPC::Message(0, 2, IPC::Message::PRIORITY_NORMAL); | 293 new Message(0, 2, Message::PRIORITY_NORMAL); |
306 message->WriteInt64(base::TimeTicks::Now().ToInternalValue()); | 294 message->WriteInt64(base::TimeTicks::Now().ToInternalValue()); |
307 message->WriteInt(-1); | 295 message->WriteInt(-1); |
308 message->WriteString("hello"); | 296 message->WriteString("hello"); |
309 sender()->Send(message); | 297 sender()->Send(message); |
310 | 298 |
311 // Run message loop. | 299 // Run message loop. |
312 base::MessageLoop::current()->Run(); | 300 base::MessageLoop::current()->Run(); |
313 } | 301 } |
314 | 302 |
315 // Send quit message. | 303 // Send quit message. |
316 IPC::Message* message = new IPC::Message(0, 2, IPC::Message::PRIORITY_NORMAL); | 304 Message* message = new Message(0, 2, Message::PRIORITY_NORMAL); |
317 message->WriteInt64(base::TimeTicks::Now().ToInternalValue()); | 305 message->WriteInt64(base::TimeTicks::Now().ToInternalValue()); |
318 message->WriteInt(-1); | 306 message->WriteInt(-1); |
319 message->WriteString("quit"); | 307 message->WriteString("quit"); |
320 sender()->Send(message); | 308 sender()->Send(message); |
321 | 309 |
322 EXPECT_TRUE(WaitForClientShutdown()); | 310 EXPECT_TRUE(WaitForClientShutdown()); |
323 DestroyChannelProxy(); | 311 DestroyChannelProxy(); |
324 } | 312 } |
325 | 313 |
326 } // namespace | 314 |
| 315 PingPongTestClient::PingPongTestClient() |
| 316 : listener_(new ChannelReflectorListener()) { |
| 317 } |
| 318 |
| 319 PingPongTestClient::~PingPongTestClient() { |
| 320 } |
| 321 |
| 322 scoped_ptr<Channel> PingPongTestClient::CreateChannel( |
| 323 Listener* listener) { |
| 324 return Channel::CreateClient( |
| 325 IPCTestBase::GetChannelName("PerformanceClient"), listener); |
| 326 } |
| 327 |
| 328 int PingPongTestClient::RunMain() { |
| 329 scoped_ptr<Channel> channel = CreateChannel(listener_.get()); |
| 330 listener_->Init(channel.get()); |
| 331 CHECK(channel->Connect()); |
| 332 |
| 333 base::MessageLoop::current()->Run(); |
| 334 return 0; |
| 335 } |
| 336 |
| 337 scoped_refptr<base::TaskRunner> PingPongTestClient::task_runner() { |
| 338 return main_message_loop_.message_loop_proxy(); |
| 339 } |
| 340 |
| 341 } // namespace test |
| 342 } // namespace IPC |
OLD | NEW |