How to Read a Stack Trace

- 12 minutes read - 2493 words

A stumbling block for many people when debugging is reading the stack trace. Today I’d like to discuss this important skill.

What is a stack trace? According to Wikipedia: “In computing, a stack trace… is a report of the active stack frames at a certain point in time during the execution of a program.” It’s the answer to the question: “when this system is being observed, what is happening?” Reading stack traces is a core programming skill.

I compare reading stack traces to troubleshooting a component of a car. Imagine that you can’t open your car’s automatic window. Should you dismantle the door and replace the motor that lowers it? That might work, but no, you should not. There are multiple explanations for this problem and the motor is just one. Permit me a few non-mechanic explanations:

  • The electrical power to the car might be off
  • The window might be stuck or obstructed
  • The window control might be broken or missing
  • The electrical line that powers the motor might be faulty
  • (And finally) the motor might be broken

Your mechanic uses a checklist like this, perhaps just mentally, to ensure the action being taken is the right one.

Debugging works the same way. Isolating the issue to the frontend, backend, data layer, infrastructure, or even your computer, is the only way to ensure you’re fixing the right problem.

Example

Let’s look at a real stack trace! This is Ruby code. Ruby is famous for its readability, so if you aren’t a Rubyist, please try to follow along anyway. Some Rubyists some might consider this example too simple, but I’ve seen a stacktrace like mystify people dozens of times.

For context, this printed in my Chrome Network Tab after an endpoint returned 500.

N = u a A - - - - - - - F - - - - - - - - - - o = n p p u M = d p p a l l a l l l l a a a a a d a a a a . e = e / 1 1 1 1 1 2 2 2 2 2 2 p i i p i i i l p c c c c e c c c c l t = f v 5 6 7 8 9 0 1 2 3 4 5 b p b b p b b b p t t t t f t t t t o h = i i a / / / / / / / b / i i i i a i i i i t o = n e c l l m p s l a v o v o o c o o v v s d = e w k i o o i i i o c i n e n n e n n e e E = d s e j j t e g g d n t g k e v s v v v v s s o r = / n s s r w b b d t e b t w i u i i ( i i u u f r = m p e d o o j j j j a s o l e m o r s e p e e 1 e e p p o = e l n n n s s s s c o o e r a o a / w p w w . w w p p e r = t a d . . o o o o e p k k w e p k c p o 0 o o x = h t p e n n n n l / / a s _ / e l ( r ( ( . ( ( r r t a = o f o s . . . . a r r r t p r a 4 t 4 4 2 4 4 t t r t = d o s t n g g s t a a e _ r a t . . . ) . . a = r t i a e e c f i i / c o i f 2 ( 2 2 2 2 ( ( / = ' m a m m t t h o l l e a x l o . 4 . . l . . 4 4 l a = e / l a e _ _ e r s s n t y s r 1 . 1 1 i 1 1 . . i p = a a _ t i i d m _ _ s a . _ m 1 2 1 1 b 1 1 2 2 n i = c p c e e t t u / e e u l r e / . . . . / . . . . e / = h i o s s _ _ l a x x r o b x a 3 1 3 3 d 3 3 1 1 s d = ' / d t b b e p t t e g : t p ) 1 ) ) e ) ) 1 1 e = d e @ i y y i / _ _ 2 / i . f . . o l = f e e m _ e a a s p 2 r / l 3 l l a l l 3 3 m i = o l p s a e l s d c c e r : a d i ) i i c i i ) ) i v = r i o t t s a t e t t s o i c e b b b e b b t e = v s i o t t i l i i s x n k l / l / / / / / l l t r = n e t m r i e m i o o i y / i a i a a a a a i i e y = i r a a . m s a v n n o . ` l v c b c c c c c b b d _ = l y l t s a t t e _ _ n r p o e t / t t t t t / / e = : _ _ o e t o r c c _ b e g r i a i i i i i a a 😅 s = N e c r r o e r y o o i : r g y o c o o o o o c c t = i s o s v r s . _ n n d 1 f e _ n t n n n n n t t i = l t d . i . t e e t t . 7 o r e _ i _ _ _ _ _ i i m = C i e e c e i v s r r r : r . s v v v v v v v v v a = l m a e s m a t o o b i m r t i e i i i i i e e t = a a c _ t a l i l l : n _ b i e _ e e e e e _ _ e = s t h n i t u m l l 1 r : m w s w w w w w s s s = s e a m o a a e e 7 ` e 1 a / u / / _ / / u u = s d m a r t t r r : p q 2 t t p t t e r r p p = / o e t . e e / / i e u : e e p e e x e e p p = i e e d s m m n r e i s m o m m t n n o o = n | . s _ / e e f s n / p r p p e d d r r = d e e t s i t t ` o t i l t l l n e e t t = e s a i c n a a c r ' ` n a / a a s r r / / = x t r m h d l l a m c d t n t t i e e n n = . i l a e e / / l _ a e e o e e o r r o v m i t d x i i l r l x . t . . n / t t 1 a e e u . n n ' e l . r i r r s t a i i . t s . l v s s q _ v b f b b . e b f f j o t l e 1 t t u a 1 : i : : r m s i i b r _ a . r r e p . 1 c 3 1 b p t c c u | p t j u u s p j 4 a 3 4 : l r a a i r e b m m t ' b 5 t 7 3 4 a a t t l o s u e e ' u : i : : 1 t c i i d m t i n n i i o i i : e t o o e i _ l t t l n n n n i _ _ n n r s p d a a d s n r r s s , e r e t t e ` . ` ` e e . / d o r i i r b r i r ` n n r i l _ m : o o : l b n e r d d b n i d i 2 n n 2 o : s n e e e : s n e s 0 . . 0 c 1 t d n r r 1 t e l e : r r : k 6 r e d e e 6 r i d i b b i 6 u r e r r 4 u 2 v _ n : : n i : m ' r . . : m 0 e d 2 2 n i e ' r r i e r e ` 2 1 ` n n b b n n y l _ : : _ r t : : t _ i 3 i i 3 e ` ' 5 3 ` e o v 5 n n 5 n i 4 9 b r n e 4 4 d n : : l . r 6 ` ` 6 e s i i o r y 0 b p 0 r t n n c b _ 5 l r 5 ' r k : o b o o b u ` ` 2 n 2 c c 2 m b b i 0 3 k e 3 e l l n : 0 s 0 n o o i f i s f t c c i n b n _ b ' k k n 7 a 7 s ` 9 p c 9 ( i t i 9 r t 9 2 n r n e o i e u s 6 c o 6 l i m t 1 e n 1 e n e r b s ' b v s n u 9 s 9 e t t m a _ a l r ' e e a e s u n 5 c 5 ) m t b t b e ' 2 i 2 i n d o d n t 0 n 0 ' a ' a r 1 1 e b b n 7 7 d d d e ' ' r _ t e m p l a t e '

Where to start? Look at the first word of the trace:

N o M e t h o d E r r o r

This is a common Ruby error that means you tried to call a method that does not exist on an object. Important!

Next:

u n d e f i n e d m e t h o d ' e a c h ' f o r n i l : N i l C l a s s

Quite communicative! Something in the code is nil and we tried to call .each on it. Can Ruby iterate over nil? No, it can’t.

Next, we get an actual line of code:

a p p / v i e w s / p l a t f o r m / a p i / d e l i v e r y _ e s t i m a t e s / i n d e x . v 1 . j b u i l d e r , l i n e 2 0

Jump to that line quickly. Here it is:

json.estimates @estimators.each do |estimator|

Remember, we were trying to call .each on nil. There’s only one .each here which narrows it down. And what is it being called on? @estimators. This code doesn’t consider that @estimators can be nil, but it can.

We now have one job: find out where @estimators is being set and understand how it can be nil. That is the bug. We’re done debugging and now solving the problem.

Takeaways

After you acquire this knowledge, a neat trick is to stop and verbalize what’s happening. For this example, I’d say:

“When we ask for estimates, our view tries to iterate over a collection of estimators. That collection can be nil, which the API can’t handle.”

An imperfect summary, perhaps, but it’s a lot better than “the magic computer is doing magic things.”

Most of the stack trace is noise. Potentially relevant and interesting noise, but noise nonetheless. Follow your gut. If you’re reading lib/active_support/notifications/instrumenter.rb:20, the last line I shared of the full stack trace, you’re probably off track. Your code is likely causing the issue because it’s almost always your fault.

Happy debugging.