mirror of https://github.com/lukechilds/node.git
You can not select more than 25 topics
Topics must start with a letter or number, can include dashes ('-') and can be up to 35 characters long.
2033 lines
69 KiB
2033 lines
69 KiB
// Copyright 2010 the V8 project authors. 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.
|
|
//
|
|
// Tests of profiles generator and utilities.
|
|
|
|
#include "src/v8.h"
|
|
|
|
#include "include/v8-profiler.h"
|
|
#include "src/base/platform/platform.h"
|
|
#include "src/base/smart-pointers.h"
|
|
#include "src/deoptimizer.h"
|
|
#include "src/profiler/cpu-profiler-inl.h"
|
|
#include "src/utils.h"
|
|
#include "test/cctest/cctest.h"
|
|
#include "test/cctest/profiler-extension.h"
|
|
using i::CodeEntry;
|
|
using i::CpuProfile;
|
|
using i::CpuProfiler;
|
|
using i::CpuProfilesCollection;
|
|
using i::Heap;
|
|
using i::ProfileGenerator;
|
|
using i::ProfileNode;
|
|
using i::ProfilerEventsProcessor;
|
|
using i::ScopedVector;
|
|
using i::Vector;
|
|
using v8::base::SmartPointer;
|
|
|
|
|
|
// Helper methods
|
|
static v8::Local<v8::Function> GetFunction(v8::Local<v8::Context> env,
|
|
const char* name) {
|
|
return v8::Local<v8::Function>::Cast(
|
|
env->Global()->Get(env, v8_str(name)).ToLocalChecked());
|
|
}
|
|
|
|
|
|
static size_t offset(const char* src, const char* substring) {
|
|
const char* it = strstr(src, substring);
|
|
CHECK(it);
|
|
return static_cast<size_t>(it - src);
|
|
}
|
|
|
|
|
|
static const char* reason(const i::Deoptimizer::DeoptReason reason) {
|
|
return i::Deoptimizer::GetDeoptReason(reason);
|
|
}
|
|
|
|
|
|
TEST(StartStop) {
|
|
i::Isolate* isolate = CcTest::i_isolate();
|
|
CpuProfilesCollection profiles(isolate->heap());
|
|
ProfileGenerator generator(&profiles);
|
|
SmartPointer<ProfilerEventsProcessor> processor(new ProfilerEventsProcessor(
|
|
&generator, NULL, v8::base::TimeDelta::FromMicroseconds(100)));
|
|
processor->Start();
|
|
processor->StopSynchronously();
|
|
}
|
|
|
|
|
|
static void EnqueueTickSampleEvent(ProfilerEventsProcessor* proc,
|
|
i::Address frame1,
|
|
i::Address frame2 = NULL,
|
|
i::Address frame3 = NULL) {
|
|
i::TickSample* sample = proc->StartTickSample();
|
|
sample->pc = frame1;
|
|
sample->tos = frame1;
|
|
sample->frames_count = 0;
|
|
if (frame2 != NULL) {
|
|
sample->stack[0] = frame2;
|
|
sample->frames_count = 1;
|
|
}
|
|
if (frame3 != NULL) {
|
|
sample->stack[1] = frame3;
|
|
sample->frames_count = 2;
|
|
}
|
|
proc->FinishTickSample();
|
|
}
|
|
|
|
namespace {
|
|
|
|
class TestSetup {
|
|
public:
|
|
TestSetup()
|
|
: old_flag_prof_browser_mode_(i::FLAG_prof_browser_mode) {
|
|
i::FLAG_prof_browser_mode = false;
|
|
}
|
|
|
|
~TestSetup() {
|
|
i::FLAG_prof_browser_mode = old_flag_prof_browser_mode_;
|
|
}
|
|
|
|
private:
|
|
bool old_flag_prof_browser_mode_;
|
|
};
|
|
|
|
} // namespace
|
|
|
|
i::AbstractCode* CreateCode(LocalContext* env) {
|
|
static int counter = 0;
|
|
i::EmbeddedVector<char, 256> script;
|
|
i::EmbeddedVector<char, 32> name;
|
|
|
|
i::SNPrintF(name, "function_%d", ++counter);
|
|
const char* name_start = name.start();
|
|
i::SNPrintF(script,
|
|
"function %s() {\n"
|
|
"var counter = 0;\n"
|
|
"for (var i = 0; i < %d; ++i) counter += i;\n"
|
|
"return '%s_' + counter;\n"
|
|
"}\n"
|
|
"%s();\n", name_start, counter, name_start, name_start);
|
|
CompileRun(script.start());
|
|
|
|
i::Handle<i::JSFunction> fun = i::Handle<i::JSFunction>::cast(
|
|
v8::Utils::OpenHandle(*GetFunction(env->local(), name_start)));
|
|
return fun->abstract_code();
|
|
}
|
|
|
|
TEST(CodeEvents) {
|
|
CcTest::InitializeVM();
|
|
LocalContext env;
|
|
i::Isolate* isolate = CcTest::i_isolate();
|
|
i::Factory* factory = isolate->factory();
|
|
TestSetup test_setup;
|
|
|
|
i::HandleScope scope(isolate);
|
|
|
|
i::AbstractCode* aaa_code = CreateCode(&env);
|
|
i::AbstractCode* comment_code = CreateCode(&env);
|
|
i::AbstractCode* args5_code = CreateCode(&env);
|
|
i::AbstractCode* comment2_code = CreateCode(&env);
|
|
i::AbstractCode* moved_code = CreateCode(&env);
|
|
i::AbstractCode* args3_code = CreateCode(&env);
|
|
i::AbstractCode* args4_code = CreateCode(&env);
|
|
|
|
CpuProfilesCollection* profiles = new CpuProfilesCollection(isolate->heap());
|
|
profiles->StartProfiling("", false);
|
|
ProfileGenerator generator(profiles);
|
|
SmartPointer<ProfilerEventsProcessor> processor(new ProfilerEventsProcessor(
|
|
&generator, NULL, v8::base::TimeDelta::FromMicroseconds(100)));
|
|
processor->Start();
|
|
CpuProfiler profiler(isolate, profiles, &generator, processor.get());
|
|
|
|
// Enqueue code creation events.
|
|
const char* aaa_str = "aaa";
|
|
i::Handle<i::String> aaa_name = factory->NewStringFromAsciiChecked(aaa_str);
|
|
profiler.CodeCreateEvent(i::Logger::FUNCTION_TAG, aaa_code, *aaa_name);
|
|
profiler.CodeCreateEvent(i::Logger::BUILTIN_TAG, comment_code, "comment");
|
|
profiler.CodeCreateEvent(i::Logger::STUB_TAG, args5_code, 5);
|
|
profiler.CodeCreateEvent(i::Logger::BUILTIN_TAG, comment2_code, "comment2");
|
|
profiler.CodeMoveEvent(comment2_code, moved_code->address());
|
|
profiler.CodeCreateEvent(i::Logger::STUB_TAG, args3_code, 3);
|
|
profiler.CodeCreateEvent(i::Logger::STUB_TAG, args4_code, 4);
|
|
|
|
// Enqueue a tick event to enable code events processing.
|
|
EnqueueTickSampleEvent(processor.get(), aaa_code->address());
|
|
|
|
processor->StopSynchronously();
|
|
|
|
// Check the state of profile generator.
|
|
CodeEntry* aaa = generator.code_map()->FindEntry(aaa_code->address());
|
|
CHECK(aaa);
|
|
CHECK_EQ(0, strcmp(aaa_str, aaa->name()));
|
|
|
|
CodeEntry* comment = generator.code_map()->FindEntry(comment_code->address());
|
|
CHECK(comment);
|
|
CHECK_EQ(0, strcmp("comment", comment->name()));
|
|
|
|
CodeEntry* args5 = generator.code_map()->FindEntry(args5_code->address());
|
|
CHECK(args5);
|
|
CHECK_EQ(0, strcmp("5", args5->name()));
|
|
|
|
CHECK(!generator.code_map()->FindEntry(comment2_code->address()));
|
|
|
|
CodeEntry* comment2 = generator.code_map()->FindEntry(moved_code->address());
|
|
CHECK(comment2);
|
|
CHECK_EQ(0, strcmp("comment2", comment2->name()));
|
|
}
|
|
|
|
template<typename T>
|
|
static int CompareProfileNodes(const T* p1, const T* p2) {
|
|
return strcmp((*p1)->entry()->name(), (*p2)->entry()->name());
|
|
}
|
|
|
|
TEST(TickEvents) {
|
|
TestSetup test_setup;
|
|
LocalContext env;
|
|
i::Isolate* isolate = CcTest::i_isolate();
|
|
i::HandleScope scope(isolate);
|
|
|
|
i::AbstractCode* frame1_code = CreateCode(&env);
|
|
i::AbstractCode* frame2_code = CreateCode(&env);
|
|
i::AbstractCode* frame3_code = CreateCode(&env);
|
|
|
|
CpuProfilesCollection* profiles = new CpuProfilesCollection(isolate->heap());
|
|
profiles->StartProfiling("", false);
|
|
ProfileGenerator generator(profiles);
|
|
SmartPointer<ProfilerEventsProcessor> processor(new ProfilerEventsProcessor(
|
|
&generator, NULL, v8::base::TimeDelta::FromMicroseconds(100)));
|
|
processor->Start();
|
|
CpuProfiler profiler(isolate, profiles, &generator, processor.get());
|
|
|
|
profiler.CodeCreateEvent(i::Logger::BUILTIN_TAG, frame1_code, "bbb");
|
|
profiler.CodeCreateEvent(i::Logger::STUB_TAG, frame2_code, 5);
|
|
profiler.CodeCreateEvent(i::Logger::BUILTIN_TAG, frame3_code, "ddd");
|
|
|
|
EnqueueTickSampleEvent(processor.get(), frame1_code->instruction_start());
|
|
EnqueueTickSampleEvent(
|
|
processor.get(),
|
|
frame2_code->instruction_start() + frame2_code->ExecutableSize() / 2,
|
|
frame1_code->instruction_start() + frame2_code->ExecutableSize() / 2);
|
|
EnqueueTickSampleEvent(
|
|
processor.get(),
|
|
frame3_code->instruction_end() - 1,
|
|
frame2_code->instruction_end() - 1,
|
|
frame1_code->instruction_end() - 1);
|
|
|
|
processor->StopSynchronously();
|
|
CpuProfile* profile = profiles->StopProfiling("");
|
|
CHECK(profile);
|
|
|
|
// Check call trees.
|
|
const i::List<ProfileNode*>* top_down_root_children =
|
|
profile->top_down()->root()->children();
|
|
CHECK_EQ(1, top_down_root_children->length());
|
|
CHECK_EQ(0, strcmp("bbb", top_down_root_children->last()->entry()->name()));
|
|
const i::List<ProfileNode*>* top_down_bbb_children =
|
|
top_down_root_children->last()->children();
|
|
CHECK_EQ(1, top_down_bbb_children->length());
|
|
CHECK_EQ(0, strcmp("5", top_down_bbb_children->last()->entry()->name()));
|
|
const i::List<ProfileNode*>* top_down_stub_children =
|
|
top_down_bbb_children->last()->children();
|
|
CHECK_EQ(1, top_down_stub_children->length());
|
|
CHECK_EQ(0, strcmp("ddd", top_down_stub_children->last()->entry()->name()));
|
|
const i::List<ProfileNode*>* top_down_ddd_children =
|
|
top_down_stub_children->last()->children();
|
|
CHECK_EQ(0, top_down_ddd_children->length());
|
|
}
|
|
|
|
// http://crbug/51594
|
|
// This test must not crash.
|
|
TEST(CrashIfStoppingLastNonExistentProfile) {
|
|
CcTest::InitializeVM();
|
|
TestSetup test_setup;
|
|
CpuProfiler* profiler = CcTest::i_isolate()->cpu_profiler();
|
|
profiler->StartProfiling("1");
|
|
profiler->StopProfiling("2");
|
|
profiler->StartProfiling("1");
|
|
profiler->StopProfiling("");
|
|
}
|
|
|
|
// http://code.google.com/p/v8/issues/detail?id=1398
|
|
// Long stacks (exceeding max frames limit) must not be erased.
|
|
TEST(Issue1398) {
|
|
TestSetup test_setup;
|
|
LocalContext env;
|
|
i::Isolate* isolate = CcTest::i_isolate();
|
|
i::HandleScope scope(isolate);
|
|
|
|
i::AbstractCode* code = CreateCode(&env);
|
|
|
|
CpuProfilesCollection* profiles = new CpuProfilesCollection(isolate->heap());
|
|
profiles->StartProfiling("", false);
|
|
ProfileGenerator generator(profiles);
|
|
SmartPointer<ProfilerEventsProcessor> processor(new ProfilerEventsProcessor(
|
|
&generator, NULL, v8::base::TimeDelta::FromMicroseconds(100)));
|
|
processor->Start();
|
|
CpuProfiler profiler(isolate, profiles, &generator, processor.get());
|
|
|
|
profiler.CodeCreateEvent(i::Logger::BUILTIN_TAG, code, "bbb");
|
|
|
|
i::TickSample* sample = processor->StartTickSample();
|
|
sample->pc = code->address();
|
|
sample->tos = 0;
|
|
sample->frames_count = i::TickSample::kMaxFramesCount;
|
|
for (unsigned i = 0; i < sample->frames_count; ++i) {
|
|
sample->stack[i] = code->address();
|
|
}
|
|
processor->FinishTickSample();
|
|
|
|
processor->StopSynchronously();
|
|
CpuProfile* profile = profiles->StopProfiling("");
|
|
CHECK(profile);
|
|
|
|
unsigned actual_depth = 0;
|
|
const ProfileNode* node = profile->top_down()->root();
|
|
while (node->children()->length() > 0) {
|
|
node = node->children()->last();
|
|
++actual_depth;
|
|
}
|
|
|
|
CHECK_EQ(1 + i::TickSample::kMaxFramesCount, actual_depth); // +1 for PC.
|
|
}
|
|
|
|
TEST(DeleteAllCpuProfiles) {
|
|
CcTest::InitializeVM();
|
|
TestSetup test_setup;
|
|
CpuProfiler* profiler = CcTest::i_isolate()->cpu_profiler();
|
|
CHECK_EQ(0, profiler->GetProfilesCount());
|
|
profiler->DeleteAllProfiles();
|
|
CHECK_EQ(0, profiler->GetProfilesCount());
|
|
|
|
profiler->StartProfiling("1");
|
|
profiler->StopProfiling("1");
|
|
CHECK_EQ(1, profiler->GetProfilesCount());
|
|
profiler->DeleteAllProfiles();
|
|
CHECK_EQ(0, profiler->GetProfilesCount());
|
|
profiler->StartProfiling("1");
|
|
profiler->StartProfiling("2");
|
|
profiler->StopProfiling("2");
|
|
profiler->StopProfiling("1");
|
|
CHECK_EQ(2, profiler->GetProfilesCount());
|
|
profiler->DeleteAllProfiles();
|
|
CHECK_EQ(0, profiler->GetProfilesCount());
|
|
|
|
// Test profiling cancellation by the 'delete' command.
|
|
profiler->StartProfiling("1");
|
|
profiler->StartProfiling("2");
|
|
CHECK_EQ(0, profiler->GetProfilesCount());
|
|
profiler->DeleteAllProfiles();
|
|
CHECK_EQ(0, profiler->GetProfilesCount());
|
|
}
|
|
|
|
|
|
static bool FindCpuProfile(v8::CpuProfiler* v8profiler,
|
|
const v8::CpuProfile* v8profile) {
|
|
i::CpuProfiler* profiler = reinterpret_cast<i::CpuProfiler*>(v8profiler);
|
|
const i::CpuProfile* profile =
|
|
reinterpret_cast<const i::CpuProfile*>(v8profile);
|
|
int length = profiler->GetProfilesCount();
|
|
for (int i = 0; i < length; i++) {
|
|
if (profile == profiler->GetProfile(i))
|
|
return true;
|
|
}
|
|
return false;
|
|
}
|
|
|
|
|
|
TEST(DeleteCpuProfile) {
|
|
LocalContext env;
|
|
v8::HandleScope scope(env->GetIsolate());
|
|
v8::CpuProfiler* cpu_profiler = env->GetIsolate()->GetCpuProfiler();
|
|
i::CpuProfiler* iprofiler = reinterpret_cast<i::CpuProfiler*>(cpu_profiler);
|
|
|
|
CHECK_EQ(0, iprofiler->GetProfilesCount());
|
|
v8::Local<v8::String> name1 = v8_str("1");
|
|
cpu_profiler->StartProfiling(name1);
|
|
v8::CpuProfile* p1 = cpu_profiler->StopProfiling(name1);
|
|
CHECK(p1);
|
|
CHECK_EQ(1, iprofiler->GetProfilesCount());
|
|
CHECK(FindCpuProfile(cpu_profiler, p1));
|
|
p1->Delete();
|
|
CHECK_EQ(0, iprofiler->GetProfilesCount());
|
|
|
|
v8::Local<v8::String> name2 = v8_str("2");
|
|
cpu_profiler->StartProfiling(name2);
|
|
v8::CpuProfile* p2 = cpu_profiler->StopProfiling(name2);
|
|
CHECK(p2);
|
|
CHECK_EQ(1, iprofiler->GetProfilesCount());
|
|
CHECK(FindCpuProfile(cpu_profiler, p2));
|
|
v8::Local<v8::String> name3 = v8_str("3");
|
|
cpu_profiler->StartProfiling(name3);
|
|
v8::CpuProfile* p3 = cpu_profiler->StopProfiling(name3);
|
|
CHECK(p3);
|
|
CHECK_EQ(2, iprofiler->GetProfilesCount());
|
|
CHECK_NE(p2, p3);
|
|
CHECK(FindCpuProfile(cpu_profiler, p3));
|
|
CHECK(FindCpuProfile(cpu_profiler, p2));
|
|
p2->Delete();
|
|
CHECK_EQ(1, iprofiler->GetProfilesCount());
|
|
CHECK(!FindCpuProfile(cpu_profiler, p2));
|
|
CHECK(FindCpuProfile(cpu_profiler, p3));
|
|
p3->Delete();
|
|
CHECK_EQ(0, iprofiler->GetProfilesCount());
|
|
}
|
|
|
|
|
|
TEST(ProfileStartEndTime) {
|
|
LocalContext env;
|
|
v8::HandleScope scope(env->GetIsolate());
|
|
v8::CpuProfiler* cpu_profiler = env->GetIsolate()->GetCpuProfiler();
|
|
|
|
v8::Local<v8::String> profile_name = v8_str("test");
|
|
cpu_profiler->StartProfiling(profile_name);
|
|
const v8::CpuProfile* profile = cpu_profiler->StopProfiling(profile_name);
|
|
CHECK(profile->GetStartTime() <= profile->GetEndTime());
|
|
}
|
|
|
|
static v8::CpuProfile* RunProfiler(v8::Local<v8::Context> env,
|
|
v8::Local<v8::Function> function,
|
|
v8::Local<v8::Value> argv[], int argc,
|
|
unsigned min_js_samples = 0,
|
|
unsigned min_external_samples = 0,
|
|
bool collect_samples = false) {
|
|
v8::CpuProfiler* cpu_profiler = env->GetIsolate()->GetCpuProfiler();
|
|
v8::Local<v8::String> profile_name = v8_str("my_profile");
|
|
|
|
cpu_profiler->SetSamplingInterval(100);
|
|
cpu_profiler->StartProfiling(profile_name, collect_samples);
|
|
|
|
i::Sampler* sampler =
|
|
reinterpret_cast<i::Isolate*>(env->GetIsolate())->logger()->sampler();
|
|
sampler->StartCountingSamples();
|
|
do {
|
|
function->Call(env, env->Global(), argc, argv).ToLocalChecked();
|
|
} while (sampler->js_sample_count() < min_js_samples ||
|
|
sampler->external_sample_count() < min_external_samples);
|
|
|
|
v8::CpuProfile* profile = cpu_profiler->StopProfiling(profile_name);
|
|
|
|
CHECK(profile);
|
|
// Dump collected profile to have a better diagnostic in case of failure.
|
|
reinterpret_cast<i::CpuProfile*>(profile)->Print();
|
|
|
|
return profile;
|
|
}
|
|
|
|
|
|
static const v8::CpuProfileNode* FindChild(v8::Local<v8::Context> context,
|
|
const v8::CpuProfileNode* node,
|
|
const char* name) {
|
|
int count = node->GetChildrenCount();
|
|
v8::Local<v8::String> name_handle = v8_str(name);
|
|
for (int i = 0; i < count; i++) {
|
|
const v8::CpuProfileNode* child = node->GetChild(i);
|
|
if (name_handle->Equals(context, child->GetFunctionName()).FromJust()) {
|
|
return child;
|
|
}
|
|
}
|
|
return NULL;
|
|
}
|
|
|
|
|
|
static const v8::CpuProfileNode* GetChild(v8::Local<v8::Context> context,
|
|
const v8::CpuProfileNode* node,
|
|
const char* name) {
|
|
const v8::CpuProfileNode* result = FindChild(context, node, name);
|
|
if (!result) {
|
|
char buffer[100];
|
|
i::SNPrintF(Vector<char>(buffer, arraysize(buffer)),
|
|
"Failed to GetChild: %s", name);
|
|
FATAL(buffer);
|
|
}
|
|
return result;
|
|
}
|
|
|
|
|
|
static void CheckSimpleBranch(v8::Local<v8::Context> context,
|
|
const v8::CpuProfileNode* node,
|
|
const char* names[], int length) {
|
|
for (int i = 0; i < length; i++) {
|
|
const char* name = names[i];
|
|
node = GetChild(context, node, name);
|
|
}
|
|
}
|
|
|
|
|
|
static const ProfileNode* GetSimpleBranch(v8::Local<v8::Context> context,
|
|
v8::CpuProfile* profile,
|
|
const char* names[], int length) {
|
|
const v8::CpuProfileNode* node = profile->GetTopDownRoot();
|
|
for (int i = 0; i < length; i++) {
|
|
node = GetChild(context, node, names[i]);
|
|
}
|
|
return reinterpret_cast<const ProfileNode*>(node);
|
|
}
|
|
|
|
static void CallCollectSample(const v8::FunctionCallbackInfo<v8::Value>& info) {
|
|
info.GetIsolate()->GetCpuProfiler()->CollectSample();
|
|
}
|
|
|
|
static const char* cpu_profiler_test_source =
|
|
"%NeverOptimizeFunction(loop);\n"
|
|
"%NeverOptimizeFunction(delay);\n"
|
|
"%NeverOptimizeFunction(bar);\n"
|
|
"%NeverOptimizeFunction(baz);\n"
|
|
"%NeverOptimizeFunction(foo);\n"
|
|
"%NeverOptimizeFunction(start);\n"
|
|
"function loop(timeout) {\n"
|
|
" this.mmm = 0;\n"
|
|
" var start = Date.now();\n"
|
|
" do {\n"
|
|
" var n = 1000;\n"
|
|
" while(n > 1) {\n"
|
|
" n--;\n"
|
|
" this.mmm += n * n * n;\n"
|
|
" }\n"
|
|
" } while (Date.now() - start < timeout);\n"
|
|
"}\n"
|
|
"function delay() { loop(10); }\n"
|
|
"function bar() { delay(); }\n"
|
|
"function baz() { delay(); }\n"
|
|
"function foo() {\n"
|
|
" delay();\n"
|
|
" bar();\n"
|
|
" delay();\n"
|
|
" baz();\n"
|
|
"}\n"
|
|
"function start(duration) {\n"
|
|
" var start = Date.now();\n"
|
|
" do {\n"
|
|
" foo();\n"
|
|
" } while (Date.now() - start < duration);\n"
|
|
"}\n";
|
|
|
|
// Check that the profile tree for the script above will look like the
|
|
// following:
|
|
//
|
|
// [Top down]:
|
|
// 1062 0 (root) [-1]
|
|
// 1054 0 start [-1]
|
|
// 1054 1 foo [-1]
|
|
// 265 0 baz [-1]
|
|
// 265 1 delay [-1]
|
|
// 264 264 loop [-1]
|
|
// 525 3 delay [-1]
|
|
// 522 522 loop [-1]
|
|
// 263 0 bar [-1]
|
|
// 263 1 delay [-1]
|
|
// 262 262 loop [-1]
|
|
// 2 2 (program) [-1]
|
|
// 6 6 (garbage collector) [-1]
|
|
TEST(CollectCpuProfile) {
|
|
i::FLAG_allow_natives_syntax = true;
|
|
LocalContext env;
|
|
v8::HandleScope scope(env->GetIsolate());
|
|
|
|
CompileRun(cpu_profiler_test_source);
|
|
v8::Local<v8::Function> function = GetFunction(env.local(), "start");
|
|
|
|
int32_t profiling_interval_ms = 200;
|
|
v8::Local<v8::Value> args[] = {
|
|
v8::Integer::New(env->GetIsolate(), profiling_interval_ms)};
|
|
v8::CpuProfile* profile =
|
|
RunProfiler(env.local(), function, args, arraysize(args), 1000);
|
|
|
|
const v8::CpuProfileNode* root = profile->GetTopDownRoot();
|
|
const v8::CpuProfileNode* start_node = GetChild(env.local(), root, "start");
|
|
const v8::CpuProfileNode* foo_node = GetChild(env.local(), start_node, "foo");
|
|
|
|
const char* bar_branch[] = {"bar", "delay", "loop"};
|
|
CheckSimpleBranch(env.local(), foo_node, bar_branch, arraysize(bar_branch));
|
|
const char* baz_branch[] = {"baz", "delay", "loop"};
|
|
CheckSimpleBranch(env.local(), foo_node, baz_branch, arraysize(baz_branch));
|
|
const char* delay_branch[] = {"delay", "loop"};
|
|
CheckSimpleBranch(env.local(), foo_node, delay_branch,
|
|
arraysize(delay_branch));
|
|
|
|
profile->Delete();
|
|
}
|
|
|
|
static const char* hot_deopt_no_frame_entry_test_source =
|
|
"%NeverOptimizeFunction(foo);\n"
|
|
"%NeverOptimizeFunction(start);\n"
|
|
"function foo(a, b) {\n"
|
|
" return a + b;\n"
|
|
"}\n"
|
|
"function start(timeout) {\n"
|
|
" var start = Date.now();\n"
|
|
" do {\n"
|
|
" for (var i = 1; i < 1000; ++i) foo(1, i);\n"
|
|
" var duration = Date.now() - start;\n"
|
|
" } while (duration < timeout);\n"
|
|
" return duration;\n"
|
|
"}\n";
|
|
|
|
// Check that the profile tree for the script above will look like the
|
|
// following:
|
|
//
|
|
// [Top down]:
|
|
// 1062 0 (root) [-1]
|
|
// 1054 0 start [-1]
|
|
// 1054 1 foo [-1]
|
|
// 2 2 (program) [-1]
|
|
// 6 6 (garbage collector) [-1]
|
|
//
|
|
// The test checks no FP ranges are present in a deoptimized function.
|
|
// If 'foo' has no ranges the samples falling into the prologue will miss the
|
|
// 'start' function on the stack, so 'foo' will be attached to the (root).
|
|
TEST(HotDeoptNoFrameEntry) {
|
|
i::FLAG_allow_natives_syntax = true;
|
|
LocalContext env;
|
|
v8::HandleScope scope(env->GetIsolate());
|
|
|
|
CompileRun(hot_deopt_no_frame_entry_test_source);
|
|
v8::Local<v8::Function> function = GetFunction(env.local(), "start");
|
|
|
|
int32_t profiling_interval_ms = 200;
|
|
v8::Local<v8::Value> args[] = {
|
|
v8::Integer::New(env->GetIsolate(), profiling_interval_ms)};
|
|
v8::CpuProfile* profile =
|
|
RunProfiler(env.local(), function, args, arraysize(args), 1000);
|
|
function->Call(env.local(), env->Global(), arraysize(args), args)
|
|
.ToLocalChecked();
|
|
|
|
const v8::CpuProfileNode* root = profile->GetTopDownRoot();
|
|
const v8::CpuProfileNode* start_node = GetChild(env.local(), root, "start");
|
|
GetChild(env.local(), start_node, "foo");
|
|
|
|
profile->Delete();
|
|
}
|
|
|
|
TEST(CollectCpuProfileSamples) {
|
|
i::FLAG_allow_natives_syntax = true;
|
|
LocalContext env;
|
|
v8::HandleScope scope(env->GetIsolate());
|
|
|
|
CompileRun(cpu_profiler_test_source);
|
|
v8::Local<v8::Function> function = GetFunction(env.local(), "start");
|
|
|
|
int32_t profiling_interval_ms = 200;
|
|
v8::Local<v8::Value> args[] = {
|
|
v8::Integer::New(env->GetIsolate(), profiling_interval_ms)};
|
|
v8::CpuProfile* profile =
|
|
RunProfiler(env.local(), function, args, arraysize(args), 1000, 0, true);
|
|
|
|
CHECK_LE(200, profile->GetSamplesCount());
|
|
uint64_t end_time = profile->GetEndTime();
|
|
uint64_t current_time = profile->GetStartTime();
|
|
CHECK_LE(current_time, end_time);
|
|
for (int i = 0; i < profile->GetSamplesCount(); i++) {
|
|
CHECK(profile->GetSample(i));
|
|
uint64_t timestamp = profile->GetSampleTimestamp(i);
|
|
CHECK_LE(current_time, timestamp);
|
|
CHECK_LE(timestamp, end_time);
|
|
current_time = timestamp;
|
|
}
|
|
|
|
profile->Delete();
|
|
}
|
|
|
|
static const char* cpu_profiler_test_source2 =
|
|
"%NeverOptimizeFunction(loop);\n"
|
|
"%NeverOptimizeFunction(delay);\n"
|
|
"%NeverOptimizeFunction(start);\n"
|
|
"function loop() {}\n"
|
|
"function delay() { loop(); }\n"
|
|
"function start(duration) {\n"
|
|
" var start = Date.now();\n"
|
|
" do {\n"
|
|
" for (var i = 0; i < 10000; ++i) delay();\n"
|
|
" } while (Date.now() - start < duration);\n"
|
|
"}";
|
|
|
|
// Check that the profile tree doesn't contain unexpected traces:
|
|
// - 'loop' can be called only by 'delay'
|
|
// - 'delay' may be called only by 'start'
|
|
// The profile will look like the following:
|
|
//
|
|
// [Top down]:
|
|
// 135 0 (root) [-1] #1
|
|
// 121 72 start [-1] #3
|
|
// 49 33 delay [-1] #4
|
|
// 16 16 loop [-1] #5
|
|
// 14 14 (program) [-1] #2
|
|
TEST(SampleWhenFrameIsNotSetup) {
|
|
i::FLAG_allow_natives_syntax = true;
|
|
LocalContext env;
|
|
v8::HandleScope scope(env->GetIsolate());
|
|
|
|
CompileRun(cpu_profiler_test_source2);
|
|
v8::Local<v8::Function> function = GetFunction(env.local(), "start");
|
|
|
|
int32_t duration_ms = 100;
|
|
v8::Local<v8::Value> args[] = {
|
|
v8::Integer::New(env->GetIsolate(), duration_ms)};
|
|
v8::CpuProfile* profile =
|
|
RunProfiler(env.local(), function, args, arraysize(args), 1000);
|
|
|
|
const v8::CpuProfileNode* root = profile->GetTopDownRoot();
|
|
const v8::CpuProfileNode* start_node = GetChild(env.local(), root, "start");
|
|
const v8::CpuProfileNode* delay_node =
|
|
GetChild(env.local(), start_node, "delay");
|
|
GetChild(env.local(), delay_node, "loop");
|
|
|
|
profile->Delete();
|
|
}
|
|
|
|
static const char* native_accessor_test_source = "function start(count) {\n"
|
|
" for (var i = 0; i < count; i++) {\n"
|
|
" var o = instance.foo;\n"
|
|
" instance.foo = o + 1;\n"
|
|
" }\n"
|
|
"}\n";
|
|
|
|
class TestApiCallbacks {
|
|
public:
|
|
explicit TestApiCallbacks(int min_duration_ms)
|
|
: min_duration_ms_(min_duration_ms),
|
|
is_warming_up_(false) {}
|
|
|
|
static void Getter(v8::Local<v8::String> name,
|
|
const v8::PropertyCallbackInfo<v8::Value>& info) {
|
|
TestApiCallbacks* data = FromInfo(info);
|
|
data->Wait();
|
|
}
|
|
|
|
static void Setter(v8::Local<v8::String> name,
|
|
v8::Local<v8::Value> value,
|
|
const v8::PropertyCallbackInfo<void>& info) {
|
|
TestApiCallbacks* data = FromInfo(info);
|
|
data->Wait();
|
|
}
|
|
|
|
static void Callback(const v8::FunctionCallbackInfo<v8::Value>& info) {
|
|
TestApiCallbacks* data = FromInfo(info);
|
|
data->Wait();
|
|
}
|
|
|
|
void set_warming_up(bool value) { is_warming_up_ = value; }
|
|
|
|
private:
|
|
void Wait() {
|
|
if (is_warming_up_) return;
|
|
double start = v8::base::OS::TimeCurrentMillis();
|
|
double duration = 0;
|
|
while (duration < min_duration_ms_) {
|
|
v8::base::OS::Sleep(v8::base::TimeDelta::FromMilliseconds(1));
|
|
duration = v8::base::OS::TimeCurrentMillis() - start;
|
|
}
|
|
}
|
|
|
|
template <typename T>
|
|
static TestApiCallbacks* FromInfo(const T& info) {
|
|
void* data = v8::External::Cast(*info.Data())->Value();
|
|
return reinterpret_cast<TestApiCallbacks*>(data);
|
|
}
|
|
|
|
int min_duration_ms_;
|
|
bool is_warming_up_;
|
|
};
|
|
|
|
|
|
// Test that native accessors are properly reported in the CPU profile.
|
|
// This test checks the case when the long-running accessors are called
|
|
// only once and the optimizer doesn't have chance to change the invocation
|
|
// code.
|
|
TEST(NativeAccessorUninitializedIC) {
|
|
LocalContext env;
|
|
v8::Isolate* isolate = env->GetIsolate();
|
|
v8::HandleScope scope(isolate);
|
|
|
|
v8::Local<v8::FunctionTemplate> func_template =
|
|
v8::FunctionTemplate::New(isolate);
|
|
v8::Local<v8::ObjectTemplate> instance_template =
|
|
func_template->InstanceTemplate();
|
|
|
|
TestApiCallbacks accessors(100);
|
|
v8::Local<v8::External> data =
|
|
v8::External::New(isolate, &accessors);
|
|
instance_template->SetAccessor(v8_str("foo"), &TestApiCallbacks::Getter,
|
|
&TestApiCallbacks::Setter, data);
|
|
v8::Local<v8::Function> func =
|
|
func_template->GetFunction(env.local()).ToLocalChecked();
|
|
v8::Local<v8::Object> instance =
|
|
func->NewInstance(env.local()).ToLocalChecked();
|
|
env->Global()->Set(env.local(), v8_str("instance"), instance).FromJust();
|
|
|
|
CompileRun(native_accessor_test_source);
|
|
v8::Local<v8::Function> function = GetFunction(env.local(), "start");
|
|
|
|
int32_t repeat_count = 1;
|
|
v8::Local<v8::Value> args[] = {v8::Integer::New(isolate, repeat_count)};
|
|
v8::CpuProfile* profile =
|
|
RunProfiler(env.local(), function, args, arraysize(args), 0, 100);
|
|
|
|
const v8::CpuProfileNode* root = profile->GetTopDownRoot();
|
|
const v8::CpuProfileNode* start_node = GetChild(env.local(), root, "start");
|
|
GetChild(env.local(), start_node, "get foo");
|
|
GetChild(env.local(), start_node, "set foo");
|
|
|
|
profile->Delete();
|
|
}
|
|
|
|
|
|
// Test that native accessors are properly reported in the CPU profile.
|
|
// This test makes sure that the accessors are called enough times to become
|
|
// hot and to trigger optimizations.
|
|
TEST(NativeAccessorMonomorphicIC) {
|
|
LocalContext env;
|
|
v8::Isolate* isolate = env->GetIsolate();
|
|
v8::HandleScope scope(isolate);
|
|
|
|
v8::Local<v8::FunctionTemplate> func_template =
|
|
v8::FunctionTemplate::New(isolate);
|
|
v8::Local<v8::ObjectTemplate> instance_template =
|
|
func_template->InstanceTemplate();
|
|
|
|
TestApiCallbacks accessors(1);
|
|
v8::Local<v8::External> data =
|
|
v8::External::New(isolate, &accessors);
|
|
instance_template->SetAccessor(v8_str("foo"), &TestApiCallbacks::Getter,
|
|
&TestApiCallbacks::Setter, data);
|
|
v8::Local<v8::Function> func =
|
|
func_template->GetFunction(env.local()).ToLocalChecked();
|
|
v8::Local<v8::Object> instance =
|
|
func->NewInstance(env.local()).ToLocalChecked();
|
|
env->Global()->Set(env.local(), v8_str("instance"), instance).FromJust();
|
|
|
|
CompileRun(native_accessor_test_source);
|
|
v8::Local<v8::Function> function = GetFunction(env.local(), "start");
|
|
|
|
{
|
|
// Make sure accessors ICs are in monomorphic state before starting
|
|
// profiling.
|
|
accessors.set_warming_up(true);
|
|
int32_t warm_up_iterations = 3;
|
|
v8::Local<v8::Value> args[] = {
|
|
v8::Integer::New(isolate, warm_up_iterations)};
|
|
function->Call(env.local(), env->Global(), arraysize(args), args)
|
|
.ToLocalChecked();
|
|
accessors.set_warming_up(false);
|
|
}
|
|
|
|
int32_t repeat_count = 100;
|
|
v8::Local<v8::Value> args[] = {v8::Integer::New(isolate, repeat_count)};
|
|
v8::CpuProfile* profile =
|
|
RunProfiler(env.local(), function, args, arraysize(args), 0, 100);
|
|
|
|
const v8::CpuProfileNode* root = profile->GetTopDownRoot();
|
|
const v8::CpuProfileNode* start_node = GetChild(env.local(), root, "start");
|
|
GetChild(env.local(), start_node, "get foo");
|
|
GetChild(env.local(), start_node, "set foo");
|
|
|
|
profile->Delete();
|
|
}
|
|
|
|
|
|
static const char* native_method_test_source = "function start(count) {\n"
|
|
" for (var i = 0; i < count; i++) {\n"
|
|
" instance.fooMethod();\n"
|
|
" }\n"
|
|
"}\n";
|
|
|
|
|
|
TEST(NativeMethodUninitializedIC) {
|
|
LocalContext env;
|
|
v8::Isolate* isolate = env->GetIsolate();
|
|
v8::HandleScope scope(isolate);
|
|
|
|
TestApiCallbacks callbacks(100);
|
|
v8::Local<v8::External> data =
|
|
v8::External::New(isolate, &callbacks);
|
|
|
|
v8::Local<v8::FunctionTemplate> func_template =
|
|
v8::FunctionTemplate::New(isolate);
|
|
func_template->SetClassName(v8_str("Test_InstanceCostructor"));
|
|
v8::Local<v8::ObjectTemplate> proto_template =
|
|
func_template->PrototypeTemplate();
|
|
v8::Local<v8::Signature> signature =
|
|
v8::Signature::New(isolate, func_template);
|
|
proto_template->Set(
|
|
v8_str("fooMethod"),
|
|
v8::FunctionTemplate::New(isolate, &TestApiCallbacks::Callback, data,
|
|
signature, 0));
|
|
|
|
v8::Local<v8::Function> func =
|
|
func_template->GetFunction(env.local()).ToLocalChecked();
|
|
v8::Local<v8::Object> instance =
|
|
func->NewInstance(env.local()).ToLocalChecked();
|
|
env->Global()->Set(env.local(), v8_str("instance"), instance).FromJust();
|
|
|
|
CompileRun(native_method_test_source);
|
|
v8::Local<v8::Function> function = GetFunction(env.local(), "start");
|
|
|
|
int32_t repeat_count = 1;
|
|
v8::Local<v8::Value> args[] = {v8::Integer::New(isolate, repeat_count)};
|
|
v8::CpuProfile* profile =
|
|
RunProfiler(env.local(), function, args, arraysize(args), 0, 100);
|
|
|
|
const v8::CpuProfileNode* root = profile->GetTopDownRoot();
|
|
const v8::CpuProfileNode* start_node = GetChild(env.local(), root, "start");
|
|
GetChild(env.local(), start_node, "fooMethod");
|
|
|
|
profile->Delete();
|
|
}
|
|
|
|
|
|
TEST(NativeMethodMonomorphicIC) {
|
|
LocalContext env;
|
|
v8::Isolate* isolate = env->GetIsolate();
|
|
v8::HandleScope scope(isolate);
|
|
|
|
TestApiCallbacks callbacks(1);
|
|
v8::Local<v8::External> data =
|
|
v8::External::New(isolate, &callbacks);
|
|
|
|
v8::Local<v8::FunctionTemplate> func_template =
|
|
v8::FunctionTemplate::New(isolate);
|
|
func_template->SetClassName(v8_str("Test_InstanceCostructor"));
|
|
v8::Local<v8::ObjectTemplate> proto_template =
|
|
func_template->PrototypeTemplate();
|
|
v8::Local<v8::Signature> signature =
|
|
v8::Signature::New(isolate, func_template);
|
|
proto_template->Set(
|
|
v8_str("fooMethod"),
|
|
v8::FunctionTemplate::New(isolate, &TestApiCallbacks::Callback, data,
|
|
signature, 0));
|
|
|
|
v8::Local<v8::Function> func =
|
|
func_template->GetFunction(env.local()).ToLocalChecked();
|
|
v8::Local<v8::Object> instance =
|
|
func->NewInstance(env.local()).ToLocalChecked();
|
|
env->Global()->Set(env.local(), v8_str("instance"), instance).FromJust();
|
|
|
|
CompileRun(native_method_test_source);
|
|
v8::Local<v8::Function> function = GetFunction(env.local(), "start");
|
|
{
|
|
// Make sure method ICs are in monomorphic state before starting
|
|
// profiling.
|
|
callbacks.set_warming_up(true);
|
|
int32_t warm_up_iterations = 3;
|
|
v8::Local<v8::Value> args[] = {
|
|
v8::Integer::New(isolate, warm_up_iterations)};
|
|
function->Call(env.local(), env->Global(), arraysize(args), args)
|
|
.ToLocalChecked();
|
|
callbacks.set_warming_up(false);
|
|
}
|
|
|
|
int32_t repeat_count = 100;
|
|
v8::Local<v8::Value> args[] = {v8::Integer::New(isolate, repeat_count)};
|
|
v8::CpuProfile* profile =
|
|
RunProfiler(env.local(), function, args, arraysize(args), 0, 200);
|
|
|
|
const v8::CpuProfileNode* root = profile->GetTopDownRoot();
|
|
GetChild(env.local(), root, "start");
|
|
const v8::CpuProfileNode* start_node = GetChild(env.local(), root, "start");
|
|
GetChild(env.local(), start_node, "fooMethod");
|
|
|
|
profile->Delete();
|
|
}
|
|
|
|
|
|
static const char* bound_function_test_source =
|
|
"function foo() {\n"
|
|
" startProfiling('my_profile');\n"
|
|
"}\n"
|
|
"function start() {\n"
|
|
" var callback = foo.bind(this);\n"
|
|
" callback();\n"
|
|
"}";
|
|
|
|
|
|
TEST(BoundFunctionCall) {
|
|
v8::HandleScope scope(CcTest::isolate());
|
|
v8::Local<v8::Context> env = CcTest::NewContext(PROFILER_EXTENSION);
|
|
v8::Context::Scope context_scope(env);
|
|
|
|
CompileRun(bound_function_test_source);
|
|
v8::Local<v8::Function> function = GetFunction(env, "start");
|
|
|
|
v8::CpuProfile* profile = RunProfiler(env, function, NULL, 0);
|
|
|
|
const v8::CpuProfileNode* root = profile->GetTopDownRoot();
|
|
|
|
const v8::CpuProfileNode* start_node = GetChild(env, root, "start");
|
|
GetChild(env, start_node, "foo");
|
|
|
|
profile->Delete();
|
|
}
|
|
|
|
// This tests checks distribution of the samples through the source lines.
|
|
static void TickLines(bool optimize) {
|
|
CcTest::InitializeVM();
|
|
LocalContext env;
|
|
i::FLAG_allow_natives_syntax = true;
|
|
i::FLAG_turbo_source_positions = true;
|
|
i::Isolate* isolate = CcTest::i_isolate();
|
|
i::Factory* factory = isolate->factory();
|
|
i::HandleScope scope(isolate);
|
|
|
|
i::EmbeddedVector<char, 512> script;
|
|
|
|
const char* func_name = "func";
|
|
const char* opt_func =
|
|
optimize ? "%OptimizeFunctionOnNextCall" : "%NeverOptimizeFunction";
|
|
i::SNPrintF(script,
|
|
"function %s() {\n"
|
|
" var n = 0;\n"
|
|
" var m = 100*100;\n"
|
|
" while (m > 1) {\n"
|
|
" m--;\n"
|
|
" n += m * m * m;\n"
|
|
" }\n"
|
|
"}\n"
|
|
"%s(%s);\n"
|
|
"%s();\n",
|
|
func_name, opt_func, func_name, func_name);
|
|
|
|
CompileRun(script.start());
|
|
|
|
i::Handle<i::JSFunction> func = i::Handle<i::JSFunction>::cast(
|
|
v8::Utils::OpenHandle(*GetFunction(env.local(), func_name)));
|
|
CHECK(func->shared());
|
|
CHECK(func->shared()->abstract_code());
|
|
i::AbstractCode* code = func->abstract_code();
|
|
CHECK(code);
|
|
i::Address code_address = code->instruction_start();
|
|
CHECK(code_address);
|
|
|
|
CpuProfilesCollection* profiles = new CpuProfilesCollection(isolate->heap());
|
|
profiles->StartProfiling("", false);
|
|
ProfileGenerator generator(profiles);
|
|
SmartPointer<ProfilerEventsProcessor> processor(new ProfilerEventsProcessor(
|
|
&generator, NULL, v8::base::TimeDelta::FromMicroseconds(100)));
|
|
processor->Start();
|
|
CpuProfiler profiler(isolate, profiles, &generator, processor.get());
|
|
|
|
// Enqueue code creation events.
|
|
i::Handle<i::String> str = factory->NewStringFromAsciiChecked(func_name);
|
|
int line = 1;
|
|
int column = 1;
|
|
profiler.CodeCreateEvent(i::Logger::FUNCTION_TAG, code, func->shared(), NULL,
|
|
*str, line, column);
|
|
|
|
// Enqueue a tick event to enable code events processing.
|
|
EnqueueTickSampleEvent(processor.get(), code_address);
|
|
|
|
processor->StopSynchronously();
|
|
|
|
CpuProfile* profile = profiles->StopProfiling("");
|
|
CHECK(profile);
|
|
|
|
// Check the state of profile generator.
|
|
CodeEntry* func_entry = generator.code_map()->FindEntry(code_address);
|
|
CHECK(func_entry);
|
|
CHECK_EQ(0, strcmp(func_name, func_entry->name()));
|
|
const i::JITLineInfoTable* line_info = func_entry->line_info();
|
|
CHECK(line_info);
|
|
CHECK(!line_info->empty());
|
|
|
|
// Check the hit source lines using V8 Public APIs.
|
|
const i::ProfileTree* tree = profile->top_down();
|
|
ProfileNode* root = tree->root();
|
|
CHECK(root);
|
|
ProfileNode* func_node = root->FindChild(func_entry);
|
|
CHECK(func_node);
|
|
|
|
// Add 10 faked ticks to source line #5.
|
|
int hit_line = 5;
|
|
int hit_count = 10;
|
|
for (int i = 0; i < hit_count; i++) func_node->IncrementLineTicks(hit_line);
|
|
|
|
unsigned int line_count = func_node->GetHitLineCount();
|
|
CHECK_EQ(2u, line_count); // Expect two hit source lines - #1 and #5.
|
|
ScopedVector<v8::CpuProfileNode::LineTick> entries(line_count);
|
|
CHECK(func_node->GetLineTicks(&entries[0], line_count));
|
|
int value = 0;
|
|
for (int i = 0; i < entries.length(); i++)
|
|
if (entries[i].line == hit_line) {
|
|
value = entries[i].hit_count;
|
|
break;
|
|
}
|
|
CHECK_EQ(hit_count, value);
|
|
}
|
|
|
|
TEST(TickLinesBaseline) { TickLines(false); }
|
|
|
|
TEST(TickLinesOptimized) { TickLines(true); }
|
|
|
|
static const char* call_function_test_source =
|
|
"%NeverOptimizeFunction(bar);\n"
|
|
"%NeverOptimizeFunction(start);\n"
|
|
"function bar(n) {\n"
|
|
" var s = 0;\n"
|
|
" for (var i = 0; i < n; i++) s += i * i * i;\n"
|
|
" return s;\n"
|
|
"}\n"
|
|
"function start(duration) {\n"
|
|
" var start = Date.now();\n"
|
|
" do {\n"
|
|
" for (var i = 0; i < 100; ++i)\n"
|
|
" bar.call(this, 1000);\n"
|
|
" } while (Date.now() - start < duration);\n"
|
|
"}";
|
|
|
|
// Test that if we sampled thread when it was inside FunctionCall buitin then
|
|
// its caller frame will be '(unresolved function)' as we have no reliable way
|
|
// to resolve it.
|
|
//
|
|
// [Top down]:
|
|
// 96 0 (root) [-1] #1
|
|
// 1 1 (garbage collector) [-1] #4
|
|
// 5 0 (unresolved function) [-1] #5
|
|
// 5 5 call [-1] #6
|
|
// 71 70 start [-1] #3
|
|
// 1 1 bar [-1] #7
|
|
// 19 19 (program) [-1] #2
|
|
TEST(FunctionCallSample) {
|
|
i::FLAG_allow_natives_syntax = true;
|
|
LocalContext env;
|
|
v8::HandleScope scope(env->GetIsolate());
|
|
|
|
// Collect garbage that might have be generated while installing
|
|
// extensions.
|
|
CcTest::heap()->CollectAllGarbage();
|
|
|
|
CompileRun(call_function_test_source);
|
|
v8::Local<v8::Function> function = GetFunction(env.local(), "start");
|
|
|
|
int32_t duration_ms = 100;
|
|
v8::Local<v8::Value> args[] = {
|
|
v8::Integer::New(env->GetIsolate(), duration_ms)};
|
|
v8::CpuProfile* profile =
|
|
RunProfiler(env.local(), function, args, arraysize(args), 1000);
|
|
|
|
const v8::CpuProfileNode* root = profile->GetTopDownRoot();
|
|
const v8::CpuProfileNode* start_node = GetChild(env.local(), root, "start");
|
|
GetChild(env.local(), start_node, "bar");
|
|
|
|
const v8::CpuProfileNode* unresolved_node = FindChild(
|
|
env.local(), root, i::ProfileGenerator::kUnresolvedFunctionName);
|
|
CHECK(!unresolved_node || GetChild(env.local(), unresolved_node, "call"));
|
|
|
|
profile->Delete();
|
|
}
|
|
|
|
static const char* function_apply_test_source =
|
|
"%NeverOptimizeFunction(bar);\n"
|
|
"%NeverOptimizeFunction(test);\n"
|
|
"%NeverOptimizeFunction(start);\n"
|
|
"function bar(n) {\n"
|
|
" var s = 0;\n"
|
|
" for (var i = 0; i < n; i++) s += i * i * i;\n"
|
|
" return s;\n"
|
|
"}\n"
|
|
"function test() {\n"
|
|
" bar.apply(this, [1000]);\n"
|
|
"}\n"
|
|
"function start(duration) {\n"
|
|
" var start = Date.now();\n"
|
|
" do {\n"
|
|
" for (var i = 0; i < 100; ++i) test();\n"
|
|
" } while (Date.now() - start < duration);\n"
|
|
"}";
|
|
|
|
// [Top down]:
|
|
// 94 0 (root) [-1] #0 1
|
|
// 2 2 (garbage collector) [-1] #0 7
|
|
// 82 49 start [-1] #16 3
|
|
// 1 0 (unresolved function) [-1] #0 8
|
|
// 1 1 apply [-1] #0 9
|
|
// 32 21 test [-1] #16 4
|
|
// 2 2 bar [-1] #16 6
|
|
// 10 10 (program) [-1] #0 2
|
|
TEST(FunctionApplySample) {
|
|
i::FLAG_allow_natives_syntax = true;
|
|
LocalContext env;
|
|
v8::HandleScope scope(env->GetIsolate());
|
|
|
|
CompileRun(function_apply_test_source);
|
|
v8::Local<v8::Function> function = GetFunction(env.local(), "start");
|
|
|
|
int32_t duration_ms = 100;
|
|
v8::Local<v8::Value> args[] = {
|
|
v8::Integer::New(env->GetIsolate(), duration_ms)};
|
|
|
|
v8::CpuProfile* profile =
|
|
RunProfiler(env.local(), function, args, arraysize(args), 1000);
|
|
|
|
const v8::CpuProfileNode* root = profile->GetTopDownRoot();
|
|
const v8::CpuProfileNode* start_node = GetChild(env.local(), root, "start");
|
|
const v8::CpuProfileNode* test_node =
|
|
GetChild(env.local(), start_node, "test");
|
|
GetChild(env.local(), test_node, "bar");
|
|
|
|
const v8::CpuProfileNode* unresolved_node = FindChild(
|
|
env.local(), start_node, ProfileGenerator::kUnresolvedFunctionName);
|
|
CHECK(!unresolved_node || GetChild(env.local(), unresolved_node, "apply"));
|
|
|
|
profile->Delete();
|
|
}
|
|
|
|
static const char* cpu_profiler_deep_stack_test_source =
|
|
"function foo(n) {\n"
|
|
" if (n)\n"
|
|
" foo(n - 1);\n"
|
|
" else\n"
|
|
" collectSample();\n"
|
|
"}\n"
|
|
"function start() {\n"
|
|
" startProfiling('my_profile');\n"
|
|
" foo(250);\n"
|
|
"}\n";
|
|
|
|
// Check a deep stack
|
|
//
|
|
// [Top down]:
|
|
// 0 (root) 0 #1
|
|
// 2 (program) 0 #2
|
|
// 0 start 21 #3 no reason
|
|
// 0 foo 21 #4 no reason
|
|
// 0 foo 21 #5 no reason
|
|
// ....
|
|
// 0 foo 21 #254 no reason
|
|
TEST(CpuProfileDeepStack) {
|
|
v8::HandleScope scope(CcTest::isolate());
|
|
v8::Local<v8::Context> env = CcTest::NewContext(PROFILER_EXTENSION);
|
|
v8::Context::Scope context_scope(env);
|
|
|
|
CompileRun(cpu_profiler_deep_stack_test_source);
|
|
v8::Local<v8::Function> function = GetFunction(env, "start");
|
|
|
|
v8::CpuProfiler* cpu_profiler = env->GetIsolate()->GetCpuProfiler();
|
|
v8::Local<v8::String> profile_name = v8_str("my_profile");
|
|
function->Call(env, env->Global(), 0, NULL).ToLocalChecked();
|
|
v8::CpuProfile* profile = cpu_profiler->StopProfiling(profile_name);
|
|
CHECK(profile);
|
|
// Dump collected profile to have a better diagnostic in case of failure.
|
|
reinterpret_cast<i::CpuProfile*>(profile)->Print();
|
|
|
|
const v8::CpuProfileNode* root = profile->GetTopDownRoot();
|
|
const v8::CpuProfileNode* node = GetChild(env, root, "start");
|
|
for (int i = 0; i <= 250; ++i) {
|
|
node = GetChild(env, node, "foo");
|
|
}
|
|
CHECK(!FindChild(env, node, "foo"));
|
|
|
|
profile->Delete();
|
|
}
|
|
|
|
static const char* js_native_js_test_source =
|
|
"%NeverOptimizeFunction(foo);\n"
|
|
"%NeverOptimizeFunction(bar);\n"
|
|
"%NeverOptimizeFunction(start);\n"
|
|
"function foo(n) {\n"
|
|
" var s = 0;\n"
|
|
" for (var i = 0; i < n; i++) s += i * i * i;\n"
|
|
" return s;\n"
|
|
"}\n"
|
|
"function bar() {\n"
|
|
" foo(1000);\n"
|
|
"}\n"
|
|
"function start() {\n"
|
|
" CallJsFunction(bar);\n"
|
|
"}";
|
|
|
|
static void CallJsFunction(const v8::FunctionCallbackInfo<v8::Value>& info) {
|
|
v8::Local<v8::Function> function = info[0].As<v8::Function>();
|
|
v8::Local<v8::Value> argv[] = {info[1]};
|
|
function->Call(info.GetIsolate()->GetCurrentContext(), info.This(),
|
|
arraysize(argv), argv)
|
|
.ToLocalChecked();
|
|
}
|
|
|
|
// [Top down]:
|
|
// 58 0 (root) #0 1
|
|
// 2 2 (program) #0 2
|
|
// 56 1 start #16 3
|
|
// 55 0 CallJsFunction #0 4
|
|
// 55 1 bar #16 5
|
|
// 54 54 foo #16 6
|
|
TEST(JsNativeJsSample) {
|
|
i::FLAG_allow_natives_syntax = true;
|
|
v8::HandleScope scope(CcTest::isolate());
|
|
v8::Local<v8::Context> env = CcTest::NewContext(PROFILER_EXTENSION);
|
|
v8::Context::Scope context_scope(env);
|
|
|
|
v8::Local<v8::FunctionTemplate> func_template = v8::FunctionTemplate::New(
|
|
env->GetIsolate(), CallJsFunction);
|
|
v8::Local<v8::Function> func =
|
|
func_template->GetFunction(env).ToLocalChecked();
|
|
func->SetName(v8_str("CallJsFunction"));
|
|
env->Global()->Set(env, v8_str("CallJsFunction"), func).FromJust();
|
|
|
|
CompileRun(js_native_js_test_source);
|
|
v8::Local<v8::Function> function = GetFunction(env, "start");
|
|
|
|
v8::CpuProfile* profile = RunProfiler(env, function, NULL, 0, 1000);
|
|
|
|
const v8::CpuProfileNode* root = profile->GetTopDownRoot();
|
|
const v8::CpuProfileNode* start_node = GetChild(env, root, "start");
|
|
const v8::CpuProfileNode* native_node =
|
|
GetChild(env, start_node, "CallJsFunction");
|
|
const v8::CpuProfileNode* bar_node = GetChild(env, native_node, "bar");
|
|
GetChild(env, bar_node, "foo");
|
|
|
|
profile->Delete();
|
|
}
|
|
|
|
static const char* js_native_js_runtime_js_test_source =
|
|
"%NeverOptimizeFunction(foo);\n"
|
|
"%NeverOptimizeFunction(bar);\n"
|
|
"%NeverOptimizeFunction(start);\n"
|
|
"function foo(n) {\n"
|
|
" var s = 0;\n"
|
|
" for (var i = 0; i < n; i++) s += i * i * i;\n"
|
|
" return s;\n"
|
|
"}\n"
|
|
"var bound = foo.bind(this);\n"
|
|
"function bar() {\n"
|
|
" bound(1000);\n"
|
|
"}\n"
|
|
"function start() {\n"
|
|
" CallJsFunction(bar);\n"
|
|
"}";
|
|
|
|
// [Top down]:
|
|
// 57 0 (root) #0 1
|
|
// 55 1 start #16 3
|
|
// 54 0 CallJsFunction #0 4
|
|
// 54 3 bar #16 5
|
|
// 51 51 foo #16 6
|
|
// 2 2 (program) #0 2
|
|
TEST(JsNativeJsRuntimeJsSample) {
|
|
i::FLAG_allow_natives_syntax = true;
|
|
v8::HandleScope scope(CcTest::isolate());
|
|
v8::Local<v8::Context> env = CcTest::NewContext(PROFILER_EXTENSION);
|
|
v8::Context::Scope context_scope(env);
|
|
|
|
v8::Local<v8::FunctionTemplate> func_template = v8::FunctionTemplate::New(
|
|
env->GetIsolate(), CallJsFunction);
|
|
v8::Local<v8::Function> func =
|
|
func_template->GetFunction(env).ToLocalChecked();
|
|
func->SetName(v8_str("CallJsFunction"));
|
|
env->Global()->Set(env, v8_str("CallJsFunction"), func).FromJust();
|
|
|
|
CompileRun(js_native_js_runtime_js_test_source);
|
|
v8::Local<v8::Function> function = GetFunction(env, "start");
|
|
v8::CpuProfile* profile = RunProfiler(env, function, NULL, 0, 1000);
|
|
|
|
const v8::CpuProfileNode* root = profile->GetTopDownRoot();
|
|
const v8::CpuProfileNode* start_node = GetChild(env, root, "start");
|
|
const v8::CpuProfileNode* native_node =
|
|
GetChild(env, start_node, "CallJsFunction");
|
|
const v8::CpuProfileNode* bar_node = GetChild(env, native_node, "bar");
|
|
GetChild(env, bar_node, "foo");
|
|
|
|
profile->Delete();
|
|
}
|
|
|
|
static void CallJsFunction2(const v8::FunctionCallbackInfo<v8::Value>& info) {
|
|
v8::base::OS::Print("In CallJsFunction2\n");
|
|
CallJsFunction(info);
|
|
}
|
|
|
|
static const char* js_native1_js_native2_js_test_source =
|
|
"%NeverOptimizeFunction(foo);\n"
|
|
"%NeverOptimizeFunction(bar);\n"
|
|
"%NeverOptimizeFunction(start);\n"
|
|
"function foo() {\n"
|
|
" var s = 0;\n"
|
|
" for (var i = 0; i < 1000; i++) s += i * i * i;\n"
|
|
" return s;\n"
|
|
"}\n"
|
|
"function bar() {\n"
|
|
" CallJsFunction2(foo);\n"
|
|
"}\n"
|
|
"function start() {\n"
|
|
" CallJsFunction1(bar);\n"
|
|
"}";
|
|
|
|
// [Top down]:
|
|
// 57 0 (root) #0 1
|
|
// 55 1 start #16 3
|
|
// 54 0 CallJsFunction1 #0 4
|
|
// 54 0 bar #16 5
|
|
// 54 0 CallJsFunction2 #0 6
|
|
// 54 54 foo #16 7
|
|
// 2 2 (program) #0 2
|
|
TEST(JsNative1JsNative2JsSample) {
|
|
i::FLAG_allow_natives_syntax = true;
|
|
v8::HandleScope scope(CcTest::isolate());
|
|
v8::Local<v8::Context> env = CcTest::NewContext(PROFILER_EXTENSION);
|
|
v8::Context::Scope context_scope(env);
|
|
|
|
v8::Local<v8::Function> func1 =
|
|
v8::FunctionTemplate::New(env->GetIsolate(), CallJsFunction)
|
|
->GetFunction(env)
|
|
.ToLocalChecked();
|
|
func1->SetName(v8_str("CallJsFunction1"));
|
|
env->Global()->Set(env, v8_str("CallJsFunction1"), func1).FromJust();
|
|
|
|
v8::Local<v8::Function> func2 =
|
|
v8::FunctionTemplate::New(env->GetIsolate(), CallJsFunction2)
|
|
->GetFunction(env)
|
|
.ToLocalChecked();
|
|
func2->SetName(v8_str("CallJsFunction2"));
|
|
env->Global()->Set(env, v8_str("CallJsFunction2"), func2).FromJust();
|
|
|
|
CompileRun(js_native1_js_native2_js_test_source);
|
|
v8::Local<v8::Function> function = GetFunction(env, "start");
|
|
|
|
v8::CpuProfile* profile = RunProfiler(env, function, NULL, 0, 1000);
|
|
|
|
const v8::CpuProfileNode* root = profile->GetTopDownRoot();
|
|
const v8::CpuProfileNode* start_node = GetChild(env, root, "start");
|
|
const v8::CpuProfileNode* native_node1 =
|
|
GetChild(env, start_node, "CallJsFunction1");
|
|
const v8::CpuProfileNode* bar_node = GetChild(env, native_node1, "bar");
|
|
const v8::CpuProfileNode* native_node2 =
|
|
GetChild(env, bar_node, "CallJsFunction2");
|
|
GetChild(env, native_node2, "foo");
|
|
|
|
profile->Delete();
|
|
}
|
|
|
|
static const char* js_force_collect_sample_source =
|
|
"function start() {\n"
|
|
" CallCollectSample();\n"
|
|
"}";
|
|
|
|
TEST(CollectSampleAPI) {
|
|
v8::HandleScope scope(CcTest::isolate());
|
|
v8::Local<v8::Context> env = CcTest::NewContext(PROFILER_EXTENSION);
|
|
v8::Context::Scope context_scope(env);
|
|
|
|
v8::Local<v8::FunctionTemplate> func_template =
|
|
v8::FunctionTemplate::New(env->GetIsolate(), CallCollectSample);
|
|
v8::Local<v8::Function> func =
|
|
func_template->GetFunction(env).ToLocalChecked();
|
|
func->SetName(v8_str("CallCollectSample"));
|
|
env->Global()->Set(env, v8_str("CallCollectSample"), func).FromJust();
|
|
|
|
CompileRun(js_force_collect_sample_source);
|
|
v8::Local<v8::Function> function = GetFunction(env, "start");
|
|
v8::CpuProfile* profile = RunProfiler(env, function, NULL, 0, 0);
|
|
|
|
const v8::CpuProfileNode* root = profile->GetTopDownRoot();
|
|
const v8::CpuProfileNode* start_node = GetChild(env, root, "start");
|
|
CHECK_LE(1, start_node->GetChildrenCount());
|
|
GetChild(env, start_node, "CallCollectSample");
|
|
|
|
profile->Delete();
|
|
}
|
|
|
|
static const char* js_native_js_runtime_multiple_test_source =
|
|
"%NeverOptimizeFunction(foo);\n"
|
|
"%NeverOptimizeFunction(bar);\n"
|
|
"%NeverOptimizeFunction(start);\n"
|
|
"function foo() {\n"
|
|
" return Math.sin(Math.random());\n"
|
|
"}\n"
|
|
"var bound = foo.bind(this);\n"
|
|
"function bar() {\n"
|
|
" return bound();\n"
|
|
"}\n"
|
|
"function start() {\n"
|
|
" startProfiling('my_profile');\n"
|
|
" var startTime = Date.now();\n"
|
|
" do {\n"
|
|
" CallJsFunction(bar);\n"
|
|
" } while (Date.now() - startTime < 200);\n"
|
|
"}";
|
|
|
|
// The test check multiple entrances/exits between JS and native code.
|
|
//
|
|
// [Top down]:
|
|
// (root) #0 1
|
|
// start #16 3
|
|
// CallJsFunction #0 4
|
|
// bar #16 5
|
|
// foo #16 6
|
|
// (program) #0 2
|
|
TEST(JsNativeJsRuntimeJsSampleMultiple) {
|
|
i::FLAG_allow_natives_syntax = true;
|
|
v8::HandleScope scope(CcTest::isolate());
|
|
v8::Local<v8::Context> env = CcTest::NewContext(PROFILER_EXTENSION);
|
|
v8::Context::Scope context_scope(env);
|
|
|
|
v8::Local<v8::FunctionTemplate> func_template =
|
|
v8::FunctionTemplate::New(env->GetIsolate(), CallJsFunction);
|
|
v8::Local<v8::Function> func =
|
|
func_template->GetFunction(env).ToLocalChecked();
|
|
func->SetName(v8_str("CallJsFunction"));
|
|
env->Global()->Set(env, v8_str("CallJsFunction"), func).FromJust();
|
|
|
|
CompileRun(js_native_js_runtime_multiple_test_source);
|
|
v8::Local<v8::Function> function = GetFunction(env, "start");
|
|
|
|
v8::CpuProfile* profile = RunProfiler(env, function, NULL, 0, 500, 500);
|
|
|
|
const v8::CpuProfileNode* root = profile->GetTopDownRoot();
|
|
const v8::CpuProfileNode* start_node = GetChild(env, root, "start");
|
|
const v8::CpuProfileNode* native_node =
|
|
GetChild(env, start_node, "CallJsFunction");
|
|
const v8::CpuProfileNode* bar_node = GetChild(env, native_node, "bar");
|
|
GetChild(env, bar_node, "foo");
|
|
|
|
profile->Delete();
|
|
}
|
|
|
|
static const char* inlining_test_source =
|
|
"%NeverOptimizeFunction(action);\n"
|
|
"%NeverOptimizeFunction(start);\n"
|
|
"%OptimizeFunctionOnNextCall(level1);\n"
|
|
"%OptimizeFunctionOnNextCall(level2);\n"
|
|
"%OptimizeFunctionOnNextCall(level3);\n"
|
|
"var finish = false;\n"
|
|
"function action(n) {\n"
|
|
" var s = 0;\n"
|
|
" for (var i = 0; i < n; ++i) s += i*i*i;\n"
|
|
" if (finish)\n"
|
|
" startProfiling('my_profile');\n"
|
|
" return s;\n"
|
|
"}\n"
|
|
"function level3() { return action(100); }\n"
|
|
"function level2() { return level3() * 2; }\n"
|
|
"function level1() { return level2(); }\n"
|
|
"function start() {\n"
|
|
" var n = 100;\n"
|
|
" while (--n)\n"
|
|
" level1();\n"
|
|
" finish = true;\n"
|
|
" level1();\n"
|
|
"}";
|
|
|
|
// The test check multiple entrances/exits between JS and native code.
|
|
//
|
|
// [Top down]:
|
|
// (root) #0 1
|
|
// start #16 3
|
|
// level1 #0 4
|
|
// level2 #16 5
|
|
// level3 #16 6
|
|
// action #16 7
|
|
// (program) #0 2
|
|
TEST(Inlining) {
|
|
i::FLAG_allow_natives_syntax = true;
|
|
v8::HandleScope scope(CcTest::isolate());
|
|
v8::Local<v8::Context> env = CcTest::NewContext(PROFILER_EXTENSION);
|
|
v8::Context::Scope context_scope(env);
|
|
|
|
CompileRun(inlining_test_source);
|
|
v8::Local<v8::Function> function = GetFunction(env, "start");
|
|
|
|
v8::CpuProfiler* cpu_profiler = env->GetIsolate()->GetCpuProfiler();
|
|
v8::Local<v8::String> profile_name = v8_str("my_profile");
|
|
function->Call(env, env->Global(), 0, NULL).ToLocalChecked();
|
|
v8::CpuProfile* profile = cpu_profiler->StopProfiling(profile_name);
|
|
CHECK(profile);
|
|
// Dump collected profile to have a better diagnostic in case of failure.
|
|
reinterpret_cast<i::CpuProfile*>(profile)->Print();
|
|
|
|
const v8::CpuProfileNode* root = profile->GetTopDownRoot();
|
|
const v8::CpuProfileNode* start_node = GetChild(env, root, "start");
|
|
const v8::CpuProfileNode* level1_node = GetChild(env, start_node, "level1");
|
|
const v8::CpuProfileNode* level2_node = GetChild(env, level1_node, "level2");
|
|
const v8::CpuProfileNode* level3_node = GetChild(env, level2_node, "level3");
|
|
GetChild(env, level3_node, "action");
|
|
|
|
profile->Delete();
|
|
}
|
|
|
|
// [Top down]:
|
|
// 0 (root) #0 1
|
|
// 2 (program) #0 2
|
|
// 3 (idle) #0 3
|
|
TEST(IdleTime) {
|
|
LocalContext env;
|
|
v8::HandleScope scope(env->GetIsolate());
|
|
v8::CpuProfiler* cpu_profiler = env->GetIsolate()->GetCpuProfiler();
|
|
|
|
v8::Local<v8::String> profile_name = v8_str("my_profile");
|
|
cpu_profiler->StartProfiling(profile_name);
|
|
|
|
i::Isolate* isolate = CcTest::i_isolate();
|
|
i::ProfilerEventsProcessor* processor = isolate->cpu_profiler()->processor();
|
|
|
|
processor->AddCurrentStack(isolate, true);
|
|
cpu_profiler->SetIdle(true);
|
|
for (int i = 0; i < 3; i++) {
|
|
processor->AddCurrentStack(isolate, true);
|
|
}
|
|
cpu_profiler->SetIdle(false);
|
|
processor->AddCurrentStack(isolate, true);
|
|
|
|
v8::CpuProfile* profile = cpu_profiler->StopProfiling(profile_name);
|
|
CHECK(profile);
|
|
// Dump collected profile to have a better diagnostic in case of failure.
|
|
reinterpret_cast<i::CpuProfile*>(profile)->Print();
|
|
|
|
const v8::CpuProfileNode* root = profile->GetTopDownRoot();
|
|
const v8::CpuProfileNode* program_node =
|
|
GetChild(env.local(), root, ProfileGenerator::kProgramEntryName);
|
|
CHECK_EQ(0, program_node->GetChildrenCount());
|
|
CHECK_GE(program_node->GetHitCount(), 2u);
|
|
|
|
const v8::CpuProfileNode* idle_node =
|
|
GetChild(env.local(), root, ProfileGenerator::kIdleEntryName);
|
|
CHECK_EQ(0, idle_node->GetChildrenCount());
|
|
CHECK_GE(idle_node->GetHitCount(), 3u);
|
|
|
|
profile->Delete();
|
|
}
|
|
|
|
static void CheckFunctionDetails(v8::Isolate* isolate,
|
|
const v8::CpuProfileNode* node,
|
|
const char* name, const char* script_name,
|
|
int script_id, int line, int column) {
|
|
v8::Local<v8::Context> context = isolate->GetCurrentContext();
|
|
CHECK(v8_str(name)->Equals(context, node->GetFunctionName()).FromJust());
|
|
CHECK(v8_str(script_name)
|
|
->Equals(context, node->GetScriptResourceName())
|
|
.FromJust());
|
|
CHECK_EQ(script_id, node->GetScriptId());
|
|
CHECK_EQ(line, node->GetLineNumber());
|
|
CHECK_EQ(column, node->GetColumnNumber());
|
|
}
|
|
|
|
|
|
TEST(FunctionDetails) {
|
|
i::FLAG_allow_natives_syntax = true;
|
|
v8::HandleScope scope(CcTest::isolate());
|
|
v8::Local<v8::Context> env = CcTest::NewContext(PROFILER_EXTENSION);
|
|
v8::Context::Scope context_scope(env);
|
|
|
|
v8::Local<v8::Script> script_a = CompileWithOrigin(
|
|
"%NeverOptimizeFunction(foo);\n"
|
|
"%NeverOptimizeFunction(bar);\n"
|
|
" function foo\n() { bar(); }\n"
|
|
" function bar() { startProfiling(); }\n",
|
|
"script_a");
|
|
script_a->Run(env).ToLocalChecked();
|
|
v8::Local<v8::Script> script_b = CompileWithOrigin(
|
|
"%NeverOptimizeFunction(baz);"
|
|
"\n\n function baz() { foo(); }\n"
|
|
"\n\nbaz();\n"
|
|
"stopProfiling();\n",
|
|
"script_b");
|
|
script_b->Run(env).ToLocalChecked();
|
|
const v8::CpuProfile* profile = i::ProfilerExtension::last_profile;
|
|
const v8::CpuProfileNode* current = profile->GetTopDownRoot();
|
|
reinterpret_cast<ProfileNode*>(
|
|
const_cast<v8::CpuProfileNode*>(current))->Print(0);
|
|
// The tree should look like this:
|
|
// 0 (root) 0 #1
|
|
// 0 "" 19 #2 no reason script_b:1
|
|
// 0 baz 19 #3 TryCatchStatement script_b:3
|
|
// 0 foo 18 #4 TryCatchStatement script_a:2
|
|
// 1 bar 18 #5 no reason script_a:3
|
|
const v8::CpuProfileNode* root = profile->GetTopDownRoot();
|
|
const v8::CpuProfileNode* script = GetChild(env, root, "");
|
|
CheckFunctionDetails(env->GetIsolate(), script, "", "script_b",
|
|
script_b->GetUnboundScript()->GetId(), 1, 1);
|
|
const v8::CpuProfileNode* baz = GetChild(env, script, "baz");
|
|
CheckFunctionDetails(env->GetIsolate(), baz, "baz", "script_b",
|
|
script_b->GetUnboundScript()->GetId(), 3, 16);
|
|
const v8::CpuProfileNode* foo = GetChild(env, baz, "foo");
|
|
CheckFunctionDetails(env->GetIsolate(), foo, "foo", "script_a",
|
|
script_a->GetUnboundScript()->GetId(), 4, 1);
|
|
const v8::CpuProfileNode* bar = GetChild(env, foo, "bar");
|
|
CheckFunctionDetails(env->GetIsolate(), bar, "bar", "script_a",
|
|
script_a->GetUnboundScript()->GetId(), 5, 14);
|
|
}
|
|
|
|
|
|
TEST(DontStopOnFinishedProfileDelete) {
|
|
v8::HandleScope scope(CcTest::isolate());
|
|
v8::Local<v8::Context> env = CcTest::NewContext(PROFILER_EXTENSION);
|
|
v8::Context::Scope context_scope(env);
|
|
|
|
v8::CpuProfiler* profiler = env->GetIsolate()->GetCpuProfiler();
|
|
i::CpuProfiler* iprofiler = reinterpret_cast<i::CpuProfiler*>(profiler);
|
|
|
|
CHECK_EQ(0, iprofiler->GetProfilesCount());
|
|
v8::Local<v8::String> outer = v8_str("outer");
|
|
profiler->StartProfiling(outer);
|
|
CHECK_EQ(0, iprofiler->GetProfilesCount());
|
|
|
|
v8::Local<v8::String> inner = v8_str("inner");
|
|
profiler->StartProfiling(inner);
|
|
CHECK_EQ(0, iprofiler->GetProfilesCount());
|
|
|
|
v8::CpuProfile* inner_profile = profiler->StopProfiling(inner);
|
|
CHECK(inner_profile);
|
|
CHECK_EQ(1, iprofiler->GetProfilesCount());
|
|
inner_profile->Delete();
|
|
inner_profile = NULL;
|
|
CHECK_EQ(0, iprofiler->GetProfilesCount());
|
|
|
|
v8::CpuProfile* outer_profile = profiler->StopProfiling(outer);
|
|
CHECK(outer_profile);
|
|
CHECK_EQ(1, iprofiler->GetProfilesCount());
|
|
outer_profile->Delete();
|
|
outer_profile = NULL;
|
|
CHECK_EQ(0, iprofiler->GetProfilesCount());
|
|
}
|
|
|
|
|
|
const char* GetBranchDeoptReason(v8::Local<v8::Context> context,
|
|
i::CpuProfile* iprofile, const char* branch[],
|
|
int length) {
|
|
v8::CpuProfile* profile = reinterpret_cast<v8::CpuProfile*>(iprofile);
|
|
const ProfileNode* iopt_function = NULL;
|
|
iopt_function = GetSimpleBranch(context, profile, branch, length);
|
|
CHECK_EQ(1U, iopt_function->deopt_infos().size());
|
|
return iopt_function->deopt_infos()[0].deopt_reason;
|
|
}
|
|
|
|
|
|
// deopt at top function
|
|
TEST(CollectDeoptEvents) {
|
|
if (!CcTest::i_isolate()->use_crankshaft() || i::FLAG_always_opt) return;
|
|
i::FLAG_allow_natives_syntax = true;
|
|
v8::HandleScope scope(CcTest::isolate());
|
|
v8::Local<v8::Context> env = CcTest::NewContext(PROFILER_EXTENSION);
|
|
v8::Context::Scope context_scope(env);
|
|
v8::Isolate* isolate = env->GetIsolate();
|
|
v8::CpuProfiler* profiler = isolate->GetCpuProfiler();
|
|
i::CpuProfiler* iprofiler = reinterpret_cast<i::CpuProfiler*>(profiler);
|
|
|
|
const char opt_source[] =
|
|
"function opt_function%d(value, depth) {\n"
|
|
" if (depth) return opt_function%d(value, depth - 1);\n"
|
|
"\n"
|
|
" return 10 / value;\n"
|
|
"}\n"
|
|
"\n";
|
|
|
|
for (int i = 0; i < 3; ++i) {
|
|
i::EmbeddedVector<char, sizeof(opt_source) + 100> buffer;
|
|
i::SNPrintF(buffer, opt_source, i, i);
|
|
v8::Script::Compile(env, v8_str(buffer.start()))
|
|
.ToLocalChecked()
|
|
->Run(env)
|
|
.ToLocalChecked();
|
|
}
|
|
|
|
const char* source =
|
|
"startProfiling();\n"
|
|
"\n"
|
|
"opt_function0(1, 1);\n"
|
|
"\n"
|
|
"%OptimizeFunctionOnNextCall(opt_function0)\n"
|
|
"\n"
|
|
"opt_function0(1, 1);\n"
|
|
"\n"
|
|
"opt_function0(undefined, 1);\n"
|
|
"\n"
|
|
"opt_function1(1, 1);\n"
|
|
"\n"
|
|
"%OptimizeFunctionOnNextCall(opt_function1)\n"
|
|
"\n"
|
|
"opt_function1(1, 1);\n"
|
|
"\n"
|
|
"opt_function1(NaN, 1);\n"
|
|
"\n"
|
|
"opt_function2(1, 1);\n"
|
|
"\n"
|
|
"%OptimizeFunctionOnNextCall(opt_function2)\n"
|
|
"\n"
|
|
"opt_function2(1, 1);\n"
|
|
"\n"
|
|
"opt_function2(0, 1);\n"
|
|
"\n"
|
|
"stopProfiling();\n"
|
|
"\n";
|
|
|
|
v8::Script::Compile(env, v8_str(source))
|
|
.ToLocalChecked()
|
|
->Run(env)
|
|
.ToLocalChecked();
|
|
i::CpuProfile* iprofile = iprofiler->GetProfile(0);
|
|
iprofile->Print();
|
|
/* The expected profile
|
|
[Top down]:
|
|
0 (root) 0 #1
|
|
23 32 #2
|
|
1 opt_function2 31 #7
|
|
1 opt_function2 31 #8
|
|
;;; deopted at script_id: 31 position: 106 with reason
|
|
'division by zero'.
|
|
2 opt_function0 29 #3
|
|
4 opt_function0 29 #4
|
|
;;; deopted at script_id: 29 position: 108 with reason 'not a
|
|
heap number'.
|
|
0 opt_function1 30 #5
|
|
1 opt_function1 30 #6
|
|
;;; deopted at script_id: 30 position: 108 with reason 'lost
|
|
precision or NaN'.
|
|
*/
|
|
|
|
{
|
|
const char* branch[] = {"", "opt_function0", "opt_function0"};
|
|
CHECK_EQ(reason(i::Deoptimizer::kNotAHeapNumber),
|
|
GetBranchDeoptReason(env, iprofile, branch, arraysize(branch)));
|
|
}
|
|
{
|
|
const char* branch[] = {"", "opt_function1", "opt_function1"};
|
|
const char* deopt_reason =
|
|
GetBranchDeoptReason(env, iprofile, branch, arraysize(branch));
|
|
if (deopt_reason != reason(i::Deoptimizer::kNaN) &&
|
|
deopt_reason != reason(i::Deoptimizer::kLostPrecisionOrNaN)) {
|
|
FATAL(deopt_reason);
|
|
}
|
|
}
|
|
{
|
|
const char* branch[] = {"", "opt_function2", "opt_function2"};
|
|
CHECK_EQ(reason(i::Deoptimizer::kDivisionByZero),
|
|
GetBranchDeoptReason(env, iprofile, branch, arraysize(branch)));
|
|
}
|
|
iprofiler->DeleteProfile(iprofile);
|
|
}
|
|
|
|
|
|
TEST(SourceLocation) {
|
|
i::FLAG_always_opt = true;
|
|
i::FLAG_hydrogen_track_positions = true;
|
|
LocalContext env;
|
|
v8::HandleScope scope(CcTest::isolate());
|
|
|
|
const char* source =
|
|
"function CompareStatementWithThis() {\n"
|
|
" if (this === 1) {}\n"
|
|
"}\n"
|
|
"CompareStatementWithThis();\n";
|
|
|
|
v8::Script::Compile(env.local(), v8_str(source))
|
|
.ToLocalChecked()
|
|
->Run(env.local())
|
|
.ToLocalChecked();
|
|
}
|
|
|
|
|
|
static const char* inlined_source =
|
|
"function opt_function(left, right) { var k = left / 10; var r = 10 / "
|
|
"right; return k + r; }\n";
|
|
// 0.........1.........2.........3.........4....*....5.........6......*..7
|
|
|
|
|
|
// deopt at the first level inlined function
|
|
TEST(DeoptAtFirstLevelInlinedSource) {
|
|
if (!CcTest::i_isolate()->use_crankshaft() || i::FLAG_always_opt) return;
|
|
i::FLAG_allow_natives_syntax = true;
|
|
v8::HandleScope scope(CcTest::isolate());
|
|
v8::Local<v8::Context> env = CcTest::NewContext(PROFILER_EXTENSION);
|
|
v8::Context::Scope context_scope(env);
|
|
v8::Isolate* isolate = env->GetIsolate();
|
|
v8::CpuProfiler* profiler = isolate->GetCpuProfiler();
|
|
i::CpuProfiler* iprofiler = reinterpret_cast<i::CpuProfiler*>(profiler);
|
|
|
|
// 0.........1.........2.........3.........4.........5.........6.........7
|
|
const char* source =
|
|
"function test(left, right) { return opt_function(left, right); }\n"
|
|
"\n"
|
|
"startProfiling();\n"
|
|
"\n"
|
|
"test(10, 10);\n"
|
|
"\n"
|
|
"%OptimizeFunctionOnNextCall(test)\n"
|
|
"\n"
|
|
"test(10, 10);\n"
|
|
"\n"
|
|
"test(undefined, 10);\n"
|
|
"\n"
|
|
"stopProfiling();\n"
|
|
"\n";
|
|
|
|
v8::Local<v8::Script> inlined_script = v8_compile(inlined_source);
|
|
inlined_script->Run(env).ToLocalChecked();
|
|
int inlined_script_id = inlined_script->GetUnboundScript()->GetId();
|
|
|
|
v8::Local<v8::Script> script = v8_compile(source);
|
|
script->Run(env).ToLocalChecked();
|
|
int script_id = script->GetUnboundScript()->GetId();
|
|
|
|
i::CpuProfile* iprofile = iprofiler->GetProfile(0);
|
|
iprofile->Print();
|
|
/* The expected profile output
|
|
[Top down]:
|
|
0 (root) 0 #1
|
|
10 30 #2
|
|
1 test 30 #3
|
|
;;; deopted at script_id: 29 position: 45 with reason 'not a
|
|
heap number'.
|
|
;;; Inline point: script_id 30 position: 36.
|
|
4 opt_function 29 #4
|
|
*/
|
|
v8::CpuProfile* profile = reinterpret_cast<v8::CpuProfile*>(iprofile);
|
|
|
|
const char* branch[] = {"", "test"};
|
|
const ProfileNode* itest_node =
|
|
GetSimpleBranch(env, profile, branch, arraysize(branch));
|
|
const std::vector<v8::CpuProfileDeoptInfo>& deopt_infos =
|
|
itest_node->deopt_infos();
|
|
CHECK_EQ(1U, deopt_infos.size());
|
|
|
|
const v8::CpuProfileDeoptInfo& info = deopt_infos[0];
|
|
CHECK_EQ(reason(i::Deoptimizer::kNotAHeapNumber), info.deopt_reason);
|
|
CHECK_EQ(2U, info.stack.size());
|
|
CHECK_EQ(inlined_script_id, info.stack[0].script_id);
|
|
CHECK_EQ(offset(inlined_source, "left /"), info.stack[0].position);
|
|
CHECK_EQ(script_id, info.stack[1].script_id);
|
|
CHECK_EQ(offset(source, "opt_function(left,"), info.stack[1].position);
|
|
|
|
iprofiler->DeleteProfile(iprofile);
|
|
}
|
|
|
|
|
|
// deopt at the second level inlined function
|
|
TEST(DeoptAtSecondLevelInlinedSource) {
|
|
if (!CcTest::i_isolate()->use_crankshaft() || i::FLAG_always_opt) return;
|
|
i::FLAG_allow_natives_syntax = true;
|
|
v8::HandleScope scope(CcTest::isolate());
|
|
v8::Local<v8::Context> env = CcTest::NewContext(PROFILER_EXTENSION);
|
|
v8::Context::Scope context_scope(env);
|
|
v8::Isolate* isolate = env->GetIsolate();
|
|
v8::CpuProfiler* profiler = isolate->GetCpuProfiler();
|
|
i::CpuProfiler* iprofiler = reinterpret_cast<i::CpuProfiler*>(profiler);
|
|
|
|
// 0.........1.........2.........3.........4.........5.........6.........7
|
|
const char* source =
|
|
"function test2(left, right) { return opt_function(left, right); }\n"
|
|
"function test1(left, right) { return test2(left, right); }\n"
|
|
"\n"
|
|
"startProfiling();\n"
|
|
"\n"
|
|
"test1(10, 10);\n"
|
|
"\n"
|
|
"%OptimizeFunctionOnNextCall(test1)\n"
|
|
"\n"
|
|
"test1(10, 10);\n"
|
|
"\n"
|
|
"test1(undefined, 10);\n"
|
|
"\n"
|
|
"stopProfiling();\n"
|
|
"\n";
|
|
|
|
v8::Local<v8::Script> inlined_script = v8_compile(inlined_source);
|
|
inlined_script->Run(env).ToLocalChecked();
|
|
int inlined_script_id = inlined_script->GetUnboundScript()->GetId();
|
|
|
|
v8::Local<v8::Script> script = v8_compile(source);
|
|
script->Run(env).ToLocalChecked();
|
|
int script_id = script->GetUnboundScript()->GetId();
|
|
|
|
i::CpuProfile* iprofile = iprofiler->GetProfile(0);
|
|
iprofile->Print();
|
|
/* The expected profile output
|
|
[Top down]:
|
|
0 (root) 0 #1
|
|
11 30 #2
|
|
1 test1 30 #3
|
|
;;; deopted at script_id: 29 position: 45 with reason 'not a
|
|
heap number'.
|
|
;;; Inline point: script_id 30 position: 37.
|
|
;;; Inline point: script_id 30 position: 103.
|
|
1 test2 30 #4
|
|
3 opt_function 29 #5
|
|
*/
|
|
|
|
v8::CpuProfile* profile = reinterpret_cast<v8::CpuProfile*>(iprofile);
|
|
|
|
const char* branch[] = {"", "test1"};
|
|
const ProfileNode* itest_node =
|
|
GetSimpleBranch(env, profile, branch, arraysize(branch));
|
|
const std::vector<v8::CpuProfileDeoptInfo>& deopt_infos =
|
|
itest_node->deopt_infos();
|
|
CHECK_EQ(1U, deopt_infos.size());
|
|
|
|
const v8::CpuProfileDeoptInfo info = deopt_infos[0];
|
|
CHECK_EQ(reason(i::Deoptimizer::kNotAHeapNumber), info.deopt_reason);
|
|
CHECK_EQ(3U, info.stack.size());
|
|
CHECK_EQ(inlined_script_id, info.stack[0].script_id);
|
|
CHECK_EQ(offset(inlined_source, "left /"), info.stack[0].position);
|
|
CHECK_EQ(script_id, info.stack[1].script_id);
|
|
CHECK_EQ(offset(source, "opt_function(left,"), info.stack[1].position);
|
|
CHECK_EQ(offset(source, "test2(left, right);"), info.stack[2].position);
|
|
|
|
iprofiler->DeleteProfile(iprofile);
|
|
}
|
|
|
|
|
|
// deopt in untracked function
|
|
TEST(DeoptUntrackedFunction) {
|
|
if (!CcTest::i_isolate()->use_crankshaft() || i::FLAG_always_opt) return;
|
|
i::FLAG_allow_natives_syntax = true;
|
|
v8::HandleScope scope(CcTest::isolate());
|
|
v8::Local<v8::Context> env = CcTest::NewContext(PROFILER_EXTENSION);
|
|
v8::Context::Scope context_scope(env);
|
|
v8::Isolate* isolate = env->GetIsolate();
|
|
v8::CpuProfiler* profiler = isolate->GetCpuProfiler();
|
|
i::CpuProfiler* iprofiler = reinterpret_cast<i::CpuProfiler*>(profiler);
|
|
|
|
// 0.........1.........2.........3.........4.........5.........6.........7
|
|
const char* source =
|
|
"function test(left, right) { return opt_function(left, right); }\n"
|
|
"\n"
|
|
"test(10, 10);\n"
|
|
"\n"
|
|
"%OptimizeFunctionOnNextCall(test)\n"
|
|
"\n"
|
|
"test(10, 10);\n"
|
|
"\n"
|
|
"startProfiling();\n" // profiler started after compilation.
|
|
"\n"
|
|
"test(undefined, 10);\n"
|
|
"\n"
|
|
"stopProfiling();\n"
|
|
"\n";
|
|
|
|
v8::Local<v8::Script> inlined_script = v8_compile(inlined_source);
|
|
inlined_script->Run(env).ToLocalChecked();
|
|
|
|
v8::Local<v8::Script> script = v8_compile(source);
|
|
script->Run(env).ToLocalChecked();
|
|
|
|
i::CpuProfile* iprofile = iprofiler->GetProfile(0);
|
|
iprofile->Print();
|
|
v8::CpuProfile* profile = reinterpret_cast<v8::CpuProfile*>(iprofile);
|
|
|
|
const char* branch[] = {"", "test"};
|
|
const ProfileNode* itest_node =
|
|
GetSimpleBranch(env, profile, branch, arraysize(branch));
|
|
CHECK_EQ(0U, itest_node->deopt_infos().size());
|
|
|
|
iprofiler->DeleteProfile(iprofile);
|
|
}
|
|
|