Come registrare le query di Rails prima che si verifichino?

Question

Il logger delle porte per impostazione predefinita mostrerà l'SQL dopo che è stato eseguito. A volte, soprattutto quando una query richiede molto tempo, desidero configurare il logger in modo che emetta l'SQL prima che venga eseguito. Quindi può aggiungere un log di follow-up una volta che il database ha risposto.

idea di base è qualcosa di simile:

10:01:01 POST Load Executing "SELECT * from posts;' 
10:01:03 POST Load 1712ms 

Come può Rails essere configurato per rompere la registrazione SQL in 2 fasi come questo?

Answer 1

Non esiste un modo standard per configurare il logger per l'emissione della query SQL prima dell'esecuzione.

Ma è comunque possibile registrare le query in questo modo estendendo la classe ActiveRecord::LogSubscriber.

# initializers/extensions/active_record_logger.rb 
module Extensions 
    module ActiveRecordLogger 
    IGNORE_PAYLOAD_NAMES = ActiveRecord::LogSubscriber::IGNORE_PAYLOAD_NAMES 

    # ActiveRecord::LogSubscriber doesn't implement this method. 
    # This method will be invoked before event starts processing. 
    # It's exactly we are looking for! 
    def start(name, id, payload) 
     super 

     return unless logger.debug? 
     return if IGNORE_PAYLOAD_NAMES.include?(payload[:name]) 

     name = payload[:name] 
     sql = payload[:sql] 

     name = color(name, nil, true) 
     sql = color(sql, nil, true) 

     debug "STARTING #{name} #{sql}" 
    end 
    end 
end 

ActiveRecord::LogSubscriber.include Extensions::ActiveRecordLogger 

Ora otterrete log delle query prima esecuzione. Ad esempio, l'interrogazione

User.find 1 

produrrà

STARTING User Load SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 
User Load (0.2ms) SELECT "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1 [["id", 1]] 
#<User id: 1, username: "dimakura", created_at: "2015-09-08 13:16:42", updated_at: "2015-09-08 13:16:42"> 

Answer 2

Penso che stiate cercando il metodo delle rotaie explain. Quindi, è necessario implementare qualcosa di simile:

@query = Some.model.query 
Rails.logger @query.explain 
ActiveRecord::Base.silence do 
    @query.load 
end 
Rails.logger "Finished" 

Naturalmente, è possibile aggiungere i timer, le cause, la gestione delle eccezioni et.c.