Bug #18907
Updated by ivoanjo (Ivo Anjo) over 2 years ago
Howdy! I'm working at Datadog [on the `ddtrace` gem](https://github.com/DataDog/dd-trace-rb), and we're starting to make use of the `rb_profile_frames` API for our continuous profiler.
While comparing the output of `rb_profile_frames` for `Thread.main` with the regular `Thread.main.backtrace_locations` I noticed we get **one** more frame at the base of the stack.
This is the dummy frame that gets skipped on `backtrace_each` (https://github.com/ruby/ruby/blob/2733c049674298cbc2130689a0a40013f3458755/vm_backtrace.c#L890) and `rb_ec_parcial_backtrace_object` (https://github.com/ruby/ruby/blob/2733c049674298cbc2130689a0a40013f3458755/vm_backtrace.c#L605) but is not skipped by `rb_profile_frames`.
For instance, adding the following test code to `test/-ext-/debug/test_profile_frames.rb`:
```ruby
def test_compare_apis
backtrace_locations, profile_frames = [Thread.current.backtrace_locations, Bug::Debug.profile_frames(0, 100)]
puts '---'
puts backtrace_locations.size
puts backtrace_locations
puts '---'
puts profile_frames.size
profile_frames.each { puts _1.to_s }
puts '---'
end
```
and then running it with `make test/-ext-/debug/test_profile_frames.rb` yields:
```
[3/4] TestProfileFrames#test_compare_apis---
27
ruby-master/test/-ext-/debug/test_profile_frames.rb:141:in `backtrace_locations'
ruby-master/test/-ext-/debug/test_profile_frames.rb:141:in `test_compare_apis'
ruby-master/tool/lib/test/unit/testcase.rb:200:in `run_test'
ruby-master/tool/lib/test/unit/testcase.rb:168:in `run'
ruby-master/tool/lib/test/unit.rb:1563:in `block in _run_suite'
ruby-master/tool/lib/test/unit.rb:1550:in `map'
ruby-master/tool/lib/test/unit.rb:1550:in `_run_suite'
ruby-master/tool/lib/test/unit.rb:1343:in `_run_suite'
ruby-master/tool/lib/test/unit.rb:812:in `block in _run_suites'
ruby-master/tool/lib/test/unit.rb:810:in `each'
ruby-master/tool/lib/test/unit.rb:810:in `_run_suites'
ruby-master/tool/lib/test/unit.rb:847:in `_run_suites'
ruby-master/tool/lib/test/unit.rb:1496:in `_run_anything'
ruby-master/tool/lib/test/unit.rb:1280:in `_run_anything'
ruby-master/tool/lib/test/unit.rb:1671:in `run_tests'
ruby-master/tool/lib/test/unit.rb:1658:in `block in _run'
ruby-master/tool/lib/test/unit.rb:1657:in `each'
ruby-master/tool/lib/test/unit.rb:1657:in `_run'
ruby-master/tool/lib/test/unit.rb:1700:in `run'
ruby-master/tool/lib/test/unit.rb:1032:in `run'
ruby-master/tool/lib/test/unit.rb:880:in `run'
ruby-master/tool/lib/test/unit.rb:154:in `run'
ruby-master/tool/lib/test/unit.rb:1779:in `run'
ruby-master/tool/lib/test/unit.rb:1783:in `run'
ruby-master/tool/test/runner.rb:23:in `<top (required)>'
./test/runner.rb:14:in `require_relative'
./test/runner.rb:14:in `<main>' # <--- FRAME IN MAIN
---
28
[nil, "<cfunc>", nil, nil, "Bug::Debug.profile_frames", nil, "Bug::Debug", true, "profile_frames", "Bug::Debug.profile_frames", 0]
["ruby-master/test/-ext-/debug/test_profile_frames.rb", "ruby-master/test/-ext-/debug/test_profile_frames.rb", "test_compare_apis", "test_compare_apis", "TestProfileFrames#test_compare_apis", 140, "TestProfileFrames", false, "test_compare_apis", "TestProfileFrames#test_compare_apis", 141]
["ruby-master/tool/lib/test/unit/testcase.rb", "ruby-master/tool/lib/test/unit/testcase.rb", "run_test", "run_test", "Test::Unit::TestCase#run_test", 198, "Test::Unit::TestCase", false, "run_test", "Test::Unit::TestCase#run_test", 200]
["ruby-master/tool/lib/test/unit/testcase.rb", "ruby-master/tool/lib/test/unit/testcase.rb", "run", "run", "Test::Unit::TestCase#run", 146, "Test::Unit::TestCase", false, "run", "Test::Unit::TestCase#run", 168]
["ruby-master/tool/lib/test/unit.rb", "ruby-master/tool/lib/test/unit.rb", "_run_suite", "_run_suite", "Test::Unit::Runner#_run_suite", 1530, "Test::Unit::Runner", false, "_run_suite", "Test::Unit::Runner#_run_suite", 1563]
[nil, "<cfunc>", nil, nil, "Array#map", nil, "Array", false, "map", "Array#map", 0]
["ruby-master/tool/lib/test/unit.rb", "ruby-master/tool/lib/test/unit.rb", "_run_suite", "_run_suite", "Test::Unit::Runner#_run_suite", 1530, "Test::Unit::Runner", false, "_run_suite", "Test::Unit::Runner#_run_suite", 1550]
["ruby-master/tool/lib/test/unit.rb", "ruby-master/tool/lib/test/unit.rb", "_run_suite", "_run_suite", "Test::Unit::ExcludesOption#_run_suite", 1339, "Test::Unit::ExcludesOption", false, "_run_suite", "Test::Unit::ExcludesOption#_run_suite", 1343]
["ruby-master/tool/lib/test/unit.rb", "ruby-master/tool/lib/test/unit.rb", "_run_suites", "_run_suites", "Test::Unit::Parallel#_run_suites", 802, "Test::Unit::Parallel", false, "_run_suites", "Test::Unit::Parallel#_run_suites", 812]
[nil, "<cfunc>", nil, nil, "Array#each", nil, "Array", false, "each", "Array#each", 0]
["ruby-master/tool/lib/test/unit.rb", "ruby-master/tool/lib/test/unit.rb", "_run_suites", "_run_suites", "Test::Unit::Parallel#_run_suites", 802, "Test::Unit::Parallel", false, "_run_suites", "Test::Unit::Parallel#_run_suites", 810]
["ruby-master/tool/lib/test/unit.rb", "ruby-master/tool/lib/test/unit.rb", "_run_suites", "_run_suites", "Test::Unit::Skipping#_run_suites", 846, "Test::Unit::Skipping", false, "_run_suites", "Test::Unit::Skipping#_run_suites", 847]
["ruby-master/tool/lib/test/unit.rb", "ruby-master/tool/lib/test/unit.rb", "_run_anything", "_run_anything", "Test::Unit::Runner#_run_anything", 1477, "Test::Unit::Runner", false, "_run_anything", "Test::Unit::Runner#_run_anything", 1496]
["ruby-master/tool/lib/test/unit.rb", "ruby-master/tool/lib/test/unit.rb", "_run_anything", "_run_anything", "Test::Unit::RepeatOption#_run_anything", 1278, "Test::Unit::RepeatOption", false, "_run_anything", "Test::Unit::RepeatOption#_run_anything", 1280]
["ruby-master/tool/lib/test/unit.rb", "ruby-master/tool/lib/test/unit.rb", "run_tests", "run_tests", "Test::Unit::Runner#run_tests", 1670, "Test::Unit::Runner", false, "run_tests", "Test::Unit::Runner#run_tests", 1671]
["ruby-master/tool/lib/test/unit.rb", "ruby-master/tool/lib/test/unit.rb", "_run", "_run", "Test::Unit::Runner#_run", 1651, "Test::Unit::Runner", false, "_run", "Test::Unit::Runner#_run", 1658]
[nil, "<cfunc>", nil, nil, "Array#each", nil, "Array", false, "each", "Array#each", 0]
["ruby-master/tool/lib/test/unit.rb", "ruby-master/tool/lib/test/unit.rb", "_run", "_run", "Test::Unit::Runner#_run", 1651, "Test::Unit::Runner", false, "_run", "Test::Unit::Runner#_run", 1657]
["ruby-master/tool/lib/test/unit.rb", "ruby-master/tool/lib/test/unit.rb", "run", "run", "Test::Unit::Runner#run", 1699, "Test::Unit::Runner", false, "run", "Test::Unit::Runner#run", 1700]
["ruby-master/tool/lib/test/unit.rb", "ruby-master/tool/lib/test/unit.rb", "run", "run", "Test::Unit::StatusLine#run", 1031, "Test::Unit::StatusLine", false, "run", "Test::Unit::StatusLine#run", 1032]
["ruby-master/tool/lib/test/unit.rb", "ruby-master/tool/lib/test/unit.rb", "run", "run", "Test::Unit::Statistics#run", 879, "Test::Unit::Statistics", false, "run", "Test::Unit::Statistics#run", 880]
["ruby-master/tool/lib/test/unit.rb", "ruby-master/tool/lib/test/unit.rb", "run", "run", "Test::Unit::RunCount#run", 152, "Test::Unit::RunCount", false, "run", "Test::Unit::RunCount#run", 154]
["ruby-master/tool/lib/test/unit.rb", "ruby-master/tool/lib/test/unit.rb", "run", "run", "Test::Unit::AutoRunner#run", 1775, "Test::Unit::AutoRunner", false, "run", "Test::Unit::AutoRunner#run", 1779]
["ruby-master/tool/lib/test/unit.rb", "ruby-master/tool/lib/test/unit.rb", "run", "run", "Test::Unit::AutoRunner.run", 1782, "Test::Unit::AutoRunner", true, "run", "Test::Unit::AutoRunner.run", 1783]
["ruby-master/tool/test/runner.rb", "ruby-master/tool/test/runner.rb", "<top (required)>", "<top (required)>", "<top (required)>", 0, nil, false, nil, nil, 23]
[nil, "<cfunc>", nil, nil, "Kernel#require_relative", nil, "Kernel", false, "require_relative", "Kernel#require_relative", 0]
["./test/runner.rb", "ruby-master/test/runner.rb", "<main>", "<main>", "<main>", 0, nil, false, nil, nil, 14] # <--- FRAME IN MAIN
["./test/runner.rb", nil, "<main>", "<main>", "<main>", 0, nil, false, nil, nil, 0] # <--- DUMMY FRAME
---
```
I am working on a PR to fix this, and will update this issue with fix: https://github.com/ruby/ruby/pull/6114 a link soon.