(Deze post verscheen eerder op Spike's Stuff… And Things… blog)

Gisteren was ik betrokken bij een brandweeroefening rond de lancering van een nieuwe Rails-site binnen een zeer strakke tijdlijn. De site werkte prima in ontwikkeling/staging, maar de index duurde in productie meer dan 10 seconden om te renderen.

Omdat het buiten productie werkte, concludeerden we dat het te maken had met de hosting-infrastructuur. We controleerden Apache, Passenger, serverbelasting, netwerkconfiguratie enzovoort. Niets.

Uiteindelijk dacht ik er aan om log/production.log te controleren, en daar was het:

Verwerkt door BlahController#index als */*
  Gerenderd blah/_carousel.html.erb (5795.2ms)
  Gerenderd blah/index.html.erb binnen layouts/site (5801.5ms)

We spoorden het snel terug naar een beeldverwerking die niet in cache werd opgeslagen. Het verscheen niet buiten productie omdat de beeldassets verschillend waren. Ik zal je niet vervelen met de details.

Ik zal je echter vervelen verlichten met mijn punt. Bij het debuggen van een probleem, begin met de eenvoudige dingen. De Rails-logboeken zijn niet erg gedetailleerd, maar ze bieden meer dan voldoende informatie om snel naar problemen in je code te boren.