Skip to content

[potashin] optimization #107

New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Open
wants to merge 2 commits into
base: master
Choose a base branch
from
Open
Show file tree
Hide file tree
Changes from all commits
Commits
File filter

Filter by extension

Filter by extension


Conversations
Failed to load comments.
Loading
Jump to
Jump to file
Failed to load files.
Loading
Diff view
Diff view
24 changes: 24 additions & 0 deletions .gitignore
Original file line number Diff line number Diff line change
@@ -0,0 +1,24 @@
result.json
data*.txt

/tmp/*
!/tmp/.keep

/tmp/memory_profiler/*
!/tmp/memory_profiler/
!/tmp/memory_profiler/.keep

/tmp/ruby_prof/*
!/tmp/ruby_prof/
!/tmp/ruby_prof/.keep

/tmp/stackprof/*
!/tmp/stackprof/
!/tmp/stackprof/.keep

/tmp/valgrind/*
!/tmp/valgrind/
!/tmp/valgrind/.keep

# Ignore MacOS system files
.DS_Store
1 change: 1 addition & 0 deletions .ruby-version
Original file line number Diff line number Diff line change
@@ -0,0 +1 @@
3.3.0
7 changes: 7 additions & 0 deletions Gemfile
Original file line number Diff line number Diff line change
@@ -0,0 +1,7 @@
source 'https://rubygems.org'

gem 'memory_profiler'
gem 'ruby-prof'
gem 'stackprof'
gem 'rspec'
gem 'rspec-benchmark'
42 changes: 42 additions & 0 deletions Gemfile.lock
Original file line number Diff line number Diff line change
@@ -0,0 +1,42 @@
GEM
remote: https://rubygems.org/
specs:
benchmark-malloc (0.2.0)
benchmark-perf (0.6.0)
benchmark-trend (0.4.0)
diff-lcs (1.5.1)
memory_profiler (1.0.1)
rspec (3.13.0)
rspec-core (~> 3.13.0)
rspec-expectations (~> 3.13.0)
rspec-mocks (~> 3.13.0)
rspec-benchmark (0.6.0)
benchmark-malloc (~> 0.2)
benchmark-perf (~> 0.6)
benchmark-trend (~> 0.4)
rspec (>= 3.0)
rspec-core (3.13.0)
rspec-support (~> 3.13.0)
rspec-expectations (3.13.0)
diff-lcs (>= 1.2.0, < 2.0)
rspec-support (~> 3.13.0)
rspec-mocks (3.13.0)
diff-lcs (>= 1.2.0, < 2.0)
rspec-support (~> 3.13.0)
rspec-support (3.13.1)
ruby-prof (1.7.0)
stackprof (0.2.26)

PLATFORMS
arm64-darwin-23
ruby

DEPENDENCIES
memory_profiler
rspec
rspec-benchmark
ruby-prof
stackprof

BUNDLED WITH
2.5.4
18 changes: 9 additions & 9 deletions README.md
Original file line number Diff line number Diff line change
Expand Up @@ -44,15 +44,15 @@ puts "MEMORY USAGE: %d MB" % (`ps -o rss= -p #{Process.pid}`.to_i / 1024)"
- в описание `PR` добавьте чеклист и отметьте, что из него сделали; для получения максимальной пользы надо отметить всё.

## Checklist
- [ ] Построить и проанализировать отчёт гемом `memory_profiler`
- [ ] Построить и проанализировать отчёт `ruby-prof` в режиме `Flat`;
- [ ] Построить и проанализировать отчёт `ruby-prof` в режиме `Graph`;
- [ ] Построить и проанализировать отчёт `ruby-prof` в режиме `CallStack`;
- [ ] Построить и проанализировать отчёт `ruby-prof` в режиме `CallTree` c визуализацией в `QCachegrind`;
- [ ] Построить и проанализировать текстовый отчёт `stackprof`;
- [ ] Построить и проанализировать отчёт `flamegraph` с помощью `stackprof` и визуализировать его в `speedscope.app`;
- [ ] Построить график потребления памяти в `valgrind massif visualier` и включить скриншот в описание вашего `PR`;
- [ ] Написать тест, на то что программа укладывается в бюджет по памяти
- [x] Построить и проанализировать отчёт гемом `memory_profiler`
- [x] Построить и проанализировать отчёт `ruby-prof` в режиме `Flat`;
- [x] Построить и проанализировать отчёт `ruby-prof` в режиме `Graph`;
- [x] Построить и проанализировать отчёт `ruby-prof` в режиме `CallStack`;
- [x] Построить и проанализировать отчёт `ruby-prof` в режиме `CallTree` c визуализацией в `QCachegrind`;
- [x] Построить и проанализировать текстовый отчёт `stackprof`;
- [x] Построить и проанализировать отчёт `flamegraph` с помощью `stackprof` и визуализировать его в `speedscope.app`;
- [x] Построить график потребления памяти в `valgrind massif visualier` и включить скриншот в описание вашего `PR`;
- [x] Написать тест, на то что программа укладывается в бюджет по памяти

Не нужно включать в `PR` выводы всех этих отчётов, просто используйте каждый хотя бы по разу в вашем `Case-study`.

Expand Down
71 changes: 71 additions & 0 deletions case-study.md
Original file line number Diff line number Diff line change
@@ -0,0 +1,71 @@
# Case-study оптимизации

## Актуальная проблема
В нашем проекте возникла серьёзная проблема.

Необходимо было обработать файл с данными, чуть больше ста мегабайт.

У нас уже была программа на `ruby`, которая умела делать нужную обработку.

Она успешно работала на файлах размером пару мегабайт, но для большого файла она работала слишком долго, и не было понятно, закончит ли она вообще работу за какое-то разумное время.

Я решил исправить эту проблему, оптимизировав эту программу.

## Формирование метрики
Для того, чтобы понимать, дают ли мои изменения положительный эффект на быстродействие программы я придумал использовать такую метрику: количество потребляемой памяти при просчете 100к записей (885 мб на старте, 11.4 секунды)
Copy link
Collaborator

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

👍


## Гарантия корректности работы оптимизированной программы
Программа поставлялась с тестом. Выполнение этого теста в фидбек-лупе позволяет не допустить изменения логики программы при оптимизации.

## Feedback-Loop
Для того, чтобы иметь возможность быстро проверять гипотезы я выстроил эффективный `feedback-loop`, который позволил мне получать обратную связь по эффективности сделанных изменений за *время, которое у вас получилось*

Вот как я построил `feedback_loop`: профилирование - изменение кода - тестирование – бенчмаркинг – откат при отсутствии разницы от оптимизации/сохранение результатов

## Вникаем в детали системы, чтобы найти главные точки роста
Для того, чтобы найти "точки роста" для оптимизации я воспользовался memoty_profiler, ruby-prof (allocation/memory), stackprof (allocation), valgrind

Вот какие проблемы удалось найти и решить

### Ваша находка №1
- memory_profiler показал, что больше всего памяти `3587123560` аллоцируется в `task-2.rb:74` (по классу лидирует`5212433896 Array`, что похоже на то, что происходит в `task-2.rb:74`)
- вместо создания нового массива `sessions = sessions + [parse_session(line)] if cols[0] == 'session'` будем использовать пуш `<<` в уже определенный массив (для аналогично для `users`).
- метрика снизилась с 885 до 287 мб
- профилировщик показывает `1305579360 task-2.rb:128` как лидирующую позицию. Количество аллоцированных массивов снизилось до `1499267656 Array`

### Ваша находка №2
- memory_profiler показал, что больше всего памяти `1305579360` аллоцируется в `task-2.rb:128` (по классу лидирует`1499267656 Array`, что похоже на то, что происходит в `task-2.rb:128`)
- заменяем `sessions.select { |session| session['user_id'] == user['id'] }` на поиск по предварительно сформированному хэшу `sessions_by_user = sessions.group_by { |session| session['user_id'] }`
- метрика снизилась с 287 до 140 мб
- профилировщик показывает `120416072 task-2.rb:132` как лидирующую позицию. Количество аллоцированных массивов снизилось до `206505392 Array`, лидирующее место теперь занимает `344381297 String`.

### Ваша находка №3
- memory_profiler показал, что больше всего памяти `120416072` аллоцируется в `task-2.rb:132` (по классу лидирует `344381297 String`, что не похоже на то, что происходит в `task-2.rb:132`, поскольку там происходят операции с массивами, а не строками).
- вместо `users_objects = users_objects + [user_object]` использую `users_objects << user_object`
- метрика снизилась незначительно, будем считать, что это те же 140 мб
- профилировщик показывает `97472465 task-2.rb:169` как лидирующую позицию. Количество аллоцированных массивов снизилось до `86230952 Array`, лидирующее место по-прежнему занимает `344381297 String`.

### Ваша находка №4
- memory_profiler показал, что больше всего памяти `97472465` аллоцируется в `task-2.rb:169` (по классу лидирует `344381297 String`, что похоже на то, что происходит в `task-2.rb:169`)
- заменяю `user.sessions.map{|s| s['date']}.map {|d| Date.parse(d)}.sort.reverse.map { |d| d.iso8601 }` на `user.sessions.map{|s| s['date']}.sort { |d1, d2| d2 <=> d1 }`
- метрика снизилась с 140 до 133 мб
- профилировщик показывает `96369656 json-2.7.2/lib/json/common.rb:220` как лидирующую позицию. Количество аллоцированных строк снизилось до `313934727 String`, это по-прежнему лидирующая позиция.

### Ваша находка №5
- профилировщик показывает `96369656 json-2.7.2/lib/json/common.rb:220` как лидирующую позицию
- вместо записи/чтения файла из каждого треда, агрегирую репорты из каждого треда, после чего 1 раз пишу ее содержимое в файл
- метрика снизилась с 133 до 58 мб
- профилировщик показывает `48221760 task-2.rb:72` как лидирующую позицию. Количество аллоцированных строк снизилось до `160207766 String`, это по-прежнему лидирующая позиция.

### Ваша находка №6
- профилировщик показывает `48221760 task-2.rb:72` как лидирующую позицию, но дальнейшие попытки оптимизации не приводят к снижению потребляемой памяти: основной точкой роста является ограничение накапливаемых данных
- переписываю программу в потоковом стиле (накапливаем данные только по 1 пользователю и его сессиям за раз, после накопления собираем статистику, пишем в файл и начинаем сначала)
- снизилась до 21мб для 100к (для всего файла тоже 21мб)
Copy link
Collaborator

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

да, самое кайфовое, что теперь любой объём данных так можно перелопатить

- количество строк сократилось до `51749209 String`

## Результаты
В результате проделанной оптимизации наконец удалось обработать файл с данными.
Удалось улучшить метрику системы с 885мб до 21мб и уложиться в заданный бюджет (70мб).

## Защита от регрессии производительности
Для защиты от потери достигнутого прогресса при дальнейших изменениях программы были написаны тесты на асимптотику, время работы и количество аллоцированных объектов на 10к строк
18 changes: 0 additions & 18 deletions data.txt

This file was deleted.

10 changes: 10 additions & 0 deletions memory_profiler/report.rb
Original file line number Diff line number Diff line change
@@ -0,0 +1,10 @@
require_relative '../task-2'

require 'memory_profiler'

report = MemoryProfiler.report do
GC.disable
work
end

report.pretty_print
22 changes: 22 additions & 0 deletions ruby_prof/allocation.rb
Original file line number Diff line number Diff line change
@@ -0,0 +1,22 @@
require_relative '../task-2'

require 'ruby-prof'

RubyProf.measure_mode = RubyProf::ALLOCATIONS

result = RubyProf.profile do
GC.disable
work
end

printer = RubyProf::FlatPrinter.new(result)
printer.print(File.open('tmp/ruby_prof/flat.txt', 'w+'))

# printer = RubyProf::DotPrinter.new(result)
# printer.print(File.open('tmp/ruby_prof/graphviz.dot', 'w+'))

printer = RubyProf::GraphHtmlPrinter.new(result)
printer.print(File.open('tmp/ruby_prof/graph.html', 'w+'))

printer = RubyProf::CallStackPrinter.new(result)
printer.print(File.open('tmp/ruby_prof/callstack.html', 'w+'))
14 changes: 14 additions & 0 deletions ruby_prof/memory.rb
Original file line number Diff line number Diff line change
@@ -0,0 +1,14 @@
require_relative '../task-2'

require 'ruby-prof'

RubyProf.measure_mode = RubyProf::MEMORY

result = RubyProf.profile do
GC.disable
work
end


printer = RubyProf::CallTreePrinter.new(result)
printer.print(path: 'tmp/ruby_prof', profile: 'profile')
27 changes: 27 additions & 0 deletions spec/task_spec.rb
Original file line number Diff line number Diff line change
@@ -0,0 +1,27 @@
require 'rspec'
require 'rspec-benchmark'
require_relative '../task-2'

RSpec.describe 'work' do
include RSpec::Benchmark::Matchers

it 'should be linear' do
expect { |number, _|
`head -n #{number * 1000} data_large.txt > data.txt`

work
}.to perform_linear.in_range(1, 100)
end

it 'should perform under 5 seconds' do
`head -n 1000000 data_large.txt > data.txt`

expect { work }.to perform_under(5).sec
end

it 'should not allocate more than 110000 objects' do
`head -n 10000 data_large.txt > data.txt`

expect { work }.to perform_allocation(109643)
end
end
8 changes: 8 additions & 0 deletions stackprof/allocation.rb
Original file line number Diff line number Diff line change
@@ -0,0 +1,8 @@
require_relative '../task-2'

require 'stackprof'

StackProf.run(mode: :object, out: "tmp/stackprof/allocation_#{Time.now.to_i}.dump", raw: true) do
GC.disable
work
end
Loading