X-Git-Url: https://fleuret.org/cgi-bin/gitweb/gitweb.cgi?p=profiler-torch.git;a=blobdiff_plain;f=profiler.lua;h=4420af79b203464c276bc573bfb95459ddc461e9;hp=549065145ff94f758f390a8a7e99719a5ecb260b;hb=f59950ed20a2d471c59e2c23bc41b50111a54cd6;hpb=e05c72d75cf6c53887834d3c314a8ba6db6b56b3 diff --git a/profiler.lua b/profiler.lua old mode 100755 new mode 100644 index 5490651..4420af7 --- a/profiler.lua +++ b/profiler.lua @@ -37,7 +37,17 @@ require 'sys' profiler = {} -function profiler.decor(model, functionsToDecorate) +profiler.color = true + +profiler.colors = function(name) + if profiler.color then + return sys.COLORS[name] + else + return '' + end +end + +function profiler.decorate(model, functionsToDecorate) local functionsToDecorate = functionsToDecorate or { @@ -46,23 +56,29 @@ function profiler.decor(model, functionsToDecorate) } for _, name in pairs(functionsToDecorate) do - model.accTime = 0 + model.accTime = {} + + local nameOrig = name .. '__orig' - local functionTable = model + -- We decorate the class and not the object, otherwise we cannot + -- save models anymore. - if not rawget(functionTable, name) then - functionTable = getmetatable(model) + if rawget(model, name) then + error('We decorate the class, not the objects, and there is a `' + .. name + .. '\' function in ' + .. tostring(model)) end - if functionTable[name] and not (functionTable.orig and functionTable.orig[name]) then - print('Profiler decoring ' .. functionTable.__typename .. '.' .. name) - functionTable.orig = functionTable.orig or {} - functionTable.orig[name] = functionTable[name] - functionTable[name] = function(self, ...) + local toDecorate = getmetatable(model) + + if toDecorate[name] and not toDecorate[nameOrig] then + toDecorate[nameOrig] = toDecorate[name] + toDecorate[name] = function(self, ...) local startTime = sys.clock() - local result = { self.orig[name](self, unpack({...})) } + local result = { self[nameOrig](self, unpack({...})) } local endTime = sys.clock() - self.accTime = self.accTime + endTime - startTime + self.accTime[name] = (self.accTime[name] or 0) + endTime - startTime return unpack(result) end end @@ -71,31 +87,55 @@ function profiler.decor(model, functionsToDecorate) if torch.isTypeOf(model, nn.Container) then for _, m in ipairs(model.modules) do - profiler.decor(m, functionsToDecorate) + profiler.decorate(m, functionsToDecorate) end end end -function profiler.print(model, nbSamples, indent) +function profiler.timing(l, t, nbSamples, totalTime) + local s = string.format('%s %.02fs', l, t) + if totalTime then + s = s .. string.format(profiler.colors('blue') .. ' [%.02f%%]', 100 * t / totalTime) + end + if nbSamples then + s = s .. string.format(profiler.colors('green') .. ' (%.01fmus/sample)', 1e6 * t / nbSamples) + end + s = s .. profiler.colors('black') + return s +end + +function profiler.print(model, nbSamples, totalTime, indent) local indent = indent or '' + local hint - if nbSamples then - print(string.format('%s%s %.02fs (%.01fmus/sample)', - indent, - model.__typename, - model.accTime, - 1e6 * model.accTime / nbSamples)) + local localTotal = 0 + for _, t in pairs(model.accTime) do + localTotal = localTotal + t + end + + if torch.isTypeOf(model, nn.Container) then + hint = ' ' else - print(string.format('%s%s %.02fs', - indent, - model.__typename, - model.accTime)) + if profiler.color then + hint = ' ' + else + hint = '*' + end + hint = hint .. profiler.colors('red') end + print(profiler.timing(indent .. hint .. ' ' .. model.__typename, localTotal, nbSamples, totalTime)) + + for l, t in pairs(model.accTime) do + print(profiler.timing(indent .. ' ' .. l, t, nbSamples, totalTime)) + end + + print() + if torch.isTypeOf(model, nn.Container) then for _, m in ipairs(model.modules) do - profiler.print(m, nbSamples, indent .. ' ') + profiler.print(m, nbSamples, totalTime, indent .. ' ') end end end