Closed
Bug 1433621
Opened 6 years ago
Closed 6 years ago
Intermittent TEST-UNEXPECTED-ERROR | /fetch/security/redirect-to-url-with-credentials.https.html |
Categories
(Core :: DOM: Core & HTML, defect, P3)
Core
DOM: Core & HTML
Tracking
()
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure, Whiteboard: [stockwell unknown])
Filed by: philringnalda [at] gmail.com https://treeherder.mozilla.org/logviewer.html#?job_id=158825724&repo=mozilla-inbound https://queue.taskcluster.net/v1/task/DEhjA85fTK2LClfjU_UaTw/runs/0/artifacts/public/logs/live_backing.log
Comment hidden (Intermittent Failures Robot) |
Comment 2•6 years ago
|
||
This bug has failed 31 times in the last 7 days on Linux, Windows and OX.10 affecting debug and opt build types. Failing tests: debug-web-platform-tests-e10, opt-web-platform-tests-e10. Link to a recent log:https://treeherder.mozilla.org/logviewer.html#?repo=mozilla-central&job_id=160799180&lineNumber=13785 Part of that log: [task 2018-02-07T11:18:01.009Z] 11:18:01 INFO - PID 4915 | [Parent 4915, Main Thread] WARNING: NS_ENSURE_TRUE(aSecondURI) failed: file /builds/worker/workspace/build/src/dom/base/ThirdPartyUtil.cpp, line 98 [task 2018-02-07T11:18:01.095Z] 11:18:01 INFO - TEST-UNEXPECTED-ERROR | /fetch/security/redirect-to-url-with-credentials.https.html | [task 2018-02-07T11:18:01.096Z] 11:18:01 INFO - stacktrace: [task 2018-02-07T11:18:01.096Z] 11:18:01 INFO - WebDriverError@chrome://marionette/content/error.js:170:5 [task 2018-02-07T11:18:01.097Z] 11:18:01 INFO - UnexpectedAlertOpenError@chrome://marionette/content/error.js:454:5 [task 2018-02-07T11:18:01.099Z] 11:18:01 INFO - assert.that/<@chrome://marionette/content/assert.js:405:13 [task 2018-02-07T11:18:01.099Z] 11:18:01 INFO - assert.noUserPrompt@chrome://marionette/content/assert.js:178:3 [task 2018-02-07T11:18:01.099Z] 11:18:01 INFO - GeckoDriver.prototype._assertAndDismissModal@chrome://marionette/content/driver.js:3167:5 [task 2018-02-07T11:18:01.100Z] 11:18:01 INFO - GeckoDriver.prototype.close@chrome://marionette/content/driver.js:2700:3 [task 2018-02-07T11:18:01.100Z] 11:18:01 INFO - Async*despatch@chrome://marionette/content/server.js:557:20 [task 2018-02-07T11:18:01.100Z] 11:18:01 INFO - async*execute@chrome://marionette/content/server.js:531:11 [task 2018-02-07T11:18:01.101Z] 11:18:01 INFO - async*onPacket/<@chrome://marionette/content/server.js:506:15 [task 2018-02-07T11:18:01.101Z] 11:18:01 INFO - async*onPacket@chrome://marionette/content/server.js:505:8 :overholt could you please take a look?
Flags: needinfo?(overholt)
Whiteboard: [stockwell needswork]
Comment 4•6 years ago
|
||
Is this related to your current bugs?
Flags: needinfo?(mdaly) → needinfo?(amarchesini)
Comment 5•6 years ago
|
||
Not really. It seems related to a marionette error. :ato, do you have any idea why this happens? Can we have a better error message?
Flags: needinfo?(amarchesini) → needinfo?(ato)
Comment 6•6 years ago
|
||
This isn’t a Marionette error as such, but the stacktrace can
give can impression. This is telling us that a modal dialogue
(such as a window.alert user prompt or a global dialogue) prevented
the harness from closing the window.
The above paste doesn’t include the full stacktrace:
> stacktrace:
> WebDriverError@chrome://marionette/content/error.js:170:5
> UnexpectedAlertOpenError@chrome://marionette/content/error.js:454:5
> assert.that/<@chrome://marionette/content/assert.js:405:13
> assert.noUserPrompt@chrome://marionette/content/assert.js:178:3
> GeckoDriver.prototype._assertAndDismissModal@chrome://marionette/content/driver.js:3167:5
> GeckoDriver.prototype.close@chrome://marionette/content/driver.js:2700:3
> Async*despatch@chrome://marionette/content/server.js:557:20
> async*execute@chrome://marionette/content/server.js:531:11
> async*onPacket/<@chrome://marionette/content/server.js:506:15
> async*onPacket@chrome://marionette/content/server.js:505:8
> _onJSONObjectReady/<@chrome://marionette/content/transport.js:500:9
> openModalWindow@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:353:5
> openPrompt@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:563:9
> confirmEx@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:704:9
> openModalWindow@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:353:5
> openPrompt@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:563:9
> confirmEx@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:704:9
An educated guess would be that the test is causing a browser with
multiple tabs open to shut down (confirmEx), which causes the
“Are you really sure you want to exit?” dialogue to appear.
The WPT harness then tries to clean up the open windows before the
next test runs, and fails doing that. Can we confirm somehow that
this is the dialogue that is being opened? (I haven’t looked at
the actual test yet.)
Flags: needinfo?(ato)
Comment 7•6 years ago
|
||
Hold on, the GeckoDriver#_assertAndDismissModal is supposed to close any such dialogue before the window/tab is closed. The call to assert.noUserPrompt is wrapped in a try…catch, which means there is something wrong with the error that is being passed to UnexpectedAlertOpenError. It inherits from WebDriverError, and that passes the first error argument to super [1]. [1] https://searchfox.org/mozilla-central/rev/a539f8f7fe288d0b4d8d6a32510be20f52bb7a0f/testing/marionette/error.js#170
Comment 8•6 years ago
|
||
I’m running a try run with some more debug output to tell what’s wrong with super(x): https://treeherder.mozilla.org/#/jobs?repo=try&revision=3f0c0cb422286f2b5dad93d7a89bec6c055a8ca0
Comment hidden (Intermittent Failures Robot) |
Comment 10•6 years ago
|
||
Over the last 7 days there are 31 failures present on this bug. These happen on Linux, Linux x64, linux32-stylo-disabled, linux64-ccov, windows10-64-ccov Here is the most recent log example: https://treeherder.mozilla.org/logviewer.html#?repo=autoland&job_id=162879348&lineNumber=11694 Here is a relevant part of that log: [task 2018-02-18T11:36:55.210Z] 11:36:55 INFO - TEST-UNEXPECTED-ERROR | /fetch/security/redirect-to-url-with-credentials.https.html | [task 2018-02-18T11:36:55.211Z] 11:36:55 INFO - stacktrace: [task 2018-02-18T11:36:55.211Z] 11:36:55 INFO - WebDriverError@chrome://marionette/content/error.js:170:5 [task 2018-02-18T11:36:55.212Z] 11:36:55 INFO - UnexpectedAlertOpenError@chrome://marionette/content/error.js:454:5 [task 2018-02-18T11:36:55.212Z] 11:36:55 INFO - assert.that/<@chrome://marionette/content/assert.js:405:13 [task 2018-02-18T11:36:55.213Z] 11:36:55 INFO - assert.noUserPrompt@chrome://marionette/content/assert.js:178:3 [task 2018-02-18T11:36:55.213Z] 11:36:55 INFO - GeckoDriver.prototype._assertAndDismissModal@chrome://marionette/content/driver.js:3171:5 [task 2018-02-18T11:36:55.214Z] 11:36:55 INFO - GeckoDriver.prototype.close@chrome://marionette/content/driver.js:2704:3 [task 2018-02-18T11:36:55.215Z] 11:36:55 INFO - Async*despatch@chrome://marionette/content/server.js:551:20 [task 2018-02-18T11:36:55.215Z] 11:36:55 INFO - async*execute@chrome://marionette/content/server.js:525:11 [task 2018-02-18T11:36:55.216Z] 11:36:55 INFO - async*onPacket/<@chrome://marionette/content/server.js:500:15 [task 2018-02-18T11:36:55.217Z] 11:36:55 INFO - async*onPacket@chrome://marionette/content/server.js:499:8 [task 2018-02-18T11:36:55.218Z] 11:36:55 INFO - _onJSONObjectReady/<@chrome://marionette/content/transport.js:500:9 [task 2018-02-18T11:36:55.218Z] 11:36:55 INFO - openModalWindow@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:353:5 [task 2018-02-18T11:36:55.219Z] 11:36:55 INFO - openPrompt@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:563:9 [task 2018-02-18T11:36:55.219Z] 11:36:55 INFO - confirmEx@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:704:9 [task 2018-02-18T11:36:55.220Z] 11:36:55 INFO - openModalWindow@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:353:5 [task 2018-02-18T11:36:55.220Z] 11:36:55 INFO - openPrompt@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:563:9 [task 2018-02-18T11:36:55.221Z] 11:36:55 INFO - confirmEx@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:704:9 [task 2018-02-18T11:36:55.221Z] 11:36:55 INFO - TEST-INFO took 781ms
Flags: needinfo?(overholt)
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment 13•6 years ago
|
||
I think Andreas was working on this so I'll redirect to him.
Flags: needinfo?(overholt) → needinfo?(ato)
Comment hidden (Intermittent Failures Robot) |
Comment 15•6 years ago
|
||
Just acknowledging I’ve seen this. I’m going to look at this after I finish https://bugzilla.mozilla.org/show_bug.cgi?id=marionette-window-tracking.
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment 23•6 years ago
|
||
Since 11th April there already are 36 failures. Recent failure log: https://treeherder.mozilla.org/logviewer.html#?repo=mozilla-inbound&job_id=174258873&lineNumber=3554 :ato do you have any updates here? :overholt could you please take a look?
Flags: needinfo?(overholt)
Comment 24•6 years ago
|
||
I believe Andreas is still investigating (at least it still looks like a Marionette issue).
Flags: needinfo?(overholt)
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment 27•6 years ago
|
||
There are 39 failures in the past week. Platforms: Linux opt, Linux x64 opt/pgo and debug, linux32-nightly opt, linux32-nightly opt, linux64-qr opt, windows10-64 pgo, windows10-64-ccov debug. Recent log failure: https://treeherder.mozilla.org/logviewer.html#?repo=mozilla-inbound&job_id=175320371&lineNumber=3543 Relevant part of the log: [task 2018-04-24T11:56:43.963Z] 11:56:43 INFO - TEST-UNEXPECTED-ERROR | /fetch/security/redirect-to-url-with-credentials.https.html | [task 2018-04-24T11:56:43.964Z] 11:56:43 INFO - stacktrace: [task 2018-04-24T11:56:43.964Z] 11:56:43 INFO - WebDriverError@chrome://marionette/content/error.js:178:5 [task 2018-04-24T11:56:43.965Z] 11:56:43 INFO - UnexpectedAlertOpenError@chrome://marionette/content/error.js:461:5 [task 2018-04-24T11:56:43.965Z] 11:56:43 INFO - assert.that/<@chrome://marionette/content/assert.js:405:13 [task 2018-04-24T11:56:43.965Z] 11:56:43 INFO - assert.noUserPrompt@chrome://marionette/content/assert.js:178:3 [task 2018-04-24T11:56:43.966Z] 11:56:43 INFO - GeckoDriver.prototype._assertAndDismissModal@chrome://marionette/content/driver.js:3189:5 [task 2018-04-24T11:56:43.966Z] 11:56:43 INFO - GeckoDriver.prototype.close@chrome://marionette/content/driver.js:2722:3 [task 2018-04-24T11:56:43.966Z] 11:56:43 INFO - Async*despatch@chrome://marionette/content/server.js:297:20 [task 2018-04-24T11:56:43.966Z] 11:56:43 INFO - async*execute@chrome://marionette/content/server.js:271:11 [task 2018-04-24T11:56:43.967Z] 11:56:43 INFO - async*onPacket/<@chrome://marionette/content/server.js:246:15 [task 2018-04-24T11:56:43.967Z] 11:56:43 INFO - async*onPacket@chrome://marionette/content/server.js:245:8 [task 2018-04-24T11:56:43.967Z] 11:56:43 INFO - _onJSONObjectReady/<@chrome://marionette/content/transport.js:500:9 [task 2018-04-24T11:56:43.968Z] 11:56:43 INFO - openModalWindow@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:353:5 [task 2018-04-24T11:56:43.968Z] 11:56:43 INFO - openPrompt@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:561:9 [task 2018-04-24T11:56:43.968Z] 11:56:43 INFO - confirmEx@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:702:9 [task 2018-04-24T11:56:43.969Z] 11:56:43 INFO - openModalWindow@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:353:5 [task 2018-04-24T11:56:43.969Z] 11:56:43 INFO - openPrompt@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:561:9 [task 2018-04-24T11:56:43.970Z] 11:56:43 INFO - confirmEx@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:702:9 :ato any updates here?
Comment hidden (Intermittent Failures Robot) |
Updated•6 years ago
|
Priority: -- → P3
Comment 29•6 years ago
|
||
It is sadly unlikely at this point that I will get around to this in reasonable time.
Flags: needinfo?(ato)
Comment 30•6 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → INCOMPLETE
Comment hidden (Intermittent Failures Robot) |
Assignee | ||
Updated•5 years ago
|
Component: DOM → DOM: Core & HTML
You need to log in
before you can comment on or make changes to this bug.
Description
•