We're getting random fails in update tests - often starting with something like

fail: [Browser] Line 248 of core/modules/system/src/Tests/Update/UpdatePathTestBase.php:
GET http://localhost/checkout/update.php/start?id=2&op=do_nojs returned 0 (0 bytes).

And then a load of schema checking fails.

See fails on June 15th in https://www.drupal.org/pift-ci-job/328113 and https://www.drupal.org/pift-ci-job/328465

CommentFileSizeAuthor
#118 2762549-apcu-118.patch677 bytesalexpott
#117 2762549-apcu-117.patch1.06 KBalexpott
#116 2749955.116.patch815 bytesalexpott
#113 2749955-bbfb417.patch3.77 MBalexpott
#113 2749955-bbfb417.patch3.77 MBalexpott
#110 2749955-9764ec4.patch3.77 MBalexpott
#109 2749955-4a95e65-3-hunch.patch2.88 MBalexpott
#108 2749955-4a95e65-3.patch2.87 MBalexpott
#107 2749955-4e7f9f0.patch3.77 MBalexpott
#106 2749955-e5110db.patch3.8 MBalexpott
#105 2749955-15b999d.patch3.83 MBalexpott
#103 2749955-bd634aa.patch3.69 MBalexpott
#102 2749955-78bb26d.patch3.71 MBalexpott
#102 2749955-b8a61f2.patch3.78 MBalexpott
#99 2749955-d1ae9b7.patch3.76 MBalexpott
#97 2749955-78bb26d.patch3.71 MBalexpott
#96 2749955-b8a61f2.patch3.78 MBalexpott
#95 2749955-9548184.patch3.96 MBalexpott
#93 2749955-9548184.patch3.93 MBalexpott
#91 2749955-4a95e65-2.patch2.84 MBalexpott
#84 2749955-back-again-84.patch3.69 KBalexpott
#83 2749955-back-again-83.patch597 bytesalexpott
#77 i-hope-not-2.patch1.31 KBalexpott
#77 2749955-views.patch589 bytesalexpott
#69 2749955-revert-4a95e65-69.patch1.12 KBalexpott
#68 2749955-revert-4a95e65-68.patch3.67 KBalexpott
#65 2749955-53704b7.patch2.81 MBalexpott
#64 2749955-4a95e65.patch2.8 MBalexpott
#63 2749955-5356c84.patch2.81 MBalexpott
#62 2749955-978b026.patch2.85 MBalexpott
#60 2749955-5694189.patch2.87 MBalexpott
#58 2749955-9198758.patch2.78 MBalexpott
#57 2749955-46efe01.patch3.05 MBalexpott
#56 2749955-3e04617.patch3.43 MBalexpott
#54 2749955-d276bb4.patch4.32 MBalexpott
#53 2749955-6958e21.patch22.91 MBalexpott
#51 2749955.8-2-head.patch569 bytesalexpott
#46 i-hope-not.patch1.32 KBalexpott
#45 2749955-revert-ab53171-45.patch1.65 KBalexpott
#41 2749955-revert-ab53171-42.patch1.52 KBalexpott
2749955-revert-ab53171-41.patch3.71 KBalexpott
#39 2749955-ab53171.patch2.86 MBalexpott
#39 test.patch.txt541 bytesalexpott
#38 2749955-ab53171.patch2.86 MBclaudiu.cristea
#36 2749955-16d3fe4.patch2.86 MBalexpott
#35 2749955-01e7deb.patch2.86 MBalexpott
#33 2749955-b101f90.patch2.86 MBalexpott
#31 2749955-2bf9423.patch2.84 MBalexpott
#30 2749955-619cbc3.patch2.87 MBalexpott
#28 2749955-0dc32d7.patch2.76 MBalexpott
#27 2749955-698ff30.patch2.96 MBalexpott
#26 2749955-aed9375.patch3.3 MBalexpott
#25 2749955-f7e125c.patch4.9 MBalexpott
#23 2749955-f7e125c-23.patch6.47 MBalexpott
#21 2749955-21.patch898 bytesalexpott
#16 2749955-16.patch673 bytesalexpott
#15 2749955-15.patch597 bytesalexpott
#2 2749955.test-only.patch484 bytesalexpott

Comments

alexpott created an issue. See original summary.

alexpott’s picture

StatusFileSize
new484 bytes

Let's get a few test runs in a see how often it is occurring - interestingly seems to only be 8.1.x so far (and not 8.2.x)

alexpott’s picture

Status: Needs work » Needs review

Status: Needs review » Needs work

The last submitted patch, 2: 2749955.test-only.patch, failed testing.

alexpott’s picture

mikeryan’s picture

xjm’s picture

Issue tags: +Triaged D8 critical

Discussed with @catch, @alexpott, @effulgentsia, and @Cottser. This is critical per https://www.drupal.org/core/issue-priority#critical-bug:

Cause tests to fail in HEAD on the automated testing platform for any supported environment (including random failures), since this blocks all other work.

peacog’s picture

alexpott’s picture

Assigned: alexpott » Unassigned
toomanypets’s picture

chx’s picture

Edit: deleted.

claudiu.cristea’s picture

claudiu.cristea’s picture

claudiu.cristea’s picture

@alexpott, see https://www.drupal.org/node/2767269#comment-11408801. The same patch but one for 8.1.x and the other 8.2.x. Only 8.1.x is failing.

alexpott’s picture

Status: Needs work » Needs review
StatusFileSize
new597 bytes

Can we make it fail for sure...

alexpott’s picture

StatusFileSize
new673 bytes

Let's include more of the failing tests.

Status: Needs review » Needs work

The last submitted patch, 16: 2749955-16.patch, failed testing.

alexpott’s picture

Issue summary: View changes

So we have more info and we can cause the fails!

  • Drupal\system\Tests\Update\UpdatePathTestBaseFilledTest fails on 8.2.x
  • Drupal\field\Tests\Update\FieldUpdateTest fails on 8.1.x

The last submitted patch, 15: 2749955-15.patch, failed testing.

The last submitted patch, 16: 2749955-16.patch, failed testing.

alexpott’s picture

Status: Needs work » Needs review
StatusFileSize
new898 bytes

So concentrating on 8.1.x

Status: Needs review » Needs work

The last submitted patch, 21: 2749955-21.patch, failed testing.

alexpott’s picture

Status: Needs work » Needs review
StatusFileSize
new6.47 MB

Let's try bisecting...

Status: Needs review » Needs work

The last submitted patch, 23: 2749955-f7e125c-23.patch, failed testing.

alexpott’s picture

Status: Needs work » Needs review
StatusFileSize
new4.9 MB
alexpott’s picture

StatusFileSize
new3.3 MB
alexpott’s picture

StatusFileSize
new2.96 MB
alexpott’s picture

StatusFileSize
new2.76 MB

Status: Needs review » Needs work

The last submitted patch, 28: 2749955-0dc32d7.patch, failed testing.

alexpott’s picture

Status: Needs work » Needs review
StatusFileSize
new2.87 MB
alexpott’s picture

StatusFileSize
new2.84 MB

Status: Needs review » Needs work

The last submitted patch, 31: 2749955-2bf9423.patch, failed testing.

alexpott’s picture

Status: Needs work » Needs review
StatusFileSize
new2.86 MB

Status: Needs review » Needs work

The last submitted patch, 33: 2749955-b101f90.patch, failed testing.

alexpott’s picture

Status: Needs work » Needs review
StatusFileSize
new2.86 MB
alexpott’s picture

StatusFileSize
new2.86 MB

Opps this was 5c01c88

Status: Needs review » Needs work

The last submitted patch, 36: 2749955-16d3fe4.patch, failed testing.

claudiu.cristea’s picture

Status: Needs work » Needs review
StatusFileSize
new2.86 MB
alexpott’s picture

StatusFileSize
new541 bytes
new2.86 MB

@claudiu.cristea you need to apply this patch to the hash so it runs the test a few times.

Status: Needs review » Needs work

The last submitted patch, 39: 2749955-ab53171.patch, failed testing.

alexpott’s picture

StatusFileSize
new1.52 KB

The last submitted patch, 2749955-revert-ab53171-41.patch, failed testing.

The last submitted patch, 35: 2749955-01e7deb.patch, failed testing.

The last submitted patch, 30: 2749955-619cbc3.patch, failed testing.

alexpott’s picture

alexpott’s picture

StatusFileSize
new1.32 KB

The last submitted patch, 45: 2749955-revert-ab53171-45.patch, failed testing.

Status: Needs review » Needs work

The last submitted patch, 46: i-hope-not.patch, failed testing.

alexpott’s picture

Ok so the issue with 8.1.x is the same as #2762549: Drupal\field\Tests\Update\FieldUpdateTest, Drupal\views\Tests\Update\EntityViewsDataUpdateTest and Drupal\comment\Tests\CommentFieldsTest fail on 8.1.x - even if we committed a revert it is still going to fail :( now to bisect the 8.2.x fail.

alexpott’s picture

Version: 8.1.x-dev » 8.2.x-dev
alexpott’s picture

Status: Needs work » Needs review
StatusFileSize
new569 bytes

Status: Needs review » Needs work

The last submitted patch, 51: 2749955.8-2-head.patch, failed testing.

alexpott’s picture

Status: Needs work » Needs review
StatusFileSize
new22.91 MB
alexpott’s picture

StatusFileSize
new4.32 MB

Assuming when we opened 8.2.x is good.... here's the test commit to test.

The last submitted patch, 53: 2749955-6958e21.patch, failed testing.

alexpott’s picture

StatusFileSize
new3.43 MB
alexpott’s picture

StatusFileSize
new3.05 MB
alexpott’s picture

StatusFileSize
new2.78 MB

Status: Needs review » Needs work

The last submitted patch, 58: 2749955-9198758.patch, failed testing.

alexpott’s picture

Status: Needs work » Needs review
StatusFileSize
new2.87 MB
alexpott’s picture

Issue summary: View changes
alexpott’s picture

StatusFileSize
new2.85 MB
alexpott’s picture

StatusFileSize
new2.81 MB
alexpott’s picture

StatusFileSize
new2.8 MB
alexpott’s picture

StatusFileSize
new2.81 MB

The last submitted patch, 64: 2749955-4a95e65.patch, failed testing.

alexpott’s picture

4a95e65086a40187989144a9630b12ab3bb71c62 is the first bad commit
commit 4a95e65086a40187989144a9630b12ab3bb71c62
Author: Nathaniel Catchpole
Date: Tue Jul 19 13:37:02 2016 +0100

Issue #2761403 by Berdir: Move runtime theme registry into bootstrap cache

:040000 040000 c290a369260a1764712a18e8fb79d605715a1f33 8934e4a61a161ee7326227289773cf914b9a14af M core

alexpott’s picture

StatusFileSize
new3.67 KB

Let's revert it

alexpott’s picture

StatusFileSize
new1.12 KB

Let's makde sure that changing the file doesn't fix....

Status: Needs review » Needs work

The last submitted patch, 69: 2749955-revert-4a95e65-69.patch, failed testing.

alexpott’s picture

So the issue that introduced the 8.2.x fail looks like it is #2761403: Move runtime theme registry into bootstrap cache

The last submitted patch, 63: 2749955-5356c84.patch, failed testing.

berdir’s picture

Weird. Feel free to revert that, it's not that important.

catch’s picture

Reverted the cache_bootstrap issue for now.

alexpott’s picture

Status: Needs work » Fixed

I fixed the issue summary of #2762549: Drupal\field\Tests\Update\FieldUpdateTest, Drupal\views\Tests\Update\EntityViewsDataUpdateTest and Drupal\comment\Tests\CommentFieldsTest fail on 8.1.x to include the Drupal\field\Tests\Update\FieldUpdateTest test as #46 is conclusive evidence this is the same bug.

Now that #2761403: Move runtime theme registry into bootstrap cache has been reverted I think we can mark this issue as fixed.

alexpott’s picture

Status: Fixed » Needs work

Ah looking in all my old fail emails we should also look at Drupal\views\Tests\Update\EntityViewsDataUpdateTest - seems to fail on PHP 5.5 / 8.1.x only so might be the same as #2762549: Drupal\field\Tests\Update\FieldUpdateTest, Drupal\views\Tests\Update\EntityViewsDataUpdateTest and Drupal\comment\Tests\CommentFieldsTest fail on 8.1.x

alexpott’s picture

Version: 8.2.x-dev » 8.1.x-dev
Status: Needs work » Needs review
StatusFileSize
new589 bytes
new1.31 KB

The last submitted patch, 77: 2749955-views.patch, failed testing.

alexpott’s picture

Issue summary: View changes
Status: Needs review » Fixed

Okay as suspected Drupal\views\Tests\Update\EntityViewsDataUpdateTest is also #2762549: Drupal\field\Tests\Update\FieldUpdateTest, Drupal\views\Tests\Update\EntityViewsDataUpdateTest and Drupal\comment\Tests\CommentFieldsTest fail on 8.1.x

So marking this issue as fixed again.

Mixologic’s picture

Mixologic’s picture

Added the related issue : TLDR: we worked on this back in jan-mar, and found it to be php-errors.

alexpott’s picture

Status: Fixed » Needs work

Hmm so the revert didn't fix it... :( https://www.drupal.org/pift-ci-job/388205

Maybe we've found the 8.2.x equivalent of core/lib/Drupal/Core/Config/Entity/ConfigDependencyManager.php - a file that any change results in a pass... but I tested that in #69 :(

What is going on... #68 was passing all the time.

alexpott’s picture

Version: 8.1.x-dev » 8.2.x-dev
Status: Needs work » Needs review
StatusFileSize
new597 bytes

Testing again...

alexpott’s picture

StatusFileSize
new3.69 KB

Reverting the revert...

Status: Needs review » Needs work

The last submitted patch, 84: 2749955-back-again-84.patch, failed testing.

The last submitted patch, 83: 2749955-back-again-83.patch, failed testing.

The last submitted patch, 84: 2749955-back-again-84.patch, failed testing.

The last submitted patch, 84: 2749955-back-again-84.patch, failed testing.

The last submitted patch, 83: 2749955-back-again-83.patch, failed testing.

alexpott’s picture

So did I get the wrong commit :( both 83 and 84 have now failed... I did the bisect with 30 - but maybe that is not enough - since it is possible to be green with 50... see #83

alexpott’s picture

Status: Needs work » Needs review
StatusFileSize
new2.84 MB

Status: Needs review » Needs work

The last submitted patch, 91: 2749955-4a95e65-2.patch, failed testing.

alexpott’s picture

Status: Needs work » Needs review
StatusFileSize
new3.93 MB

Status: Needs review » Needs work

The last submitted patch, 93: 2749955-9548184.patch, failed testing.

alexpott’s picture

Status: Needs work » Needs review
StatusFileSize
new3.96 MB
alexpott’s picture

StatusFileSize
new3.78 MB
alexpott’s picture

StatusFileSize
new3.71 MB

Status: Needs review » Needs work

The last submitted patch, 97: 2749955-78bb26d.patch, failed testing.

alexpott’s picture

Status: Needs work » Needs review
StatusFileSize
new3.76 MB

This actually failed on second re-test :(

The last submitted patch, 96: 2749955-b8a61f2.patch, failed testing.

The last submitted patch, 95: 2749955-9548184.patch, failed testing.

alexpott’s picture

StatusFileSize
new3.78 MB
new3.71 MB
alexpott’s picture

StatusFileSize
new3.69 MB

The last submitted patch, 99: 2749955-d1ae9b7.patch, failed testing.

alexpott’s picture

StatusFileSize
new3.83 MB
alexpott’s picture

StatusFileSize
new3.8 MB
alexpott’s picture

StatusFileSize
new3.77 MB
alexpott’s picture

StatusFileSize
new2.87 MB

Let's see if 4a95e65 still fails...

alexpott’s picture

StatusFileSize
new2.88 MB

Assuming 4a95e65 is still failing - trying out a hunch.

-    $settings['settings']['apcu_ensure_unique_prefix'] = (object) [
-      'value' => FALSE,
-      'required' => TRUE,
-    ];
+    // A hunch
+//    $settings['settings']['apcu_ensure_unique_prefix'] = (object) [
+//      'value' => FALSE,
+//      'required' => TRUE,
+//    ];
alexpott’s picture

StatusFileSize
new3.77 MB

Continuing with the bisect

The last submitted patch, 108: 2749955-4a95e65-3.patch, failed testing.

The last submitted patch, 108: 2749955-4a95e65-3.patch, failed testing.

alexpott’s picture

StatusFileSize
new3.77 MB
new3.77 MB

I don't believe this bisect... :(

The last submitted patch, 108: 2749955-4a95e65-3.patch, failed testing.

alexpott’s picture

So according to the bisect...

d1ae9b77ad02e0771206084da1fe6205405a489d is the first bad commit
commit d1ae9b77ad02e0771206084da1fe6205405a489d
Author: Nathaniel Catchpole <catch@35733.no-reply.drupal.org>
Date:   Tue Jun 14 16:23:38 2016 +0100

    Issue #2651102 by mikeker, amateescu, gaurav.pahuja, Sagar Ramgade, dawehner, akalata, catch: Using checkboxes for exposed filters results in zero rows displaying

:040000 040000 8a28e54069fc7fd22b2525932d0c99f0db2898e4 3affb5a6b2a1858aed1a0950a26d079cd6e42f88 M	core

But I'm not sure if this means anything...

alexpott’s picture

StatusFileSize
new815 bytes

Let's see what happens to test run times with unique APCu prefixes.

alexpott’s picture

StatusFileSize
new1.06 KB

Let's see if just adding a comment to webtestbase fixes things (for whatever reason)

alexpott’s picture

StatusFileSize
new677 bytes

Here's a proper patch to remove non-unique APCu prefixes just in case we decide to try this as a solution.

Status: Needs review » Needs work

The last submitted patch, 118: 2762549-apcu-118.patch, failed testing.

  • catch committed f428ef6 on 8.2.x
    Issue #2749955 by alexpott, claudiu.cristea: Random fails in...

  • catch committed 44aa63b on 8.1.x
    Issue #2749955 by alexpott, claudiu.cristea: Random fails in...
catch’s picture

Summarizing discussion in irc - I've committed #118 to 8.1.x and 8.2.x as an interim step.

Ensuring a unique APCu prefix helps a lot, but https://www.drupal.org/pift-ci-job/390169 is a fail on PHP7, which on DrupalCI does not have APCu enabled.

So this can't just be an APCu bug, but it could potentially be a PHP bug which is exacerbated by an APCu bug.

Also Mixologic confirmed in irc that all PHP versions have 4.0.7 APCu.

  • catch committed f428ef6 on 8.3.x
    Issue #2749955 by alexpott, claudiu.cristea: Random fails in...

  • catch committed f428ef6 on 8.3.x
    Issue #2749955 by alexpott, claudiu.cristea: Random fails in...

Version: 8.2.x-dev » 8.3.x-dev

Drupal 8.2.0-beta1 was released on August 3, 2016, which means new developments and disruptive changes should now be targeted against the 8.3.x-dev branch. For more information see the Drupal 8 minor version schedule and the Allowed changes during the Drupal 8 release cycle.

alexpott’s picture

Status: Needs work » Reviewed & tested by the community

In my mind this is fixed - looking at node/3060/qa these have gone away since the commit.

alexpott’s picture

Status: Reviewed & tested by the community » Fixed

Status: Fixed » Closed (fixed)

Automatically closed - issue fixed for 2 weeks with no activity.

penyaskito’s picture

Sorry for updating a closed issue, but this is still happening on d.o for me very consistently.
The error usually is
file_put_contents(/var/www/html/sites/simpletest/.htaccess): failed to open stream: Permission denied

Examples:
https://www.drupal.org/pift-ci-job/724766
https://www.drupal.org/pift-ci-job/709153
https://www.drupal.org/pift-ci-job/703693

Does it happen for any other contrib modules out there?