Class: Magick::PerformanceMetrics

Inherits:
Object
  • Object
show all
Defined in:
lib/magick/performance_metrics.rb

Defined Under Namespace

Classes: Metric

Instance Attribute Summary collapse

Instance Method Summary collapse

Constructor Details

#initialize(batch_size: 100, flush_interval: 60, redis_enabled: nil) ⇒ PerformanceMetrics

Returns a new instance of PerformanceMetrics.



27
28
29
30
31
32
33
34
35
36
37
38
39
40
41
42
43
44
45
46
47
48
49
 
# File 'lib/magick/performance_metrics.rb', line 27

def initialize(batch_size: 100, flush_interval: 60, redis_enabled: nil)
  @metrics = []
  @mutex = Mutex.new
  @usage_count = Hash.new(0) # Memory-only counts (reset on each process boot)
  @pending_updates = Hash.new(0) # For Redis batching (reset on each process boot)
  @flushed_counts = Hash.new(0) # Track counts that have been flushed to Redis (to avoid double-counting)
  @batch_size = batch_size
  @flush_interval = flush_interval
  @last_flush = Time.now
  # If redis_enabled is explicitly set, use it; otherwise default to false
  # It will be enabled later via enable_redis_tracking if Redis adapter is available
  @redis_enabled = redis_enabled.nil? ? false : redis_enabled
  # Cache expensive checks for performance
  @_rails_events_enabled = defined?(Magick::Rails::Events) && Magick::Rails::Events.rails8?
  @_adapter_available = nil # Will be cached on first check
  @_redis_available = nil # Will be cached on first check

  # Async recording queue for non-blocking metrics
  @async_queue = Queue.new
  @async_thread = nil
  @async_enabled = true # Enable async by default for performance
  start_async_processor
end

Instance Attribute Details

#redis_enabled ⇒ Object (readonly)

Public accessor for redis_enabled



52
53
54
 
# File 'lib/magick/performance_metrics.rb', line 52

def redis_enabled
  @redis_enabled
end

Instance Method Details

#average_duration(feature_name: nil, operation: nil) ⇒ Object 



262
263
264
265
266
267
268
269
270
271
272
273
274
275
276
277
278
279
280
281
282
283
284
285
286
287
288
289
290
291
292
293
294
295
296
297
298
299
300
301
302
303
304
305
306
307
308
309
310
311
312
313
314
315
316
 
# File 'lib/magick/performance_metrics.rb', line 262

def average_duration(feature_name: nil, operation: nil)
  # Calculate from memory metrics (current process, not yet flushed)
  filtered = @metrics.select do |m|
    (feature_name.nil? || m.feature_name == feature_name.to_s) &&
      (operation.nil? || m.operation == operation.to_s) &&
      m.success
  end

  memory_sum = filtered.sum(&:duration)
  memory_count = filtered.length

  # Also get from Redis if available (persisted across processes)
  redis_sum = 0.0
  redis_count = 0
  begin
    adapter = Magick.adapter_registry || Magick.default_adapter_registry
    if adapter.is_a?(Magick::Adapters::Registry) && adapter.redis_available?
      redis = adapter.redis_client
      if redis
        if feature_name && operation
          # Specific feature and operation
          sum_key = "magick:duration:sum:#{feature_name}:#{operation}"
          count_key = "magick:duration:count:#{feature_name}:#{operation}"
          redis_sum = redis.get(sum_key).to_f
          redis_count = redis.get(count_key).to_i
        elsif feature_name
          # All operations for this feature
          pattern = "magick:duration:sum:#{feature_name}:*"
          redis.keys(pattern).each do |sum_key|
            op = sum_key.to_s.sub("magick:duration:sum:#{feature_name}:", '')
            count_key = "magick:duration:count:#{feature_name}:#{op}"
            redis_sum += redis.get(sum_key).to_f
            redis_count += redis.get(count_key).to_i
          end
        else
          # All features and operations (not recommended, but supported)
          redis.keys('magick:duration:sum:*').each do |sum_key|
            count_key = sum_key.to_s.sub(':sum:', ':count:')
            redis_sum += redis.get(sum_key).to_f
            redis_count += redis.get(count_key).to_i
          end
        end
      end
    end
  rescue StandardError
    # Silently fail
  end

  total_sum = memory_sum + redis_sum
  total_count = memory_count + redis_count

  return 0.0 if total_count == 0

  total_sum / total_count.to_f
end

#clear! ⇒ Object 



375
376
377
378
379
380
381
382
 
# File 'lib/magick/performance_metrics.rb', line 375

def clear!
  @mutex.synchronize do
    @metrics.clear
    @usage_count.clear
    @pending_updates.clear
    @flushed_counts.clear
  end
end

#enable_redis_tracking(enable: true) ⇒ Object 



238
239
240
241
242
243
244
245
246
247
248
249
250
251
252
253
254
255
256
257
258
259
260
 
# File 'lib/magick/performance_metrics.rb', line 238

def enable_redis_tracking(enable: true)
  old_value = @redis_enabled
  @redis_enabled = enable

  # Flush any pending updates when enabling
  if enable && !@pending_updates.empty?
    begin
      flush_to_redis
    rescue StandardError => e
      # Don't fail if flush fails - the flag is still set
      if defined?(Rails) && Rails.env.development?
        warn "Magick: Failed to flush stats when enabling Redis tracking: #{e.message}"
      end
    end
  end

  # Verify the value was set (for debugging)
  if !(@redis_enabled == enable) && defined?(Rails) && Rails.env.development?
    warn "Magick: Failed to set redis_enabled to #{enable}, current value: #{@redis_enabled}"
  end

  true
end

#flush_to_redis ⇒ Object 



167
168
169
170
171
172
173
174
175
176
177
178
179
180
181
182
183
184
185
186
187
188
189
190
191
192
193
194
195
196
197
198
199
200
201
202
203
204
205
206
207
208
209
210
211
212
213
214
215
216
217
218
219
220
221
222
223
224
225
226
227
228
229
230
231
232
233
234
235
236
 
# File 'lib/magick/performance_metrics.rb', line 167

def flush_to_redis
  updates_to_flush = nil
  duration_stats_to_flush = {}
  @mutex.synchronize do
    return if @pending_updates.empty?

    updates_to_flush = @pending_updates.dup
    flushed_feature_names = updates_to_flush.keys.to_set
    @pending_updates.clear
    # Track what we're flushing so we don't double-count in usage_count
    updates_to_flush.each do |feature_name, count|
      @flushed_counts[feature_name] += count
    end

    # Collect duration stats for flushed features
    # Group metrics by feature_name and operation, sum durations and count occurrences
    @metrics.each do |metric|
      next unless flushed_feature_names.include?(metric.feature_name) && metric.success

      key = "#{metric.feature_name}:#{metric.operation}"
      duration_stats_to_flush[key] ||= { sum: 0.0, count: 0, feature_name: metric.feature_name,
                                         operation: metric.operation }
      duration_stats_to_flush[key][:sum] += metric.duration
      duration_stats_to_flush[key][:count] += 1
    end

    # Remove metrics for flushed features from memory to reduce memory usage
    # Metrics are already persisted in Redis, so we don't need to keep them in memory
    @metrics.reject! { |m| flushed_feature_names.include?(m.feature_name) }

    @last_flush = Time.now
  end

  return if updates_to_flush.nil? || updates_to_flush.empty?

  # Update Redis in batch
  # Always try to flush if Redis adapter is available, regardless of @redis_enabled flag
  # This ensures stats are collected even if redis_enabled wasn't set correctly
  begin
    adapter = Magick.adapter_registry || Magick.default_adapter_registry
    if adapter.is_a?(Magick::Adapters::Registry) && adapter.redis_available?
      redis = adapter.redis_client
      if redis
        # Flush usage counts
        updates_to_flush.each do |feature_name, count|
          redis_key = "magick:stats:#{feature_name}"
          redis.incrby(redis_key, count)
          redis.expire(redis_key, 86_400 * 7) # Keep stats for 7 days
        end

        # Flush duration stats (sum and count for calculating averages)
        duration_stats_to_flush.each do |_key, stats|
          sum_key = "magick:duration:sum:#{stats[:feature_name]}:#{stats[:operation]}"
          count_key = "magick:duration:count:#{stats[:feature_name]}:#{stats[:operation]}"
          redis.incrbyfloat(sum_key, stats[:sum])
          redis.incrby(count_key, stats[:count])
          redis.expire(sum_key, 86_400 * 7) # Keep stats for 7 days
          redis.expire(count_key, 86_400 * 7)
        end

        # Auto-enable redis tracking if we successfully flushed to Redis
        # This ensures redis_enabled is set correctly even if config didn't work
        @redis_enabled ||= true
      end
    end
  rescue StandardError => e
    # Silently fail - don't break feature checks if stats fail
    warn "Magick: Failed to flush stats to Redis: #{e.message}" if defined?(Rails) && Rails.env.development?
  end
end

#flush_to_redis_if_needed ⇒ Object 



136
137
138
139
140
141
142
143
144
145
146
147
148
149
150
151
152
153
154
155
156
157
 
# File 'lib/magick/performance_metrics.rb', line 136

def flush_to_redis_if_needed
  # Cache adapter availability check (expensive)
  if @_adapter_available.nil?
    adapter = Magick.adapter_registry || Magick.default_adapter_registry
    @_adapter_available = adapter
    @_redis_available = adapter.is_a?(Magick::Adapters::Registry) && adapter.redis_available? if adapter
  end

  return unless @_adapter_available
  return unless @_redis_available || @redis_enabled
  return if @pending_updates.empty?

  should_flush = false
  @mutex.synchronize do
    # Flush if we have enough pending updates (sum of all counts) or enough time has passed
    # Check total count of pending updates, not just number of keys
    total_pending_count = @pending_updates.values.sum
    should_flush = true if total_pending_count >= @batch_size || (Time.now - @last_flush) >= @flush_interval
  end

  flush_to_redis if should_flush
end

#force_flush_to_redis ⇒ Object

Force flush pending updates to Redis immediately Useful when you need up-to-date stats across processes



161
162
163
164
165
 
# File 'lib/magick/performance_metrics.rb', line 161

def force_flush_to_redis
  return if @pending_updates.empty?

  flush_to_redis
end

#most_used_features(limit: 10) ⇒ Object 



349
350
351
352
353
354
355
356
357
358
359
360
361
362
363
364
365
366
367
368
369
370
371
372
373
 
# File 'lib/magick/performance_metrics.rb', line 349

def most_used_features(limit: 10)
  # Combine memory and Redis counts
  combined_counts = @usage_count.dup

  # Always check Redis if adapter is available (not just if @redis_enabled)
  # This ensures we get the full count even if redis_enabled flag wasn't set correctly
  begin
    adapter = Magick.adapter_registry || Magick.default_adapter_registry
    if adapter.is_a?(Magick::Adapters::Registry) && adapter.redis_available?
      redis = adapter.redis_client
      if redis
        # Get all stats keys
        redis.keys('magick:stats:*').each do |key|
          feature_name = key.to_s.sub('magick:stats:', '')
          redis_count = redis.get(key).to_i
          combined_counts[feature_name] = (combined_counts[feature_name] || 0) + redis_count
        end
      end
    end
  rescue StandardError
    # Silently fail
  end

  combined_counts.sort_by { |_name, count| -count }.first(limit).to_h
end

#process_async_record(feature_name_str, operation_str, duration, success) ⇒ Object

Internal: Process metrics from async queue (runs in background thread)



72
73
74
75
76
77
78
79
80
81
82
83
84
85
86
87
88
89
90
91
92
93
94
95
96
97
98
 
# File 'lib/magick/performance_metrics.rb', line 72

def process_async_record(feature_name_str, operation_str, duration, success)
  # Minimize mutex lock time - only update counters
  pending_count = nil
  total_pending = nil
  @mutex.synchronize do
    # Only create Metric object if we're keeping metrics in memory
    if @metrics.length < 1000
      metric = Metric.new(feature_name_str, operation_str, duration, success: success)
      @metrics << metric
    end
    @usage_count[feature_name_str] += 1
    @pending_updates[feature_name_str] += 1
    pending_count = @pending_updates[feature_name_str]
    total_pending = @pending_updates.values.sum
    # Keep only last 1000 metrics (as a safety limit)
    @metrics.shift if @metrics.length > 1000
  end

  # Rails 8+ event for usage tracking (cached check)
  if @_rails_events_enabled
    Magick::Rails::Events.usage_tracked(feature_name_str, operation: operation_str, duration: duration,
                                                          success: success)
  end

  # Batch flush check - only if we're close to batch size
  flush_to_redis_if_needed if pending_count >= @batch_size || total_pending >= @batch_size
end

#record(feature_name, operation, duration, success: true) ⇒ Object 



54
55
56
57
58
59
60
61
62
63
64
65
66
67
68
69
 
# File 'lib/magick/performance_metrics.rb', line 54

def record(feature_name, operation, duration, success: true)
  # Fast path: push to async queue (non-blocking, zero overhead in hot path)
  # Queue#<< is thread-safe and lock-free - extremely fast!
  return unless @async_enabled

  # Push to async queue - this is lock-free and extremely fast
  # Use non-blocking push (will raise if queue is full, but our queue is unbounded)
  begin
    @async_queue << [feature_name.to_s, operation.to_s, duration, success]
  rescue ThreadError, ClosedQueueError
    # Queue is closed or thread died, disable async
    @async_enabled = false
  end

  nil
end

#start_async_processor ⇒ Object

Start background thread to process async metrics



101
102
103
104
105
106
107
108
109
110
111
112
113
114
115
116
117
118
119
120
121
122
123
124
125
126
127
128
129
130
131
132
133
134
 
# File 'lib/magick/performance_metrics.rb', line 101

def start_async_processor
  return if @async_thread&.alive?

  @async_thread = Thread.new do
    last_flush_check = Time.now
    loop do
      # Wait for metrics with timeout to allow periodic flush checks
      # Queue#pop with timeout returns nil on timeout, raises on closed queue
      begin
        data = @async_queue.pop(timeout: 1.0)
      rescue ThreadError => e
        # Queue closed or thread interrupted
        break if e.message.include?('queue closed')

        raise
      end

      if data
        feature_name_str, operation_str, duration, success = data
        process_async_record(feature_name_str, operation_str, duration, success)
        last_flush_check = Time.now
      elsif Time.now - last_flush_check >= 1.0
        # Timeout - check if we need to flush based on time (every second)
        flush_to_redis_if_needed
        last_flush_check = Time.now
      end
    rescue StandardError => e
      # Log error but continue processing
      warn "Magick: Error in async metrics processor: #{e.message}" if defined?(Rails) && Rails.env.development?
      sleep 0.1 # Brief pause on error
    end
  end
  @async_thread.abort_on_exception = false
end

#stop_async_processor ⇒ Object

Stop async processor (for cleanup)



385
386
387
388
389
390
 
# File 'lib/magick/performance_metrics.rb', line 385

def stop_async_processor
  @async_enabled = false
  @async_queue.close if @async_queue.respond_to?(:close)
  @async_thread&.kill
  @async_thread = nil
end

#usage_count(feature_name) ⇒ Object 



318
319
320
321
322
323
324
325
326
327
328
329
330
331
332
333
334
335
336
337
338
339
340
341
342
343
344
345
346
347
 
# File 'lib/magick/performance_metrics.rb', line 318

def usage_count(feature_name)
  feature_name_str = feature_name.to_s

  # Force flush any pending updates for this feature before reading to ensure accuracy
  # This ensures stats are synced across processes immediately
  force_flush_to_redis if @pending_updates[feature_name_str] && @pending_updates[feature_name_str] > 0

  # Memory count = total counts in current process minus what we've already flushed
  # This avoids double-counting with Redis
  memory_count = (@usage_count[feature_name_str] || 0) - (@flushed_counts[feature_name_str] || 0)
  memory_count = 0 if memory_count < 0 # Safety check

  # Redis count = total counts from all processes (including this process's flushed counts)
  redis_count = 0
  begin
    adapter = Magick.adapter_registry || Magick.default_adapter_registry
    if adapter.is_a?(Magick::Adapters::Registry) && adapter.redis_available?
      redis = adapter.redis_client
      if redis
        redis_key = "magick:stats:#{feature_name_str}"
        redis_count = redis.get(redis_key).to_i
      end
    end
  rescue StandardError
    # Silently fail
  end

  # Total = Redis (all processes, all time) + memory (current process, not yet flushed)
  redis_count + memory_count
end