class ActiveSupport::Notifications::Event

Attributes

name[R]
payload[RW]
transaction_id[R]

Public Class Methods

new(name, start, ending, transaction_id, payload) click to toggle source
# File lib/active_support/notifications/instrumenter.rb, line 110
def initialize(name, start, ending, transaction_id, payload)
  @name           = name
  @payload        = payload.dup
  @time           = start ? start.to_f * 1_000.0 : start
  @transaction_id = transaction_id
  @end            = ending ? ending.to_f * 1_000.0 : ending
  @cpu_time_start = 0.0
  @cpu_time_finish = 0.0
  @allocation_count_start = 0
  @allocation_count_finish = 0
  @gc_time_start = 0
  @gc_time_finish = 0
end

Public Instance Methods

allocations() click to toggle source

Returns the number of allocations made between the call to start! and the call to finish!.

# File lib/active_support/notifications/instrumenter.rb, line 176
def allocations
  @allocation_count_finish - @allocation_count_start
end
cpu_time() click to toggle source

Returns the CPU time (in milliseconds) passed between the call to start! and the call to finish!.

# File lib/active_support/notifications/instrumenter.rb, line 163
def cpu_time
  @cpu_time_finish - @cpu_time_start
end
duration() click to toggle source

Returns the difference in milliseconds between when the execution of the event started and when it ended.

ActiveSupport::Notifications.subscribe('wait') do |event|
  @event = event
end

ActiveSupport::Notifications.instrument('wait') do
  sleep 1
end

@event.duration # => 1000.138
# File lib/active_support/notifications/instrumenter.rb, line 198
def duration
  @end - @time
end
end() click to toggle source
# File lib/active_support/notifications/instrumenter.rb, line 128
def end
  @end / 1000.0 if @end
end
finish!() click to toggle source

Record information at the time this event finishes

# File lib/active_support/notifications/instrumenter.rb, line 154
def finish!
  @cpu_time_finish = now_cpu
  @gc_time_finish = now_gc
  @end = now
  @allocation_count_finish = now_allocations
end
gc_time() click to toggle source

Returns the time spent in GC (in milliseconds) between the call to start! and the call to finish!

# File lib/active_support/notifications/instrumenter.rb, line 182
def gc_time
  (@gc_time_finish - @gc_time_start) / 1_000_000.0
end
idle_time() click to toggle source

Returns the idle time time (in milliseconds) passed between the call to start! and the call to finish!.

# File lib/active_support/notifications/instrumenter.rb, line 169
def idle_time
  diff = duration - cpu_time
  diff > 0.0 ? diff : 0.0
end
start!() click to toggle source

Record information at the time this event starts

# File lib/active_support/notifications/instrumenter.rb, line 146
def start!
  @time = now
  @cpu_time_start = now_cpu
  @gc_time_start = now_gc
  @allocation_count_start = now_allocations
end
time() click to toggle source
# File lib/active_support/notifications/instrumenter.rb, line 124
def time
  @time / 1000.0 if @time
end

Private Instance Methods

now() click to toggle source
# File lib/active_support/notifications/instrumenter.rb, line 203
def now
  Process.clock_gettime(Process::CLOCK_MONOTONIC, :float_millisecond)
end
now_allocations() click to toggle source
# File lib/active_support/notifications/instrumenter.rb, line 230
def now_allocations
  GC.stat(:total_allocated_objects)
end
now_cpu() click to toggle source
# File lib/active_support/notifications/instrumenter.rb, line 210
def now_cpu
  Process.clock_gettime(Process::CLOCK_THREAD_CPUTIME_ID, :float_millisecond)
end
now_gc() click to toggle source
# File lib/active_support/notifications/instrumenter.rb, line 220
def now_gc
  GC.total_time
end