Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

test_off_tls1_2 test faliure (puma 6.1.1) #3093

Open
Apteryks opened this issue Mar 9, 2023 · 12 comments
Open

test_off_tls1_2 test faliure (puma 6.1.1) #3093

Apteryks opened this issue Mar 9, 2023 · 12 comments
Labels
bug ssl

Comments

@Apteryks
Copy link

Apteryks commented Mar 9, 2023

Describe the bug
When I run rake test, I see:

$ rake test
Rack::Handler is deprecated and replaced by Rackup::Handler
/gnu/store/7kmir0qvvkr29ak0za7y8jdhizk948xa-ruby-rack-3.0.4.2/lib/ruby/vendor_ruby/gems/rack-3.0.4.2/lib/rack/chunked.rb:6: warning: Rack::Chunked is deprecated and will be removed in Rack 3.1
Run options: --seed 24484

# Running:

.SSSS..../tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helpers/integration.rb:31: warning: instance variable @server not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helpers/integration.rb:33: warning: instance variable @server not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helpers/integration.rb:37: warning: instance variable @ios_to_close not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helpers/integration.rb:46: warning: instance variable @bind_path not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helpers/integration.rb:52: warning: instance variable @server not initialized
S........................................................................EEEEEE.......................................................................................................................................................................................................................................S......F......................................................................S..........................Traceback (most recent call last):
        10: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/bin/puma:8:in `<main>'
         9: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/bin/puma:8:in `new'
         8: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/lib/puma/cli.rb:66:in `initialize'
         7: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/lib/puma/cli.rb:66:in `new'
         6: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/lib/puma/launcher.rb:54:in `initialize'
         5: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/lib/puma/configuration.rb:236:in `load'
         4: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/lib/puma/configuration.rb:236:in `each'
         3: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/lib/puma/configuration.rb:236:in `block in load'
         2: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/lib/puma/dsl.rb:132:in `_load_from'
         1: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/lib/puma/dsl.rb:132:in `instance_eval'
test/config/prune_bundler_with_multiple_workers.rb:2:in `_load_from': undefined method `setup' for Bundler:Module (NoMethodError)
...F..S....E.......................................E....................S....................S.........S...Traceback (most recent call last):
        10: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/bin/puma:8:in `<main>'
         9: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/bin/puma:8:in `new'
         8: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/lib/puma/cli.rb:66:in `initialize'
         7: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/lib/puma/cli.rb:66:in `new'
         6: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/lib/puma/launcher.rb:54:in `initialize'
         5: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/lib/puma/configuration.rb:236:in `load'
         4: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/lib/puma/configuration.rb:236:in `each'
         3: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/lib/puma/configuration.rb:236:in `block in load'
         2: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/lib/puma/dsl.rb:132:in `_load_from'
         1: from /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/lib/puma/dsl.rb:132:in `instance_eval'
test/config/prune_bundler_with_multiple_workers.rb:2:in `_load_from': undefined method `setup' for Bundler:Module (NoMethodError)
....................................E

Fabulous run in 144.571919s, 3.9288 runs/s, 11.1087 assertions/s.
Errors & Failures:

  1) Error:
TestWorkerGemIndependence#test_changing_json_version_during_phased_restart_after_querying_stats_from_status_server:
NameError: uninitialized constant TestWorkerGemIndependence::Bundler
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:138:in `with_unbundled_env'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:95:in `block in change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:94:in `chdir'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:94:in `change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:37:in `test_changing_json_version_during_phased_restart_after_querying_stats_from_status_server'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:95:in `block in timeout'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helper.rb:89:in `block (3 levels) in run'

  2) Error:
TestWorkerGemIndependence#test_changing_json_version_during_phased_restart_after_querying_thread_backtraces_from_status_server:
NameError: uninitialized constant TestWorkerGemIndependence::Bundler
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:138:in `with_unbundled_env'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:95:in `block in change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:94:in `chdir'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:94:in `change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:67:in `test_changing_json_version_during_phased_restart_after_querying_thread_backtraces_from_status_server'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:95:in `block in timeout'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helper.rb:89:in `block (3 levels) in run'

  3) Error:
TestWorkerGemIndependence#test_changing_nio4r_version_during_phased_restart:
NameError: uninitialized constant TestWorkerGemIndependence::Bundler
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:138:in `with_unbundled_env'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:95:in `block in change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:94:in `chdir'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:94:in `change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:17:in `test_changing_nio4r_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:95:in `block in timeout'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helper.rb:89:in `block (3 levels) in run'

  4) Error:
TestWorkerGemIndependence#test_changing_json_version_during_phased_restart:
NameError: uninitialized constant TestWorkerGemIndependence::Bundler
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:138:in `with_unbundled_env'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:95:in `block in change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:94:in `chdir'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:94:in `change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:24:in `test_changing_json_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:95:in `block in timeout'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helper.rb:89:in `block (3 levels) in run'

  5) Error:
TestWorkerGemIndependence#test_changing_json_version_during_phased_restart_after_querying_gc_stats_from_status_server:
NameError: uninitialized constant TestWorkerGemIndependence::Bundler
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:138:in `with_unbundled_env'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:95:in `block in change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:94:in `chdir'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:94:in `change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:52:in `test_changing_json_version_during_phased_restart_after_querying_gc_stats_from_status_server'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:95:in `block in timeout'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helper.rb:89:in `block (3 levels) in run'

  6) Error:
TestWorkerGemIndependence#test_changing_json_version_during_phased_restart_after_accessing_puma_stats_directly:
NameError: uninitialized constant TestWorkerGemIndependence::Bundler
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:138:in `with_unbundled_env'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:95:in `block in change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:94:in `chdir'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:94:in `change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_worker_gem_independence.rb:76:in `test_changing_json_version_during_phased_restart_after_accessing_puma_stats_directly'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:95:in `block in timeout'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helper.rb:89:in `block (3 levels) in run'

  7) Failure:
TestIntegrationSSLSession#test_off_tls1_2 [/tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_integration_ssl_session.rb:130]:
session was reused

  8) Failure:
TestIntegrationCluster#test_load_path_includes_extra_deps [/tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_integration_cluster.rb:288]:
Expected /gems\/minitest-[\d.]+\/lib$/ to match "/gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/x86_64-linux\n".

  9) Error:
TestIntegrationCluster#test_fork_worker_on_refork:
Errno::EMFILE: Too many open files - socket(2) for "127.0.0.1" port 38637
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helpers/integration.rb:192:in `initialize'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helpers/integration.rb:192:in `new'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helpers/integration.rb:192:in `fast_connect'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_integration_cluster.rb:246:in `test_fork_worker_on_refork'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:95:in `block in timeout'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helper.rb:89:in `block (3 levels) in run'

 10) Error:
TestIntegrationCluster#test_prune_bundler_with_multiple_workers:
TimeoutEveryTestCase::TestTookTooLong: execution expired
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helpers/integration.rb:144:in `gets'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helpers/integration.rb:144:in `wait_for_server_to_include'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helpers/integration.rb:127:in `wait_for_server_to_boot'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helpers/integration.rb:90:in `cli_server'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_integration_cluster.rb:275:in `test_prune_bundler_with_multiple_workers'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helper.rb:89:in `block (3 levels) in run'

 11) Error:
TestIntegrationPumactl#test_prune_bundler_with_multiple_workers:
TimeoutEveryTestCase::TestTookTooLong: execution expired
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helpers/integration.rb:144:in `gets'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helpers/integration.rb:144:in `wait_for_server_to_include'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helpers/integration.rb:127:in `wait_for_server_to_boot'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helpers/integration.rb:90:in `cli_server'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/test_integration_pumactl.rb:136:in `test_prune_bundler_with_multiple_workers'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-3/source/test/helper.rb:89:in `block (3 levels) in run'

568 runs, 1606 assertions, 2 failures, 9 errors, 11 skips

You have skipped tests. Run with --verbose for details.
rake aborted!
Command failed with status (1)
/gnu/store/l7a6068vvi424q2rkf9f6yn9mych39sf-ruby-rake-13.0.6/lib/ruby/vendor_ruby/gems/rake-13.0.6/exe/rake:27:in `<top (required)>'
Tasks: TOP => test
(See full trace by running task with --trace)

$ bundler --version
Bundler version 2.4.8

If I try running with ./pre-inst-env guix build puma, attempting to build it in the Guix minimal container, the result is similar but I get a few extra failures/errors:

.EEEEEE................................................/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:31: warning: instance variable @server not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:33: warning: instance variable @server not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:37: warning: instance variable @ios_to_close not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:46: warning: instance variable @bind_path not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:52: warning: instance variable @server not initialized
S............................................................................................................................S.SSS.......................................................Ftest/config/prune_bundler_with_multiple_workers.rb:2:in `_load_from': undefined method `setup' for Bundler:Module (NoMethodError)
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/lib/puma/dsl.rb:132:in `instance_eval'
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/lib/puma/dsl.rb:132:in `_load_from'
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/lib/puma/configuration.rb:236:in `block in load'
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/lib/puma/configuration.rb:236:in `each'
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/lib/puma/configuration.rb:236:in `load'
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/lib/puma/launcher.rb:54:in `initialize'
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/lib/puma/cli.rb:66:in `new'
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/lib/puma/cli.rb:66:in `initialize'
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/bin/puma:8:in `new'
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/bin/puma:8:in `<main>'
........test/config/prune_bundler_with_multiple_workers.rb:2:in `_load_from': undefined method `setup' for Bundler:Module (NoMethodError)
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/lib/puma/dsl.rb:132:in `instance_eval'
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/lib/puma/dsl.rb:132:in `_load_from'
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/lib/puma/configuration.rb:236:in `block in load'
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/lib/puma/configuration.rb:236:in `each'
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/lib/puma/configuration.rb:236:in `load'
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/lib/puma/launcher.rb:54:in `initialize'
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/lib/puma/cli.rb:66:in `new'
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/lib/puma/cli.rb:66:in `initialize'
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/bin/puma:8:in `new'
        from /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/bin/puma:8:in `<main>'
/gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/rubygems/util.rb:81: warning: conflicting chdir during another chdir block
/gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/rubygems/util.rb:81: warning: conflicting chdir during another chdir block
/gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/rubygems/util.rb:81: warning: conflicting chdir during another chdir block
/gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/rubygems/util.rb:81: warning: conflicting chdir during another chdir block
/gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/rubygems/util.rb:81: warning: conflicting chdir during another chdir block
/gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/rubygems/util.rb:81: warning: conflicting chdir during another chdir block


................S...............F.......S................................................................................................S.....S..........................S....S.........................................................................................................................................EEEEFE

Finished in 114.694484s, 4.9523 runs/s, 14.3599 assertions/s.
Errors & Failures:

  1) Error:
TestWorkerGemIndependence#test_changing_json_version_during_phased_restart_after_querying_stats_from_status_server:
NameError: uninitialized constant TestWorkerGemIndependence::Bundler
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:138:in `with_unbundled_env'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:95:in `block in change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:94:in `chdir'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:94:in `change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:37:in `test_changing_json_version_during_phased_restart_after_querying_stats_from_status_server'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:95:in `block in timeout'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:89:in `block (3 levels) in run'

  2) Error:
TestWorkerGemIndependence#test_changing_json_version_during_phased_restart_after_accessing_puma_stats_directly:
NameError: uninitialized constant TestWorkerGemIndependence::Bundler
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:138:in `with_unbundled_env'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:95:in `block in change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:94:in `chdir'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:94:in `change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:76:in `test_changing_json_version_during_phased_restart_after_accessing_puma_stats_directly'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:95:in `block in timeout'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:89:in `block (3 levels) in run'

  3) Error:
TestWorkerGemIndependence#test_changing_json_version_during_phased_restart_after_querying_thread_backtraces_from_status_server:
NameError: uninitialized constant TestWorkerGemIndependence::Bundler
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:138:in `with_unbundled_env'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:95:in `block in change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:94:in `chdir'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:94:in `change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:67:in `test_changing_json_version_during_phased_restart_after_querying_thread_backtraces_from_status_server'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:95:in `block in timeout'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:89:in `block (3 levels) in run'

  4) Error:
TestWorkerGemIndependence#test_changing_nio4r_version_during_phased_restart:
NameError: uninitialized constant TestWorkerGemIndependence::Bundler
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:138:in `with_unbundled_env'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:95:in `block in change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:94:in `chdir'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:94:in `change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:17:in `test_changing_nio4r_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:95:in `block in timeout'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:89:in `block (3 levels) in run'

  5) Error:
TestWorkerGemIndependence#test_changing_json_version_during_phased_restart:
NameError: uninitialized constant TestWorkerGemIndependence::Bundler
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:138:in `with_unbundled_env'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:95:in `block in change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:94:in `chdir'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:94:in `change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:24:in `test_changing_json_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:95:in `block in timeout'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:89:in `block (3 levels) in run'

  6) Error:
TestWorkerGemIndependence#test_changing_json_version_during_phased_restart_after_querying_gc_stats_from_status_server:
NameError: uninitialized constant TestWorkerGemIndependence::Bundler
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:138:in `with_unbundled_env'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:95:in `block in change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:94:in `chdir'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:94:in `change_gem_version_during_phased_restart'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_worker_gem_independence.rb:52:in `test_changing_json_version_during_phased_restart_after_querying_gc_stats_from_status_server'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:95:in `block in timeout'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:89:in `block (3 levels) in run'

  7) Failure:
TestIntegrationSSLSession#test_off_tls1_2 [/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_integration_ssl_session.rb:130]:
session was reused

  8) Failure:
TestIntegrationCluster#test_load_path_includes_extra_deps [/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_integration_cluster.rb:288]:
Expected /gems\/minitest-[\d.]+\/lib$/ to match "/gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/x86_64-linux\n".

  9) Error:
TestIntegrationPumactl#test_prune_bundler_with_multiple_workers:
TimeoutEveryTestCase::TestTookTooLong: execution expired
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:144:in `gets'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:144:in `wait_for_server_to_include'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:127:in `wait_for_server_to_boot'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:90:in `cli_server'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_integration_pumactl.rb:136:in `test_prune_bundler_with_multiple_workers'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:89:in `block (3 levels) in run'

 10) Error:
TestIntegrationCluster#test_prune_bundler_with_multiple_workers:
TimeoutEveryTestCase::TestTookTooLong: execution expired
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:144:in `gets'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:144:in `wait_for_server_to_include'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:127:in `wait_for_server_to_boot'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:90:in `cli_server'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_integration_cluster.rb:275:in `test_prune_bundler_with_multiple_workers'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:89:in `block (3 levels) in run'

 11) Error:
TestIntegrationCluster#test_culling_strategy_oldest_fork_worker:
TimeoutEveryTestCase::TestTookTooLong: execution expired
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:104:in `wait2'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:104:in `stop_server'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:34:in `teardown'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_integration_cluster.rb:18:in `teardown'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `block (5 levels) in run'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `each'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:96:in `block (3 levels) in run'

 12) Error:
TestIntegrationCluster#test_fork_worker_on_refork:
TimeoutEveryTestCase::TestTookTooLong: execution expired
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:104:in `wait2'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:104:in `stop_server'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:34:in `teardown'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_integration_cluster.rb:18:in `teardown'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `block (5 levels) in run'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `each'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:96:in `block (3 levels) in run'

 13) Failure:
TestIntegrationCluster#test_usr1_fork_worker:
2 responses, 2 uniq pids.
Expected: 25
  Actual: 2

Error:
TestIntegrationCluster#test_usr1_fork_worker:
TimeoutEveryTestCase::TestTookTooLong: execution expired
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:104:in `wait2'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:104:in `stop_server'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:34:in `teardown'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_integration_cluster.rb:18:in `teardown'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `block (5 levels) in run'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `each'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:96:in `block (3 levels) in run'

 14) Error:
TestIntegrationPumactl#test_refork_cluster:
TimeoutEveryTestCase::TestTookTooLong: execution expired
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_integration_pumactl.rb:127:in `wait2'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_integration_pumactl.rb:127:in `test_refork_cluster'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:89:in `block (3 levels) in run'

Error:
TestIntegrationPumactl#test_refork_cluster:
TimeoutEveryTestCase::TestTookTooLong: execution expired
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:104:in `wait2'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:104:in `stop_server'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:34:in `teardown'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_integration_pumactl.rb:17:in `teardown'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `block (5 levels) in run'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `each'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:96:in `block (3 levels) in run'

568 runs, 1647 assertions, 3 failures, 11 errors, 11 skips

Puma config:

Building version 6.1.1 from git.

To Reproduce
rake test in the Guix puma environment, which has Ruby 2.7.4 and the following direct dependencies:

bundler@2.4.8 curl@7.79.1 openssl@1.1.1l ruby-json@2.1.0 ruby-localhost@1.1.10
+ ruby-m@1.6.1 ruby-minitest-proveit@1.0.0 ruby-minitest-retry@0.2.2 ruby-minitest-stub-const@0.6
+ ruby-nio4r@2.5.2 ruby-rack@3.0.4.2 ruby-rackup@2.1.0 ruby-rake-compiler@1.1.1 ruby-webrick@1.8.1

Expected behavior
The test suite should pass.

Desktop (please complete the following information):

  • OS: Guix System
  • Puma Version: 6.1.1
@Apteryks
Copy link
Author

Apteryks commented Mar 9, 2023

Ah, running the test suite with bundle exec rake test instead of just rake test reduces the errors (in the container) to:

# Running:

................................................................................./tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:31: warning: instance variable @server not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:33: warning: instance variable @server not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:37: warning: instance variable @ios_to_close not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:46: warning: instance variable @bind_path not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:52: warning: instance variable @server not initialized
S.......FFFFFF............................................................................................................................................................................................S...................................................................................................................S.S.............................S........................................................../gnu/store/8y9s90mxzdslkpadrnpdmq0rmjhlj6vm-ruby-nio4r-2.5.2/lib/ruby/vendor_ruby/gems/nio4r-2.5.2/lib/nio/version.rb:4: warning: already initialized constant NIO::VERSION
/gnu/store/8y9s90mxzdslkpadrnpdmq0rmjhlj6vm-ruby-nio4r-2.5.2/lib/ruby/vendor_ruby/gems/nio4r-2.5.2/lib/nio/version.rb:4: warning: previous definition of VERSION was here
......S..........F....S...................................................EEEF

Finished in 119.668102s, 4.7465 runs/s, 14.0138 assertions/s.
Errors & Failures:

  1) Failure:
TestWorkerGemIndependence#test_changing_nio4r_version_during_phased_restart [/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:65]:
Expected false to be truthy.

  2) Failure:
TestWorkerGemIndependence#test_changing_json_version_during_phased_restart_after_querying_stats_from_status_server [/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:65]:
Expected false to be truthy.

  3) Failure:
TestWorkerGemIndependence#test_changing_json_version_during_phased_restart_after_querying_gc_stats_from_status_server [/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:65]:
Expected false to be truthy.

  4) Failure:
TestWorkerGemIndependence#test_changing_json_version_during_phased_restart_after_querying_thread_backtraces_from_status_server [/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:65]:
Expected false to be truthy.

  5) Failure:
TestWorkerGemIndependence#test_changing_json_version_during_phased_restart [/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:65]:
Expected false to be truthy.

  6) Failure:
TestWorkerGemIndependence#test_changing_json_version_during_phased_restart_after_accessing_puma_stats_directly [/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:65]:
Expected false to be truthy.

  7) Failure:
TestIntegrationSSLSession#test_off_tls1_2 [/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_integration_ssl_session.rb:130]:
session was reused

  8) Error:
TestIntegrationCluster#test_culling_strategy_oldest_fork_worker:
TimeoutEveryTestCase::TestTookTooLong: execution expired
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:104:in `wait2'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:104:in `stop_server'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:34:in `teardown'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_integration_cluster.rb:18:in `teardown'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `block (5 levels) in run'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `each'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:96:in `block (3 levels) in run'

  9) Error:
TestIntegrationCluster#test_fork_worker_on_refork:
TimeoutEveryTestCase::TestTookTooLong: execution expired
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:104:in `wait2'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:104:in `stop_server'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:34:in `teardown'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_integration_cluster.rb:18:in `teardown'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `block (5 levels) in run'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `each'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:96:in `block (3 levels) in run'

 10) Error:
TestIntegrationPumactl#test_refork_cluster:
TimeoutEveryTestCase::TestTookTooLong: execution expired
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_integration_pumactl.rb:127:in `wait2'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_integration_pumactl.rb:127:in `test_refork_cluster'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:89:in `block (3 levels) in run'

Error:
TestIntegrationPumactl#test_refork_cluster:
TimeoutEveryTestCase::TestTookTooLong: execution expired
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:104:in `wait2'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:104:in `stop_server'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:34:in `teardown'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_integration_pumactl.rb:17:in `teardown'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `block (5 levels) in run'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `each'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:96:in `block (3 levels) in run'

 11) Failure:
TestIntegrationCluster#test_usr1_fork_worker:
2 responses, 1 uniq pids.
Expected: 25
  Actual: 2

Error:
TestIntegrationCluster#test_usr1_fork_worker:
TimeoutEveryTestCase::TestTookTooLong: execution expired
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:104:in `wait2'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:104:in `stop_server'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:34:in `teardown'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_integration_cluster.rb:18:in `teardown'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `block (5 levels) in run'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `each'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:97:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helper.rb:96:in `block (3 levels) in run'

568 runs, 1677 assertions, 8 failures, 3 errors, 7 skips

You have skipped tests. Run with --verbose for details.
rake aborted!
Command failed with status (1)

@dentarg
Copy link
Member

dentarg commented Mar 9, 2023

This seems like an issue with your environment and not Puma so I would like to move it to an discussion, however, we have #2930 so it should probably be closed as a duplicate.

Feel free to figure out what's going on and report back.

Is it possible to replicate in Docker (or similar) or CI? Would be great to provide such steps so others can try it too.

@Apteryks
Copy link
Author

Apteryks commented Mar 9, 2023

Hello!

I don't think it'd be easily reproduced in a Docker container if your CI runs these and passes. It's probably something specific/more restricted in the Guix build container.

Guix is designed to make reproducible environments easy though, so I could push my wip Guix branch if you'd like to try it, it can be done with something like (assuming you've already installed Guix on your machine):

$ guix pull --url=https://gitlab.com/Apteryks/guix --branch=puma-3093-repro
$ guix build puma

Assuming the above guix pull worked, an non-containerized environment can now also be set up with:

$ guix shell --develop puma
[env]$ bundle exec rake test

It should reproduce what I see exactly.

@Apteryks
Copy link
Author

Apteryks commented Mar 9, 2023

Outside of the build container there is only 2 problems, one of them being a too low setrlimit on my machine (can be disregarded); the other one about TLS I'm not sure:

$ bundle exec rake test
Rack::Handler is deprecated and replaced by Rackup::Handler
/gnu/store/7kmir0qvvkr29ak0za7y8jdhizk948xa-ruby-rack-3.0.4.2/lib/ruby/vendor_ruby/gems/rack-3.0.4.2/lib/rack/chunked.rb:6: warning: Rack::Chunked is deprecated and will be removed in Rack 3.1
Run options: --seed 40062

# Running:

........../tmp/guix-build-ruby-puma-6.1.1.drv-6/source/test/helpers/integration.rb:31: warning: instance variable @server not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-6/source/test/helpers/integration.rb:33: warning: instance variable @server not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-6/source/test/helpers/integration.rb:37: warning: instance variable @ios_to_close not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-6/source/test/helpers/integration.rb:46: warning: instance variable @bind_path not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-6/source/test/helpers/integration.rb:52: warning: instance variable @server not initialized
S................................. ......................^N........................................................................................................................................E....................S...................................................................................................................................S...............S.................................................................................F...................S.............S...........S....................................................................

Fabulous run in 199.821953s, 2.8425 runs/s, 8.3574 assertions/s.
Errors & Failures:

  1) Error:
TestIntegrationCluster#test_fork_worker_on_refork:
Errno::EMFILE: Too many open files - socket(2) for "127.0.0.1" port 43203
    /tmp/guix-build-ruby-puma-6.1.1.drv-6/source/test/helpers/integration.rb:192:in `initialize'
    /tmp/guix-build-ruby-puma-6.1.1.drv-6/source/test/helpers/integration.rb:192:in `new'
    /tmp/guix-build-ruby-puma-6.1.1.drv-6/source/test/helpers/integration.rb:192:in `fast_connect'
    /tmp/guix-build-ruby-puma-6.1.1.drv-6/source/test/test_integration_cluster.rb:246:in `test_fork_worker_on_refork'
    /tmp/guix-build-ruby-puma-6.1.1.drv-6/source/test/helper.rb:91:in `block (4 levels) in run'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:95:in `block in timeout'
    /gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/lib/ruby/2.7.0/timeout.rb:105:in `timeout'
    /tmp/guix-build-ruby-puma-6.1.1.drv-6/source/test/helper.rb:89:in `block (3 levels) in run'

  2) Failure:
TestIntegrationSSLSession#test_off_tls1_2 [/tmp/guix-build-ruby-puma-6.1.1.drv-6/source/test/test_integration_ssl_session.rb:130]:
session was reused

568 runs, 1670 assertions, 1 failures, 1 errors, 7 skips

You have skipped tests. Run with --verbose for details.
rake aborted!
Command failed with status (1)
/gnu/store/l7a6068vvi424q2rkf9f6yn9mych39sf-ruby-rake-13.0.6/lib/ruby/vendor_ruby/gems/rake-13.0.6/exe/rake:27:in `<top (required)>'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/cli/exec.rb:58:in `load'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/cli/exec.rb:58:in `kernel_load'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/cli/exec.rb:23:in `run'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/cli.rb:492:in `exec'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/vendor/thor/lib/thor/command.rb:27:in `run'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/vendor/thor/lib/thor/invocation.rb:127:in `invoke_command'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/vendor/thor/lib/thor.rb:392:in `dispatch'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/cli.rb:34:in `dispatch'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/vendor/thor/lib/thor/base.rb:485:in `start'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/cli.rb:28:in `start'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/exe/bundle:45:in `block in <top (required)>'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/friendly_errors.rb:117:in `with_friendly_errors'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/exe/bundle:33:in `<top (required)>'
/gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/bin/bundle:23:in `load'
/gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/bin/bundle:23:in `<main>'
Tasks: TOP => test
(See full trace by running task with --trace)

Perhaps the container problems stem from the fact that dead processes are not reaped in this environment (the PID 1 is not an init but a Guile script).

@dentarg
Copy link
Member

dentarg commented Mar 9, 2023

The tests run on GitHub Actions which are virtual machines with Ubuntu. Could we install guix there to reproduce the problem? (And how does one do it?) You can experiment in your fork of Puma.

@Apteryks
Copy link
Author

Apteryks commented Mar 10, 2023 •
edited

Installing Guix can be done on any GNU/Linux system like so:

  wget -O guix-install.sh https://guix-install.sh
  chmod +x guix-insall.sh
  yes | sudo ./guix-install.sh
  # close and reopen session
  guix pull   # to update guix itself and its package collection
  guix install glibc-locales   # for proper localization support

The finer details can be read at https://guix.gnu.org/manual/en/html_node/Binary-Installation.html. The install script automates all of the manual steps.

@nateberkopec
Copy link
Member

Looks like an SSL version issue.

If you run with PUMA_TEST_DEBUG=1 what do you get?

@nateberkopec
Copy link
Member

I could push my wip Guix branch

I'm interested in this. I would consider committing some Guix-related and Nix-related support files to the repo.

@Apteryks
Copy link
Author

Hey, nice to hear that :-). The instructions I gave above should work in case you want to experiment. But I think a possible explanation for the SSL test failure; the Guix openssl used is detected as 1.1.1l, while it actually is 1.1.1t. That's a side-effect of grafts, a concept used in Guix to rewrite the dependency graph without having to rebuild all dependent packages (useful for timely security updates).

Looking at the test code though, it seems it shouldn't matter:

  def test_off_tls1_2
    ssl_vers = Puma::MiniSSL::OPENSSL_LIBRARY_VERSION
    old_ssl = ssl_vers.include?(' 1.0.') || ssl_vers.match?(/ 1\.1\.1[ a-e]/)
    skip 'Requires 1.1.1f or later' if old_ssl
    reused = run_session 'nil', '--tls-max 1.2'
    refute reused, 'session was reused'
  end

as long as the version detected is newer than 1.1.1e it is expected to work the same.

Output with PUMA_TEST_DEBUG=1:

ruby 2.7.4p191 (2021-07-07 revision a21a3b7d23) [x86_64-linux]
RUBYOPT: -r/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/setup
                         Puma::MiniSSL                   OpenSSL
OPENSSL_LIBRARY_VERSION: OpenSSL 1.1.1l  24 Aug 2021     OpenSSL 1.1.1l  24 Aug 2021
        OPENSSL_VERSION: OpenSSL 1.1.1l  24 Aug 2021     OpenSSL 1.1.1l  24 Aug 2021

Run options: --seed 12666

# Running:

............../tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:31: warning: instance variable @server not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:33: warning: instance variable @server not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:37: warning: instance variable @ios_to_close not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:46: warning: instance variable @bind_path not initialized
/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/helpers/integration.rb:52: warning: instance variable @server not initialized
S.............................................................................................................................................................................S....SSS............S.................................................S.....................S....................S..................S........................................................................................................................................................................................S................................F.......................

Finished in 53.266164s, 10.5508 runs/s, 31.1267 assertions/s.
Errors & Failures:

  1) Failure:
TestIntegrationSSLSession#test_off_tls1_2 [/tmp/guix-build-ruby-puma-6.1.1.drv-0/source/test/test_integration_ssl_session.rb:130]:
session was reused

562 runs, 1658 assertions, 1 failures, 0 errors, 11 skips

You have skipped tests. Run with --verbose for details.

──────────────────────────────────────────────────────────────────────── Debugging Info ──
TestIntegrationCluster#test_hot_restart_does_not_drop_connections
    3 restarts, 0 resets, 0 refused, 786 success after restart, 0 write error
TestIntegrationCluster#test_hot_restart_does_not_drop_connections_threads
    3 restarts, 0 resets, 0 refused, 2567 success after restart, 0 write error
TestIntegrationCluster#test_term_closes_listeners_tcp
    11 successes, 1 resets, 28 refused, 0 failures, 0 read timeouts
TestIntegrationCluster#test_term_closes_listeners_unix
    10 successes, 0 resets, 30 refused, 0 failures, 0 read timeouts
TestIntegrationSingle#test_hot_restart_does_not_drop_connections
    1 restarts, 0 resets, 0 refused, 199 success after restart, 0 write error
TestIntegrationSingle#test_hot_restart_does_not_drop_connections_threads
    2 restarts, 0 resets, 0 refused, 594 success after restart, 0 write error
──────────────────────────────────────────────────────────────────────────────────────────

rake aborted!
Command failed with status (1)

@MSP-Greg
Copy link
Member

@Apteryks

Thanks for checking this. The current test file does not show the curl output when a failure occurs, so it's not very helpful.

I've got a patch in a branch in my fork, see:
https://github.com/MSP-Greg/puma/blob/00-issue-3093-reuse/test/test_integration_ssl_session.rb

I think that should show the curl output. Can you try running it?

@MSP-Greg
Copy link
Member

@Apteryks I think this is now about 'SSL session reuse'? Might we change the title/subject of the issue?

@Apteryks
Copy link
Author

Hello! I tried it with the command:

./pre-inst-env guix build ruby-puma --with-git-url=ruby-puma=https://github.com/MSP-Greg/puma --with-branch=ruby-puma=00-issue-3093-reuse

And the tail of the build log reads as:

ruby 2.7.4p191 (2021-07-07 revision a21a3b7d23) [x86_64-linux]
RUBYOPT: -r/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/setup
                         Puma::MiniSSL                   OpenSSL
OPENSSL_LIBRARY_VERSION: OpenSSL 1.1.1l  24 Aug 2021     OpenSSL 1.1.1l  24 Aug 2021
        OPENSSL_VERSION: OpenSSL 1.1.1l  24 Aug 2021     OpenSSL 1.1.1l  24 Aug 2021

Run options: --seed 5523

# Running:

...................../tmp/guix-build-ruby-puma-git.00-issue-3093-reuse.drv-0/source/test/helpers/integration.rb:31: warning: instance variable @server not initialized
/tmp/guix-build-ruby-puma-git.00-issue-3093-reuse.drv-0/source/test/helpers/integration.rb:33: warning: instance variable @server not initialized
/tmp/guix-build-ruby-puma-git.00-issue-3093-reuse.drv-0/source/test/helpers/integration.rb:37: warning: instance variable @ios_to_close not initialized
/tmp/guix-build-ruby-puma-git.00-issue-3093-reuse.drv-0/source/test/helpers/integration.rb:46: warning: instance variable @bind_path not initialized
/tmp/guix-build-ruby-puma-git.00-issue-3093-reuse.drv-0/source/test/helpers/integration.rb:52: warning: instance variable @server not initialized
S.............................................................................................................................................................................S...........S..............S.......S.S.................................................F........................................................................................................................................S............................S..............................S...................Parsing options from the first comment line is deprecated!
.....S....S...........................................................

Finished in 47.174545s, 12.0616 runs/s, 35.7396 assertions/s.
Errors & Failures:

  1) Failure:
TestIntegrationSSLSession#test_off_tls1_2 [/tmp/guix-build-ruby-puma-git.00-issue-3093-reuse.drv-0/source/test/test_integration_ssl_session.rb:127]:
session was reused.
Expected "*   Trying 127.0.0.1:42605...\n  % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current\n                                 Dload  Upload   Total   Spent    Left  Speed\n\r  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0* Connected to 127.0.0.1 (127.0.0.1) port 42605 (#0)\n* GnuTLS ciphers: NORMAL:-ARCFOUR-128:-CTYPE-ALL:+CTYPE-X509:-VERS-SSL3.0:-VERS-TLS-ALL:+VERS-TLS1.2:+VERS-TLS1.1:+VERS-TLS1.0\n* ALPN, offering http/1.1\n* SSL connection using TLS1.2 / ECDHE_RSA_AES_256_GCM_SHA384\n*   server certificate verification SKIPPED\n*   server certificate status verification SKIPPED\n*   common name: localhost (does not match '127.0.0.1')\n*   server certificate expiration date OK\n*   server certificate activation date OK\n*   certificate public key: RSA\n*   certificate version: #3\n*   subject: DC=net,DC=puma,CN=localhost\n*   start date: Sat, 01 Aug 2020 00:00:00 GMT\n*   expire date: Thu, 01 Aug 2024 00:00:00 GMT\n*   issuer: DC=net,DC=puma,CN=CA\n* ALPN, server did not agree to a protocol\n> GET / HTTP/1.1\r\n> Host: 127.0.0.1:42605\r\n> User-Agent: curl/7.79.1\r\n> Accept: */*\r\n> Connection: close\r\n> \r\n* Mark bundle as not supporting multiuse\n< HTTP/1.1 200 OK\r\n< Connection: close\r\n< Content-Length: 5\r\n< \r\n{ [5 bytes data]\n\r100     5  100     5    0     0   2171      0 --:--:-- --:--:-- --:--:--  2500\n* Closing connection 0\nhttps* Hostname 127.0.0.1 was found in DNS cache\n*   Trying 127.0.0.1:42605...\n  % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current\n                                 Dload  Upload   Total   Spent    Left  Speed\n\r  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0* Connected to 127.0.0.1 (127.0.0.1) port 42605 (#1)\n* GnuTLS ciphers: NORMAL:-ARCFOUR-128:-CTYPE-ALL:+CTYPE-X509:-VERS-SSL3.0:-VERS-TLS-ALL:+VERS-TLS1.2:+VERS-TLS1.1:+VERS-TLS1.0\n* ALPN, offering http/1.1\n* SSL re-using session ID\n* SSL connection using TLS1.2 / ECDHE_RSA_AES_256_GCM_SHA384\n*   server certificate verification SKIPPED\n*   server certificate status verification SKIPPED\n*   common name: localhost (does not match '127.0.0.1')\n*   server certificate expiration date OK\n*   server certificate activation date OK\n*   certificate public key: RSA\n*   certificate version: #3\n*   subject: DC=net,DC=puma,CN=localhost\n*   start date: Sat, 01 Aug 2020 00:00:00 GMT\n*   expire date: Thu, 01 Aug 2024 00:00:00 GMT\n*   issuer: DC=net,DC=puma,CN=CA\n* ALPN, server did not agree to a protocol\n> GET / HTTP/1.1\r\n> Host: 127.0.0.1:42605\r\n> User-Agent: curl/7.79.1\r\n> Accept: */*\r\n> Connection: close\r\n> \r\n* Mark bundle as not supporting multiuse\n< HTTP/1.1 200 OK\r\n< Connection: close\r\n< Content-Length: 5\r\n< \r\n{ [5 bytes data]\n\r100     5  100     5    0     0   2860      0 --:--:-- --:--:-- --:--:--  5000\n* Closing connection 1\nhttps" to not include "* SSL re-using session ID".

569 runs, 1686 assertions, 1 failures, 0 errors, 11 skips

You have skipped tests. Run with --verbose for details.

──────────────────────────────────────────────────────────────────────── Debugging Info ──
TestIntegrationCluster#test_hot_restart_does_not_drop_connections
    2 restarts, 0 resets, 0 refused, 758 success after restart, 0 write error
TestIntegrationCluster#test_hot_restart_does_not_drop_connections_threads
    3 restarts, 0 resets, 0 refused, 2513 success after restart, 0 write error
TestIntegrationCluster#test_term_closes_listeners_tcp
    11 successes, 2 resets, 27 refused, 0 failures, 0 read timeouts
TestIntegrationCluster#test_term_closes_listeners_unix
    10 successes, 0 resets, 30 refused, 0 failures, 0 read timeouts
TestIntegrationSingle#test_hot_restart_does_not_drop_connections
    1 restarts, 0 resets, 0 refused, 87 success after restart, 0 write error
TestIntegrationSingle#test_hot_restart_does_not_drop_connections_threads
    2 restarts, 0 resets, 0 refused, 597 success after restart, 0 write error
──────────────────────────────────────────────────────────────────────────────────────────

rake aborted!
Command failed with status (1)
/gnu/store/l7a6068vvi424q2rkf9f6yn9mych39sf-ruby-rake-13.0.6/lib/ruby/vendor_ruby/gems/rake-13.0.6/exe/rake:27:in `<top (required)>'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/cli/exec.rb:58:in `load'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/cli/exec.rb:58:in `kernel_load'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/cli/exec.rb:23:in `run'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/cli.rb:492:in `exec'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/vendor/thor/lib/thor/command.rb:27:in `run'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/vendor/thor/lib/thor/invocation.rb:127:in `invoke_command'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/vendor/thor/lib/thor.rb:392:in `dispatch'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/cli.rb:34:in `dispatch'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/vendor/thor/lib/thor/base.rb:485:in `start'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/cli.rb:28:in `start'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/exe/bundle:45:in `block in <top (required)>'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/lib/bundler/friendly_errors.rb:117:in `with_friendly_errors'
/gnu/store/r2i29lm86yj10q5f99ivgr2pc7jm9s4i-bundler-2.4.8/lib/ruby/vendor_ruby/gems/bundler-2.4.8/exe/bundle:33:in `<top (required)>'
/gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/bin/bundle:23:in `load'
/gnu/store/j4z07lyi1ykk8bc68h1p4bpj1il9dn3f-ruby-2.7.4/bin/bundle:23:in `<main>'
Tasks: TOP => test
(See full trace by running task with --trace)
error: in phase 'check': uncaught exception:
%exception #<&invoke-error program: "bundle" arguments: ("exec" "rake" "test") exit-status: 1 term-signal: #f stop-signal: #f> 
phase `check' failed after 50.1 seconds

@Apteryks Apteryks changed the title Test suite failures for puma 6.1.1 (Bundler-related errors) test_off_tls1_2 test faliure (puma 6.1.1) Mar 12, 2023
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
bug ssl
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
4 participants
@dentarg @nateberkopec @Apteryks @MSP-Greg