A small script to find slow chef recipes

chef-debug-timer.rb

require 'time'
# A small script to find slow chef recipes
#
# Usage: chef-client -l debug | ruby chef-debug-timer.rb
#
#

lines = ARGF.read.split("\n").select {|x| x =~ /DEBUG: Loading Recipe/ }
current = nil
last = nil
lines.each do |x|
	line = x.split("]")
	date = line.first[1..-1]
	msg = line.last
	current = Time.parse(date).to_i
	last ||= current
	puts "#{date} #{current-last.to_i}s #{msg}"
	last = current
end