splitwise/super_diff

RSpec hanging when matching on http response

tomchipchase opened this issue · 14 comments

We've seen an issue where in a rails request spec we have something like this:

it "returns a failure" do
  post some_path(**args)
  expect(response).to be_created
end

In cases where the spec would fail, it seems to hang forever (I'm not sure if it would eventually complete if I left it, but it hits our CI pipeline timeout limit of 15 minutes).

I've managed to trace it to a method within super_diff when its trying to report the failure, but I've not found the root cause.

We're using version super_diff 0.9.0, with rspec 3.11.0 (and rails 7.0.4). (I can provide our Gemfile.lock if that would be useful).

If anyone else comes across this with the same problem, we've worked around this by using have_http_status(:created) instead.

Exactly the same problem and solution. the use of be_ predicates seems to be the trigger but only when the test would fail

expect(response).to be_successful
=> passes
expect(response).not_to be_successful
=> hangs

We are experiencing this as well. It appears to be a problem with trying to inspect the ActionDispatch::TestResponse. It goes into infinite recursions which the RecursionGuard doesn't seem to detect. Another way to reproduce the infinite recursion, in a request spec:

SuperDiff.inspect_object(response, as_lines: false)

If it helps any, I found that rspec had the same issue with this object, and they fixed it with this rails PR.

There's another bit of a hacky fix by changing the RecursionGuard. In this method, if I keep a counter, and guard against that counter hitting too high of a value, we can break out of the infinite loop. Proof of concept code:

def self.guarding_recursion_of(*objects, &block)
  Thread.current["recursion_counter"] ||= 0 
  Thread.current["recursion_counter"] = Thread.current["recursion_counter"] + 1

  already_seen_objects, first_seen_objects = objects.partition do |object|
    !SuperDiff.primitive?(object) && (Thread.current["recursion_counter"] > 1000 || already_seen?(object))
  end

# rest of the method is unchanged

Ah, thanks @travatomic, that's helpful. I'll take a look at the Rails fix — maybe inspect_object can look for a ActionDispatch::TestResponse and monkeypatch it on the fly so that to_a returns something else. It would be educational to start by tracing it and finding which method it keeps recursing on, though. As for your recursion counter idea, that would be good in general as well, in case we run into any other situations like this in the future. In any case I'm a bit busy at the moment but will hopefully have time to look at this shortly.

For anyone else having this problem: I have two solutions. Both solutions work in the user code and don't need a change to the gem. My company is probably going with option 1.

Solution 1:

Monkey patch the TestResponse. Add this to the bottom of spec/rails_helper.rb.

class ActionDispatch::TestResponse
  def attributes_for_super_diff
    {
      status: status,
      # you could also add headers or body here if those are meaningful to you.
    }
  end
end

Solution 2:

Create a new inspection tree builder. Make the following new file at spec/support/super_diff/action_dispatch_test_response_inspection_tree_builder.rb

class ActionDispatchTestResponseInspectionTreeBuilder < SuperDiff::ObjectInspection::InspectionTreeBuilders::Base
  def self.applies_to?(value)
    value.is_a?(ActionDispatch::TestResponse)
  end

  def call
    SuperDiff::ObjectInspection::InspectionTree.new do
      as_lines_when_rendering_to_lines(collection_bookend: :open) do
        add_text { |object| "#<#{object.class} " }

        when_rendering_to_lines { add_text "{" }
      end

      nested do |object|
        response_hash = {
          status: object.status,
        }
        insert_hash_inspection_of(response_hash)
      end

      as_lines_when_rendering_to_lines(collection_bookend: :close) do
        when_rendering_to_lines { add_text "}" }

        add_text ">"
      end
    end
  end
end

Then change your SuperDiff configuration to use the new inspection tree builder:

SuperDiff.configure do |config|
  config.add_extra_inspection_tree_builder_classes(
    ActionDispatchTestResponseInspectionTreeBuilder
  )
end

Output

With either option, the output looks something like this:

Failures:

  1) Api::UsersController GET /api/user/settings returns not found
     Failure/Error: expect(response).to be_not_found

                            Expected #<ActionDispatch::TestResponse status: 200>
       to return a truthy result for not_found? or not_founds?
     # ./spec/requests/api/users_spec.rb:25:in `block (3 levels) in <top (required)>'

@mcmire do you think either one of these is suitable to add to the gem?

I ran into this today using gem version 0.10.0.

Will add one more workaround:

      expect(response.successful?).to be true

It's a little less fancy, but seems to not have issues when the test fails.


By the way, I am not getting "hanging" behavior. For the code below:

      expect(response).to be_successful?

I just get an error like:

     NoMethodError:
       undefined method `keys' for nil:NilClass
     # /Users/anthony/.rvm/gems/ruby-3.2.2@my-project/gems/super_diff-0.10.0/lib/super_diff/object_inspection/inspection_tree.rb:72:in `insert_hash_inspection_of'

Also please note that #159 (comment) seems to reference the same issue, in case that is helpful.

This just bit me and took some time to debug. This issue has been around a while. @mcmire do you have any thoughts about applying a fix to the gem?

Bumping this as well, my company is facing this issue as well. A fix to the gem would be great.

I agree this has been around a while — sorry for the delay on this. I'll try to look at this soon!