Open Bug 1451142 Opened 6 years ago Updated 2 years ago

Intermittent TEST-UNEXPECTED-FAIL | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html | opt_in_method: no-opt-in

Categories

(Core :: DOM: Security, defect, P5)

defect

Tracking

()

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure, leave-open, Whiteboard: [retriggered][domsecurity-intermittent][stockwell disabled])

Attachments

(1 file, 3 obsolete files)

Filed by: apavel [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=171681583&repo=autoland

https://queue.taskcluster.net/v1/task/DnOo7cb-TCqyOlxvLadZog/runs/0/artifacts/public/logs/live_backing.log

11:06:01     INFO - TEST-OK | /mixed-content/link-css-tag/http-csp/same-host-http/top-level/keep-scheme-redirect/blockable/opt-in-blocks.https.html | took 268ms
11:06:01     INFO - PID 1083 | JavaScript error: resource:///modules/AsyncTabSwitcher.jsm, line 258: TypeError: browser.frameLoader is null
11:06:01     INFO - PID 1083 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping
11:06:01     INFO - Browser exited with return code 0
11:06:01  WARNING - u'runner_teardown': ()
11:06:01     INFO - Setting up ssl
11:06:01     INFO - certutil | 
11:06:01     INFO - certutil | 
11:06:01     INFO - certutil | 
11:06:01     INFO - Certificate Nickname                                         Trust Attributes
11:06:01     INFO -                                                              SSL,S/MIME,JAR/XPI
11:06:01     INFO - 
11:06:01     INFO - web-platform-tests                                           CT,, 
11:06:01     INFO - 
11:06:01     INFO - Application command: /Users/cltbld/tasks/task_1522777135/build/application/Firefox Nightly.app/Contents/MacOS/firefox --marionette about:blank -foreground -profile /var/folders/yt/72c7_8l14lq3ngp5wfspdw1w00000w/T/tmpodjtzN.mozrunner
11:06:01     INFO - Starting runner
11:06:02     INFO - PID 1090 | Unable to read VR Path Registry from /Users/cltbld/Library/Application Support/OpenVR/.openvr/openvrpaths.vrpath
11:06:03     INFO - PID 1090 | Unable to read VR Path Registry from /Users/cltbld/Library/Application Support/OpenVR/.openvr/openvrpaths.vrpath
11:06:03     INFO - PID 1090 | 2018-04-03 11:06:03.324 plugin-container[1092:28638] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9553, name = 'com.apple.tsm.portname'
11:06:03     INFO - PID 1090 | See /usr/include/servers/bootstrap_defs.h for the error codes.
11:06:03     INFO - PID 1090 | 1522778763724	Marionette	INFO	Listening on port 2828
11:06:04     INFO - PID 1090 | Unable to read VR Path Registry from /Users/cltbld/Library/Application Support/OpenVR/.openvr/openvrpaths.vrpath
11:06:04     INFO - TEST-START | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html
11:06:04     INFO - PID 1090 | 2018-04-03 11:06:04.231 plugin-container[1093:28717] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x913b, name = 'com.apple.tsm.portname'
11:06:04     INFO - PID 1090 | See /usr/include/servers/bootstrap_defs.h for the error codes.
11:06:04     INFO - 
11:06:04     INFO - TEST-UNEXPECTED-FAIL | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html | opt_in_method: no-opt-in
11:06:04     INFO -                                  origin: same-host-https
11:06:04     INFO -                                  source_scheme: https
11:06:04     INFO -                                  context_nesting: top-level
11:06:04     INFO -                                  redirection: keep-scheme-redirect
11:06:04     INFO -                                  subresource: link-prefetch-tag
11:06:04     INFO -                                  expectation: allowed - assert_equals: The resource request should be 'allowed'. expected "allowed" but got "blocked"
11:06:04     INFO - runTest/<@https://web-platform.test:8443/mixed-content/generic/mixed-content-test-case.js?pipe=sub:138:10
11:06:04     INFO - Test.prototype.step@https://web-platform.test:8443/resources/testharness.js:1494:20
11:06:04     INFO - Test.prototype.step_func_done/<@https://web-platform.test:8443/resources/testharness.js:1534:17
11:06:04     INFO - promise callback*runTest@https://web-platform.test:8443/mixed-content/generic/mixed-content-test-case.js?pipe=sub:121:5
11:06:04     INFO - Test.prototype.step@https://web-platform.test:8443/resources/testharness.js:1494:20
11:06:04     INFO - Test.prototype.step_func/<@https://web-platform.test:8443/resources/testharness.js:1518:20
11:06:04     INFO - @https://web-platform.test:8443/mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html:24:7
11:06:04     INFO - TEST-OK | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html | took 545ms
11:06:04     INFO - PID 1090 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping
11:06:05     INFO - Browser exited with return code 0
11:06:05  WARNING - u'runner_teardown': ()
11:06:05     INFO - Setting up ssl
11:06:05     INFO - certutil | 
11:06:05     INFO - certutil | 
11:06:05     INFO - certutil | 
11:06:05     INFO - Certificate Nickname                                         Trust Attributes
11:06:05     INFO -                                                              SSL,S/MIME,JAR/XPI
11:06:05     INFO - 
11:06:05     INFO - web-platform-tests                                           CT,, 
11:06:05     INFO - 
11:06:05     INFO - Application command: /Users/cltbld/tasks/task_1522777135/build/application/Firefox Nightly.app/Contents/MacOS/firefox --marionette about:blank -foreground -profile /var/folders/yt/72c7_8l14lq3ngp5wfspdw1w00000w/T/tmpfHmIKZ.mozrunner
11:06:05     INFO - Starting runner
11:06:05     INFO - PID 1097 | Unable to read VR Path Registry from /Users/cltbld/Library/Application Support/OpenVR/.openvr/openvrpaths.vrpath
11:06:06     INFO - PID 1097 | Unable to read VR Path Registry from /Users/cltbld/Library/Application Support/OpenVR/.openvr/openvrpaths.vrpath
11:06:06     INFO - PID 1097 | 2018-04-03 11:06:06.867 plugin-container[1099:28839] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9447, name = 'com.apple.tsm.portname'
11:06:06     INFO - PID 1097 | See /usr/include/servers/bootstrap_defs.h for the error codes.
11:06:07     INFO - PID 1097 | 1522778767151	Marionette	INFO	Listening on port 2828
Component: web-platform-tests → DOM: Security
Product: Testing → Core
Summary: Intermittent /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html | opt_in_method: no-opt-in → Intermittent TEST-UNEXPECTED-FAIL | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html | opt_in_method: no-opt-in
Version: Version 3 → Trunk
Tried to find the culprit for this bug but kinda got stuck. It seems that chunk of test runs very rarely and for my retriggers I didn't find it once so of course it would not fail again.

This is the range I ran the retriggers. And the selected one is the first fail of this kind.
https://treeherder.mozilla.org/#/jobs?repo=autoland&filter-searchStr=48cd8f422fc1ec771eaf4de7b5a3a5f3f9490598&tochange=e4a3e7fb39f72305ec8ca7a722a6a1e1df367231&fromchange=efe04571107d3d2b191fa6a292f9509233d913c7&selectedJob=171681583

Joel, could you help with what to do next? Thanks.
Flags: needinfo?(jmaher)
Whiteboard: [stockwell needswork][retriggered]
This investigation was poisoned from the beginning by me missclassifying these two fails https://goo.gl/phnA8j I'm really sorry about that. Didn't mean to do it and we could have started with earlier pushes. 

Went on with the retriggers and after seeing the merge push I moved back to inbound and went straight to this large push with wpts (https://hg.mozilla.org/integration/mozilla-inbound/pushloghtml?changeset=feb3750f2fac0a0b65a4144853389804582fe892) to do the retriggers. It failed over there. https://goo.gl/fzhxHQ This is similar to Bug 1450660 as where the failures started so maybe James could also take a look at this. 
It fails about 2 times from 20 jobs. Sorry about making you work for nothing at the beginning.
Flags: needinfo?(jmaher)
Flags: needinfo?(james)
Great work Cosmin, glad we got to the bottom of this.
Flags: needinfo?(jmaher)
Whiteboard: [stockwell needswork][retriggered] → [stockwell needswork][retriggered][domsecurity-intermittent]
In the last 7 days we have 67 failures.
They occur on linux64-qr (opt) and OS X 10.10 (opt).
Recent failure log: https://treeherder.mozilla.org/logviewer.html#?repo=mozilla-inbound&job_id=173207560&lineNumber=3935
and a relevant part of it:
[task 2018-04-12T05:43:23.226Z] 05:43:23     INFO - TEST-START | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html
[task 2018-04-12T05:43:23.820Z] 05:43:23     INFO - PID 8683 | JavaScript error: resource:///modules/ContentMetaHandler.jsm, line 155: NS_ERROR_ILLEGAL_VALUE:
[task 2018-04-12T05:43:23.846Z] 05:43:23     INFO - 
[task 2018-04-12T05:43:23.847Z] 05:43:23     INFO - TEST-UNEXPECTED-FAIL | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html | opt_in_method: no-opt-in
[task 2018-04-12T05:43:23.847Z] 05:43:23     INFO -                                  origin: same-host-https
[task 2018-04-12T05:43:23.848Z] 05:43:23     INFO -                                  source_scheme: https
[task 2018-04-12T05:43:23.848Z] 05:43:23     INFO -                                  context_nesting: top-level
[task 2018-04-12T05:43:23.849Z] 05:43:23     INFO -                                  redirection: keep-scheme-redirect
[task 2018-04-12T05:43:23.850Z] 05:43:23     INFO -                                  subresource: link-prefetch-tag
[task 2018-04-12T05:43:23.851Z] 05:43:23     INFO -                                  expectation: allowed - assert_equals: The resource request should be 'allowed'. expected "allowed" but got "blocked"
[task 2018-04-12T05:43:23.852Z] 05:43:23     INFO - runTest/<@https://web-platform.test:8443/mixed-content/generic/mixed-content-test-case.js?pipe=sub:138:10
[task 2018-04-12T05:43:23.852Z] 05:43:23     INFO - Test.prototype.step@https://web-platform.test:8443/resources/testharness.js:1494:20
[task 2018-04-12T05:43:23.853Z] 05:43:23     INFO - Test.prototype.step_func_done/<@https://web-platform.test:8443/resources/testharness.js:1534:17
[task 2018-04-12T05:43:23.854Z] 05:43:23     INFO - promise callback*runTest@https://web-platform.test:8443/mixed-content/generic/mixed-content-test-case.js?pipe=sub:121:5
[task 2018-04-12T05:43:23.855Z] 05:43:23     INFO - Test.prototype.step@https://web-platform.test:8443/resources/testharness.js:1494:20
[task 2018-04-12T05:43:23.856Z] 05:43:23     INFO - Test.prototype.step_func/<@https://web-platform.test:8443/resources/testharness.js:1518:20
[task 2018-04-12T05:43:23.856Z] 05:43:23     INFO - @https://web-platform.test:8443/mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html:24:7
:ckerschb, :jgraham can you please have a look at this?
Flags: needinfo?(ckerschb)
(In reply to Eliza Balazs [:ebalazs_] from comment #7)
> :ckerschb, :jgraham can you please have a look at this?

:jkt, any chance you could take a quick look?
Flags: needinfo?(ckerschb) → needinfo?(jkt)
We have 30 failures in the last 7 days.
For the failure pattern see Comment 7
Recent failure log: https://treeherder.mozilla.org/logviewer.html#?repo=autoland&job_id=175048865&lineNumber=4741
:jkt, can you please take a look into this?
Attachment #8971204 - Flags: review?(jmaher)
Comment on attachment 8971204 [details] [diff] [review]
disabled this test on Linux-qr opt

Review of attachment 8971204 [details] [diff] [review]:
-----------------------------------------------------------------

lets give this one more try, just a small detail

::: testing/web-platform/meta/mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html.ini
@@ +1,4 @@
>  [allowed.https.html]
>    disabled:
>      if os == "win": https://bugzilla.mozilla.org/show_bug.cgi?id=1183627
> +    if (os == "linux") and webrender and not debug| https://bugzilla.mozilla.org/show_bug.cgi?id=1451142

after debug you have a |, it should be a :
Attachment #8971204 - Flags: review?(jmaher) → review-
Attachment #8971204 - Attachment is obsolete: true
Attachment #8971269 - Flags: review?(jmaher)
Attachment #8971269 - Attachment is patch: true
Attachment #8971269 - Flags: review?(jmaher) → review+
Whiteboard: [retriggered][domsecurity-intermittent][stockwell disable-recommended] → [retriggered][domsecurity-intermittent][stockwell disabled]
Pushed by cbrindusan@mozilla.com:
https://hg.mozilla.org/integration/mozilla-inbound/rev/11a2d91d1843
disable allowed.https.html on linux-qr for frequent failures. r=jmaher
Keywords: checkin-needed
Over the last 7 days there are 44 failures on this bug. These happen on osx-10-10, windows10-64-msvc, windows10-64.

This is the most recent log example: https://treeherder.mozilla.org/logviewer.html#?job_id=196592234&repo=autoland&lineNumber=3442

07:28:49     INFO - Application command: Z:\task_1535612183\build\application\firefox\firefox.exe -marionette about:blank -profile c:\users\task_1535612183\appdata\local\temp\tmpq4kpod.mozrunner
07:28:49     INFO - Starting runner
07:28:51     INFO - PID 6544 | 1535614131449	Marionette	INFO	Listening on port 2828
07:28:51     INFO - TEST-START | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html
07:28:52     INFO - 
07:28:52     INFO - TEST-UNEXPECTED-FAIL | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html | opt_in_method: no-opt-in
07:28:52     INFO -                                  origin: same-host-https
07:28:52     INFO -                                  source_scheme: https
07:28:52     INFO -                                  context_nesting: top-level
07:28:52     INFO -                                  redirection: keep-scheme-redirect
07:28:52     INFO -                                  subresource: link-prefetch-tag
07:28:52     INFO -                                  expectation: allowed - assert_equals: The resource request should be 'allowed'. expected "allowed" but got "blocked"
07:28:52     INFO - runTest/<@https://web-platform.test:8443/mixed-content/generic/mixed-content-test-case.js?pipe=sub:140:10
07:28:52     INFO - Test.prototype.step@https://web-platform.test:8443/resources/testharness.js:1553:20
07:28:52     INFO - Test.prototype.step_func_done/<@https://web-platform.test:8443/resources/testharness.js:1593:17
07:28:52     INFO - TEST-OK | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html | took 640ms
07:28:52     INFO - PID 6544 | 1535614132552	Marionette	INFO	Stopped listening on port 2828
07:28:52     INFO - PID 6544 | JavaScript error: resource://activity-stream/lib/TopSitesFeed.jsm, line 86: TypeError: setting getter-only property "_currentSearchHostname"
07:28:52     INFO - PID 6544 | JavaScript error: resource://onboarding/onboarding.js, line 29: NS_ERROR_NOT_AVAILABLE:
07:28:52     INFO - PID 6544 | [Child 820, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
07:28:52     INFO - PID 6544 | [Parent 6544, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
07:28:52     INFO - PID 6544 | [Parent 6544, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
07:28:52     INFO - PID 6544 | [Child 3768, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
07:28:52     INFO - PID 6544 | [Parent 6544, Gecko_IOThread] WARNING: file z:/build/build/src/ipc/chromium/src/base/process_util_win.cc, line 188
07:28:53     INFO - Browser exited with return code 0
There are 176 failures in the last 7 days.
Most of them (141 failures) are on Windows10-64 

Recent log snippet:

10:21:29     INFO - TEST-START | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html
10:21:29     INFO - 
10:21:29     INFO - TEST-UNEXPECTED-FAIL | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html | opt_in_method: no-opt-in
10:21:29     INFO -                                  origin: same-host-https
10:21:29     INFO -                                  source_scheme: https
10:21:29     INFO -                                  context_nesting: top-level
10:21:29     INFO -                                  redirection: keep-scheme-redirect
10:21:29     INFO -                                  subresource: link-prefetch-tag
10:21:29     INFO -                                  expectation: allowed - assert_equals: The resource request should be 'allowed'. expected "allowed" but got "blocked"
10:21:29     INFO - runTest/<@https://web-platform.test:8443/mixed-content/generic/mixed-content-test-case.js?pipe=sub:140:10
10:21:29     INFO - Test.prototype.step@https://web-platform.test:8443/resources/testharness.js:1553:20
10:21:29     INFO - Test.prototype.step_func_done/<@https://web-platform.test:8443/resources/testharness.js:1593:17
10:21:29     INFO - TEST-OK | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html | took 661ms

This test has already been disabled on Linux-qr.
:ckerschb , can you please take a look?
Flags: needinfo?(ckerschb)
(In reply to Narcis Beleuzu [:NarcisB] from comment #42)
> This test has already been disabled on Linux-qr.
> :ckerschb , can you please take a look?

Vino, can you look into this test failure please?
Flags: needinfo?(ckerschb) → needinfo?(cegvinoth)
Update:

There were 182 failures within the last 7 days:
- 27 failures on OS X 10.10 opt
- 120 failures on windows 10 x64 opt/pgo
- 18 failures on windows 10 x64 msvc opt
- 5 failure on windows 10x64 nightly opt
- 7 failures on windows 7 x32 opt
- 5 failure on windows 7x32 msvc opt

Example log:
https://treeherder.mozilla.org/logviewer.html#?job_id=198065128&repo=mozilla-inbound&lineNumber=3603

4:31:51     INFO - TEST-START | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html
14:31:52     INFO - 
14:31:52     INFO - TEST-UNEXPECTED-FAIL | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html | opt_in_method: no-opt-in
14:31:52     INFO -                                  origin: same-host-https
14:31:52     INFO -                                  source_scheme: https
14:31:52     INFO -                                  context_nesting: top-level
14:31:52     INFO -                                  redirection: keep-scheme-redirect
14:31:52     INFO -                                  subresource: link-prefetch-tag
14:31:52     INFO -                                  expectation: allowed - assert_equals: The resource request should be 'allowed'. expected "allowed" but got "blocked"
14:31:52     INFO - runTest/<@https://web-platform.test:8443/mixed-content/generic/mixed-content-test-case.js?pipe=sub:140:10
14:31:52     INFO - Test.prototype.step@https://web-platform.test:8443/resources/testharness.js:1553:20
14:31:52     INFO - Test.prototype.step_func_done/<@https://web-platform.test:8443/resources/testharness.js:1593:17
14:31:52     INFO - TEST-OK | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html | took 684ms
This bug has failed 215 times in the last 7 days. This mostly fails on windows10-64 and windows7-32 and some failures on osx10-10.

Recent log:
https://treeherder.mozilla.org/logviewer.html#?job_id=200389614&repo=mozilla-central&lineNumber=3657

 INFO - TEST-START | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html
08:31:25     INFO - 
08:31:25     INFO - TEST-UNEXPECTED-FAIL | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html | opt_in_method: no-opt-in
08:31:25     INFO -                                  origin: same-host-https
08:31:25     INFO -                                  source_scheme: https
08:31:25     INFO -                                  context_nesting: top-level
08:31:25     INFO -                                  redirection: keep-scheme-redirect
08:31:25     INFO -                                  subresource: link-prefetch-tag
08:31:25     INFO -                                  expectation: allowed - assert_equals: The resource request should be 'allowed'. expected "allowed" but got "blocked"
08:31:25     INFO - runTest/<@https://web-platform.test:8443/mixed-content/generic/mixed-content-test-case.js?pipe=sub:164:10
08:31:25     INFO - Test.prototype.step@https://web-platform.test:8443/resources/testharness.js:1558:20
08:31:25     INFO - Test.prototype.step_func_done/<@https://web-platform.test:8443/resources/testharness.js:1598:17
08:31:25     INFO - TEST-OK | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html | took 640ms
08:31:25     INFO - PID 8448 | 1537432285674	Marionette	INFO	Stopped listening on port 2828
08:31:25     INFO - PID 8448 | JavaScript error: resource://activity-stream/lib/TopSitesFeed.jsm, line 86: TypeError: setting getter-only property "_currentSearchHostname"
08:31:25     INFO - PID 8448 | [Parent 8448, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
08:31:25     INFO - PID 8448 | [Child 2348, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
08:31:25     INFO - PID 8448 | [Child 2348, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
08:31:25     INFO - PID 8448 | [Parent 8448, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
08:31:25     INFO - PID 8448 | [Child 5008, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
08:31:25     INFO - PID 8448 | [Parent 8448, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
08:31:25     INFO - PID 8448 | [Child 8956, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
08:31:25     INFO - PID 8448 | [Child 8956, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
08:31:25     INFO - PID 8448 | [Parent 8448, Gecko_IOThread] WARNING: file z:/build/build/src/ipc/chromium/src/base/process_util_win.cc, line 188
08:31:26     INFO - Browser exited with return code 0
08:31:26  WARNING - u'runner_teardown': ()

ckerschb: Can you please take a look at this bug?
Flags: needinfo?(ckerschb)
(In reply to Dorel Luca [:dluca] from comment #60)
> 
> ckerschb: Can you please take a look at this bug?

:jkt, whenever you get a chance, can you take a look at that mixed-content intermittent?
(He is already ni? on it - i'll ping him)
Flags: needinfo?(ckerschb)
This bug has failed 169 times in the last 7 days. These occur mostly on windows10-64 and some other failures on osx-10-10. Build types are opt and pgo.

Recent log:
https://treeherder.mozilla.org/logviewer.html#?job_id=202110423&repo=autoland&lineNumber=3644

INFO - TEST-START | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html
02:52:02     INFO - 
02:52:02     INFO - TEST-UNEXPECTED-FAIL | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html | opt_in_method: no-opt-in
02:52:02     INFO -                                  origin: same-host-https
02:52:02     INFO -                                  source_scheme: https
02:52:02     INFO -                                  context_nesting: top-level
02:52:02     INFO -                                  redirection: keep-scheme-redirect
02:52:02     INFO -                                  subresource: link-prefetch-tag
02:52:02     INFO -                                  expectation: allowed - assert_equals: The resource request should be 'allowed'. expected "allowed" but got "blocked"
02:52:02     INFO - runTest/<@https://web-platform.test:8443/mixed-content/generic/mixed-content-test-case.js?pipe=sub:164:10
02:52:02     INFO - Test.prototype.step@https://web-platform.test:8443/resources/testharness.js:1561:20
02:52:02     INFO - Test.prototype.step_func_done/<@https://web-platform.test:8443/resources/testharness.js:1601:17
02:52:02     INFO - TEST-OK | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html | took 705ms
02:52:02     INFO - PID 6228 | 1538103122105	Marionette	INFO	Stopped listening on port 2828
02:52:02     INFO - PID 6228 | JavaScript error: resource://onboarding/onboarding.js, line 29: NS_ERROR_NOT_AVAILABLE:
02:52:02     INFO - PID 6228 | [Parent 3136, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
02:52:02     INFO - PID 6228 | [Child 5024, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
02:52:02     INFO - PID 6228 | [Child 5024, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
02:52:02     INFO - PID 6228 | [Parent 3136, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
02:52:02     INFO - PID 6228 | [Child 6876, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
02:52:02     INFO - PID 6228 | [Child 6876, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
02:52:02     INFO - PID 6228 | [Parent 3136, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
02:52:02     INFO - PID 6228 | [Child 6072, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
02:52:02     INFO - PID 6228 | [Child 6072, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
02:52:02     INFO - PID 6228 | [Parent 3136, Gecko_IOThread] WARNING: file z:/build/build/src/ipc/chromium/src/base/process_util_win.cc, line 188
02:52:02     INFO - Browser exited with return code 0
02:52:02  WARNING - u'runner_teardown': ()
02:52:02     INFO - Setting up ssl
02:52:02     INFO - certutil | 
02:52:02     INFO - certutil | 
02:52:02     INFO - certutil | 
02:52:02     INFO - Certificate Nickname                                         Trust Attributes
02:52:02     INFO -                                                              SSL,S/MIME,JAR/XPI
02:52:02     INFO - 
02:52:02     INFO - web-platform-tests                                           CT,, 
02:52:02     INFO - 
02:52:02     INFO - Application command: Z:\task_1538100018\build\application\firefox\firefox.exe -marionette about:blank --wait-for-browser -profile c:\users\task_1538100018\appdata\local\temp\tmpifzm6f.mozrunner
02:52:02     INFO - Starting runner
02:52:04     INFO - PID 3772 | 1538103124578	Marionette	INFO	Listening on port 2828
02:52:05     INFO - TEST-START | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/no-redirect/allowed/allowed.https.html
02:52:06     INFO - .
02:52:06     INFO - TEST-OK | /mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/no-redirect/allowed/allowed.https.html | took 671ms
02:52:06     INFO - TEST-START | /mixed-content/module-data-worker-import/http-csp/cross-origin-http/top-level/keep-scheme-redirect/blockable/opt-in-blocks.https.html
02:52:06     INFO - .
02:52:06     INFO - TEST-ERROR | /mixed-content/module-data-worker-import/http-csp/cross-origin-http/top-level/keep-scheme-redirect/blockable/opt-in-blocks.https.html | took 231ms
02:52:06     INFO - PID 3772 | 1538103126455	Marionette	INFO	Stopped listening on port 2828
02:52:06     INFO - PID 3772 | [Parent 7240, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
02:52:06     INFO - PID 3772 | [Child 7848, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
02:52:06     INFO - PID 3772 | JavaScript error: resource:///modules/AsyncTabSwitcher.jsm, line 256: TypeError: browser.frameLoader is null
02:52:06     INFO - PID 3772 | [Parent 7240, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
02:52:06     INFO - PID 3772 | [Child 8168, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
02:52:06     INFO - PID 3772 | [Child 8168, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
02:52:06     INFO - PID 3772 | [Parent 7240, Gecko_IOThread] WARNING: file z:/build/build/src/ipc/chromium/src/base/process_util_win.cc, line 188
02:52:07     INFO - Browser exited with return code 0
02:52:07  WARNING - u'runner_teardown': ()
02:52:07     INFO - Setting up ssl
02:52:07     INFO - certutil | 
02:52:07     INFO - certutil | 
02:52:07     INFO - certutil | 
02:52:07     INFO - Certificate Nickname                                         Trust Attributes
02:52:07     INFO -                                                              SSL,S/MIME,JAR/XPI
02:52:07     INFO - 
02:52:07     INFO - web-platform-tests                                           CT,, 
02:52:07     INFO - 
02:52:07     INFO - Application command: Z:\task_1538100018\build\application\firefox\firefox.exe -marionette about:blank --wait-for-browser -profile c:\users\task_1538100018\appdata\local\temp\tmpzhzgjc.mozrunner
02:52:07     INFO - Starting runner
02:52:08     INFO - PID 5200 | 1538103128820	Marionette	INFO	Listening on port 2828
02:52:09     INFO - TEST-START | /mixed-content/module-worker-top-level/http-csp/cross-origin-http/top-level/no-redirect/blockable/opt-in-blocks.https.html
02:52:09     INFO - .
02:52:09     INFO - TEST-OK | /mixed-content/module-worker-top-level/http-csp/cross-origin-http/top-level/no-redirect/blockable/opt-in-blocks.https.html | took 535ms

jkt: Can you please take a look at this bug?
In the last 7 days there have been 201 failures on Windows 7 32&64, and some on OSX 10, on OPT and some PGO.

This is a high frequency failure.
:bogdan_tara, please disable this bug, we have 3 needinfo's for >1 month and 200+ failures in a given week.
Flags: needinfo?(btara)
Attached patch 1451142_disableTest_on_Win_OSX (obsolete) — Splinter Review
Jmaher, did i get the syntax right?
Flags: needinfo?(btara)
Attachment #9014629 - Flags: review?(jmaher)
Comment on attachment 9014629 [details] [diff] [review]
1451142_disableTest_on_Win_OSX

Review of attachment 9014629 [details] [diff] [review]:
-----------------------------------------------------------------

::: testing/web-platform/meta/mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html.ini
@@ +2,5 @@
> +  disabled: https://bugzilla.mozilla.org/show_bug.cgi?id=1451142
> +    expected:
> +      if opt and (os == "mac"): FAIL
> +      if opt and (os == "win"): FAIL
> +      if pgo and (os == "win"): FAIL

we can ignore the expected clauses here, I don't think there are even opt/pgo clauses to choose from.  this new file should just have the first 2 lines
Attachment #9014629 - Flags: review?(jmaher) → review-
oddly this previous skip-if was backed out, but we have continued to have a high failure rate.  Whoever backed it out should have updated this bug, but I know there are a lot of bugs out there.  needinfo's from 1-6 months ago are not relevant.

:ebalazs, can you fix up the patch I r-'d ?
Flags: needinfo?(jkt)
Flags: needinfo?(james)
Flags: needinfo?(ebalazs)
Flags: needinfo?(cegvinoth)
QA Contact: ckerschb
Whiteboard: [retriggered][domsecurity-intermittent][stockwell disabled] → [retriggered][domsecurity-intermittent][stockwell disable-recommended]
Attachment #8971269 - Attachment is obsolete: true
joel: Hi, we searched for this file history and we found out that the lines added in the disable patch were removed 3 days after by baku in:

https://hg.mozilla.org/mozilla-central/diff/d87b294da56d/testing/web-platform/meta/mixed-content/link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html.ini

Moreover the folder link-prefetch-tag was entirely removed: https://hg.mozilla.org/mozilla-central/rev/d87b294da56d
Flags: needinfo?(ebalazs)
I think maybe Andrea can shed some light over here and why those files were removed. It caused for that test to be re-enabled while keeping the stockwell disabled and leave open tag which led to that large failure rate over time with nobody noticing it. 

https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?startday=2018-08-01&endday=2018-10-05&tree=all&bug=1451142
Flags: needinfo?(amarchesini)
yeah, I asked in bug 1486537 if we shouldn't add the leave-open keyword for wpt based tests.  That might be the best route to avoid this in the future.

As for now, we have windows/osx failures on "not debug" that we should disable the test for.  :cosmins, interested in writing that patch?
Flags: needinfo?(csabou)
In bug 1486537 I removed several .ini files because those tests were actually passing. If some of them are still intermittent, we should fix them. In the meantime I can provide a patch to disable this allowed.https.html test.
Flags: needinfo?(amarchesini)
Here it is! :)
Attachment #9014629 - Attachment is obsolete: true
Flags: needinfo?(csabou)
Attachment #9014738 - Flags: review?(jmaher)
Comment on attachment 9014738 [details] [diff] [review]
disable1451142.patch

Review of attachment 9014738 [details] [diff] [review]:
-----------------------------------------------------------------

thanks
Attachment #9014738 - Flags: review?(jmaher) → review+
Keywords: checkin-needed
Whiteboard: [retriggered][domsecurity-intermittent][stockwell disable-recommended] → [retriggered][domsecurity-intermittent][stockwell disabled]
Pushed by ebalazs@mozilla.com:
https://hg.mozilla.org/integration/mozilla-inbound/rev/be99865efc83
Disable link-prefetch-tag/no-opt-in/same-host-https/top-level/keep-scheme-redirect/allowed/allowed.https.html on all platrforms. r=jmaher
Keywords: checkin-needed
QA Contact: ckerschb
Severity: normal → S3
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: