From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: X-Spam-Checker-Version: SpamAssassin 3.4.2 (2018-09-13) on dcvr.yhbt.net X-Spam-Level: X-Spam-Status: No, score=-2.4 required=3.0 tests=AWL,BAYES_00, DKIM_ADSP_CUSTOM_MED,FORGED_GMAIL_RCVD,FREEMAIL_FORGED_FROMDOMAIN, FREEMAIL_FROM,HEADER_FROM_DIFFERENT_DOMAINS,MAILING_LIST_MULTI, SPF_HELO_NONE,SPF_PASS,UNPARSEABLE_RELAY shortcircuit=no autolearn=no autolearn_force=no version=3.4.2 Received: from neon.ruby-lang.org (neon.ruby-lang.org [221.186.184.75]) by dcvr.yhbt.net (Postfix) with ESMTP id 6E3651F4B4 for ; Sun, 6 Dec 2020 14:33:13 +0000 (UTC) Received: from neon.ruby-lang.org (localhost [IPv6:::1]) by neon.ruby-lang.org (Postfix) with ESMTP id 96C761209CA; Sun, 6 Dec 2020 23:32:27 +0900 (JST) Received: from o1678948x4.outbound-mail.sendgrid.net (o1678948x4.outbound-mail.sendgrid.net [167.89.48.4]) by neon.ruby-lang.org (Postfix) with ESMTPS id 270701209C4 for ; Sun, 6 Dec 2020 23:32:24 +0900 (JST) Received: by filterdrecv-p3iad2-6544fb89f6-xkm7c with SMTP id filterdrecv-p3iad2-6544fb89f6-xkm7c-18-5FCCEB9E-45 2020-12-06 14:33:02.485898289 +0000 UTC m=+235825.199867796 Received: from herokuapp.com (unknown) by geopod-ismtpd-2-3 (SG) with ESMTP id eYJECU0gS32_mQHBl6d8Ag for ; Sun, 06 Dec 2020 14:33:02.417 +0000 (UTC) Date: Sun, 06 Dec 2020 14:33:02 +0000 (UTC) From: yasuo.honda@gmail.com Message-ID: References: Mime-Version: 1.0 X-Redmine-MailingListIntegration-Message-Ids: 77130 X-Redmine-Project: ruby-master X-Redmine-Issue-Tracker: Bug X-Redmine-Issue-Id: 17220 X-Redmine-Issue-Author: yahonda X-Redmine-Issue-Assignee: Glass_saga X-Redmine-Sender: yahonda X-Mailer: Redmine X-Redmine-Host: bugs.ruby-lang.org X-Redmine-Site: Ruby Issue Tracking System X-Auto-Response-Suppress: All Auto-Submitted: auto-generated X-SG-EID: =?us-ascii?Q?DxUY8rT3gN23S6zXgBXsyZrbdOxEboSr6aRiQceB1g0yYH9yJvKmSOCaDceNAf?= =?us-ascii?Q?GIOt0R2fXzTjrraqx7LbCnQO5Oh7BaEvddN9tg4?= =?us-ascii?Q?wvvmTCc=2F+9D9RMSvjOenfnxxjvkINZidzQycNHb?= =?us-ascii?Q?FXCvKzYczrEmmFlm+N=2FwnQjd52j0tTnF+VC9eoY?= =?us-ascii?Q?RpWOUTpjtxivP1sRQwbGv9YLIyhKH+ihst60WVA?= =?us-ascii?Q?vIFQAlUu1oszcyhQU=3D?= To: ruby-core@ruby-lang.org X-Entity-ID: b/2+PoftWZ6GuOu3b0IycA== X-ML-Name: ruby-core X-Mail-Count: 101261 Subject: [ruby-core:101261] [Ruby master Bug#17220] Rails Active Job integration test fails with Ruby 3.0.0 since 2038cc6cab6ceeffef3ec3a765c70ae684f829ed X-BeenThere: ruby-core@ruby-lang.org X-Mailman-Version: 2.1.15 Precedence: list Reply-To: Ruby developers List-Id: Ruby developers List-Unsubscribe: , List-Post: List-Help: List-Subscribe: , Content-Type: text/plain; charset="us-ascii" Content-Transfer-Encoding: 7bit Errors-To: ruby-core-bounces@ruby-lang.org Sender: "ruby-core" Issue #17220 has been updated by yahonda (Yasuo Honda). Thanks for providing the fix. I have opened a pull request to revert 'sleep 1' workarounds https://github.com/rails/rails/pull/40754 . ---------------------------------------- Bug #17220: Rails Active Job integration test fails with Ruby 3.0.0 since 2038cc6cab6ceeffef3ec3a765c70ae684f829ed https://bugs.ruby-lang.org/issues/17220#change-88939 * Author: yahonda (Yasuo Honda) * Status: Closed * Priority: Normal * Assignee: Glass_saga (Masaki Matsushita) * Target version: 3.0 * ruby -v: ruby 2.8.0dev (2020-08-27T07:39:13Z v3_0_0_preview1~397 2038cc6cab) [x86_64-linux] * Backport: 2.5: DONTNEED, 2.6: DONTNEED, 2.7: DONTNEED ---------------------------------------- One of the Rails CI, Active Job integration test with sidekiq, against Ruby 3.0.0 has been failing since August 30, 2020. According to `git bisect` is is triggered by 2038cc6cab6ceeffef3ec3a765c70ae684f829ed . Somehow this issue only reproduces with Ruby on Docker like `rubylang/ruby:master-nightly-bionic` It does not reproduce if Ruby is installed locally using `rbenv install 3.0.0-dev` on Ubuntu 20.04 and macOS 11 beta. ### The first failed build job https://buildkite.com/rails/rails/builds/71321#84b29655-b3df-4b5c-8b20-cbf15ecd9653 ``` ruby Ruby 2.8.0p-1 (2020-08-29 revision d7492a0be885ea9f2b9f71e3e95582f9a859c439) [x86_64-linux] ``` ### The last successful build job https://buildkite.com/rails/rails/builds/71143#369217f7-95f6-4ab9-8ef5-7c6364bd803e ```ruby Ruby 2.8.0p-1 (2020-08-20 revision a74df67244199d1fd1f7a20b49dd5a096d2a13a2) [x86_64-linux] ``` ### `git bisect` result Performed `git bisect` ruby/ruby repository and it says `2038cc6cab6ceeffef3ec3a765c70ae684f829ed` triggers this build failure. ## Steps to reproduce 1. Install Docker 2. Install Ruby 2.7.1 (or whatever Ruby version to run rake) 3. Create Ruby docker image for 2038cc6cab6ceeffef3ec3a765c70ae684f829ed ``` git clone https://github.com/ruby/ruby-docker-images.git cd ruby-docker-images rake docker:build ruby_version=master:2038cc6cab6ceeffef3ec3a765c70ae684f829ed ``` 4. Run Rails CI using the Docker image created in step 3 ``` cd ~ git clone https://github.com/rails/rails.git cd rails git clone https://github.com/rails/buildkite-config .buildkite/ RUBY_IMAGE=rubylang/ruby:master-2038cc6cab6ceeffef3ec3a765c70ae684f829ed-bionic docker-compose -f .buildkite/docker-compose.yml build base && CI=1 docker-compose -f .buildkite/docker-compose.yml run default runner activejob 'AJ_ADAPTER=sidekiq AJ_INTEGRATION_TESTS=true bin/test test/integration/queuing_test.rb --seed 5170' ``` ## Actual result ``` Using sidekiq Run options: --seed 5170 # Running: .SSSF Failure: QueuingTest#test_should_run_job_enqueued_in_the_future_at_the_specified_time [/rails/activejob/test/integration/queuing_test.rb:76]: Expected false to be truthy. bin/test test/integration/queuing_test.rb:71 .F Failure: QueuingTest#test_should_run_jobs_enqueued_on_a_listening_queue [/rails/activejob/test/integration/queuing_test.rb:14]: Expected false to be truthy. bin/test test/integration/queuing_test.rb:11 .SS..F Failure: QueuingTest#test_current_locale_is_kept_while_running_perform_later [/rails/activejob/test/integration/queuing_test.rb:102]: Expected false to be truthy. bin/test test/integration/queuing_test.rb:93 F Failure: QueuingTest#test_current_timezone_is_kept_while_running_perform_later [/rails/activejob/test/integration/queuing_test.rb:119]: Expected false to be truthy. bin/test test/integration/queuing_test.rb:110 .. Finished in 34.153644s, 0.4392 runs/s, 0.3514 assertions/s. 15 runs, 12 assertions, 4 failures, 0 errors, 5 skips You have skipped tests. Run with --verbose for details. ``` ## Expected result It should success as the Ruby as of the previous commit `1035a3b202ee86bf2b0a1d00eefcfff0d7ab9f6b` does. ``` $ RUBY_IMAGE=rubylang/ruby:master-1035a3b202ee86bf2b0a1d00eefcfff0d7ab9f6b-bionic docker-compose -f .buildkite/docker-compose.yml build base && CI=1 docker-compose -f .buildkite/docker-compose.yml run default runner activejob 'AJ_ADAPTER=sidekiq AJ_INTEGRATION_TESTS=true bin/test test/integration/queuing_test.rb --seed 5170' ``` ``` +++ +++ activejob: AJ_ADAPTER=sidekiq AJ_INTEGRATION_TESTS=true bin/test test/integration/queuing_test.rb --seed 5170 Using sidekiq Run options: --seed 5170 # Running: .SSS....SS..... Finished in 13.647623s, 1.0991 runs/s, 1.0258 assertions/s. 15 runs, 14 assertions, 0 failures, 0 errors, 5 skips You have skipped tests. Run with --verbose for details. ``` ---Files-------------------------------- fix_bug17220.patch (7.32 KB) fix_bug17220_2.patch (7.53 KB) fix_bug17220_3.patch (7.11 KB) fix_bug17220_4.patch (6.64 KB) fix_bug17220_cond.patch (7.35 KB) -- https://bugs.ruby-lang.org/