1585829 - Perma fission [tier2] devtools/client/aboutdebugging/test/browser/browser_aboutdebugging_serviceworker_timeout.js | Test timed out -

Status: RESOLVED FIXED

(DevTools :: about:debugging, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: dvarga [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=269524415&repo=mozilla-central
Full log: https://queue.taskcluster.net/v1/task/TodrgFBWQhSlNictGUPK7A/runs/0/artifacts/public/logs/live_backing.log

---

[task 2019-10-02T22:17:07.041Z] 22:17:07     INFO - Longer timeout required, waiting longer...  Remaining timeouts: 1
[task 2019-10-02T22:17:07.041Z] 22:17:07     INFO - Buffered messages finished
[task 2019-10-02T22:17:07.042Z] 22:17:07     INFO - TEST-UNEXPECTED-FAIL | devtools/client/aboutdebugging/test/browser/browser_aboutdebugging_serviceworker_timeout.js | Test timed out - 
[task 2019-10-02T22:17:07.044Z] 22:17:07     INFO - Removing tab.
[task 2019-10-02T22:17:07.044Z] 22:17:07     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2019-10-02T22:17:07.045Z] 22:17:07     INFO - Got event: 'TabClose' on [object XULElement].
[task 2019-10-02T22:17:07.045Z] 22:17:07     INFO - Tab removed and finished closing
[task 2019-10-02T22:17:07.046Z] 22:17:07     INFO - Removing tab.
[task 2019-10-02T22:17:07.046Z] 22:17:07     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2019-10-02T22:17:07.047Z] 22:17:07     INFO - Got event: 'TabClose' on [object XULElement].
[task 2019-10-02T22:17:07.050Z] 22:17:07     INFO - Tab removed and finished closing
[task 2019-10-02T22:17:07.050Z] 22:17:07     INFO - TEST-PASS | devtools/client/aboutdebugging/test/browser/browser_aboutdebugging_serviceworker_timeout.js | The main process DebuggerServer has no pending connection when the test ends - 
[task 2019-10-02T22:17:07.050Z] 22:17:07     INFO - GECKO(1155) | MEMORY STAT | vsize 4080MB | residentFast 751MB | heapAllocated 307MB
[task 2019-10-02T22:17:07.051Z] 22:17:07     INFO - TEST-OK | devtools/client/aboutdebugging/test/browser/browser_aboutdebugging_serviceworker_timeout.js | took 135140ms
[task 2019-10-02T22:17:07.051Z] 22:17:07     INFO - checking window state
[task 2019-10-02T22:17:07.052Z] 22:17:07     INFO - TEST-START | devtools/client/aboutdebugging/test/browser/browser_aboutdebugging_serviceworker_unregister.js
[task 2019-10-02T22:17:07.781Z] 22:17:07     INFO - GECKO(1155) | Empty service worker registered
[task 2019-10-02T22:17:51.802Z] 22:17:51     INFO - Not taking screenshot here: see the one that was previously logged
[task 2019-10-02T22:17:51.802Z] 22:17:51     INFO - Buffered messages logged at 22:17:06
[task 2019-10-02T22:17:51.802Z] 22:17:51     INFO - Entering test bound 
[task 2019-10-02T22:17:51.802Z] 22:17:51     INFO - opening about:debugging
[task 2019-10-02T22:17:51.802Z] 22:17:51     INFO - Adding a new tab with URL: about:debugging
[task 2019-10-02T22:17:51.802Z] 22:17:51     INFO - Buffered messages logged at 22:17:07
[task 2019-10-02T22:17:51.802Z] 22:17:51     INFO - Tab added and finished loading
[task 2019-10-02T22:17:51.802Z] 22:17:51     INFO - Wait until Connect page is displayed
[task 2019-10-02T22:17:51.802Z] 22:17:51     INFO - Select This Firefox page
[task 2019-10-02T22:17:51.802Z] 22:17:51     INFO - Wait for requests to be complete
[task 2019-10-02T22:17:51.802Z] 22:17:51     INFO - Wait for runtime page to be rendered
[task 2019-10-02T22:17:51.802Z] 22:17:51     INFO - Adding a new tab with URL: http://example.com/browser/devtools/client/aboutdebugging/test/browser/resources/service-workers/empty-sw.html
[task 2019-10-02T22:17:51.802Z] 22:17:51     INFO - Tab added and finished loading
[task 2019-10-02T22:17:51.802Z] 22:17:51     INFO - Wait until the service worker appears and is running
[task 2019-10-02T22:17:51.802Z] 22:17:51     INFO - TEST-PASS | devtools/client/aboutdebugging/test/browser/browser_aboutdebugging_serviceworker_unregister.js | Found its unregister button - 
[task 2019-10-02T22:17:51.802Z] 22:17:51     INFO - Click on the unregister button and wait for the service worker to disappear
[task 2019-10-02T22:17:51.802Z] 22:17:51     INFO - Buffered messages finished
[task 2019-10-02T22:17:51.802Z] 22:17:51     INFO - TEST-UNEXPECTED-FAIL | devtools/client/aboutdebugging/test/browser/browser_aboutdebugging_serviceworker_unregister.js | Test timed out - 
[task 2019-10-02T22:17:51.802Z] 22:17:51     INFO - Removing tab.
[task 2019-10-02T22:17:51.805Z] 22:17:51     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2019-10-02T22:17:51.813Z] 22:17:51     INFO - Got event: 'TabClose' on [object XULElement].
[task 2019-10-02T22:17:51.823Z] 22:17:51     INFO - Tab removed and finished closing
[task 2019-10-02T22:17:51.824Z] 22:17:51     INFO - Removing tab.
[task 2019-10-02T22:17:51.825Z] 22:17:51     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2019-10-02T22:17:51.826Z] 22:17:51     INFO - Got event: 'TabClose' on [object XULElement].
[task 2019-10-02T22:17:51.842Z] 22:17:51     INFO - Tab removed and finished closing
[task 2019-10-02T22:17:51.884Z] 22:17:51     INFO - TEST-PASS | devtools/client/aboutdebugging/test/browser/browser_aboutdebugging_serviceworker_unregister.js | Service worker was successfully unregistered - 
[task 2019-10-02T22:17:51.891Z] 22:17:51     INFO - Remove tabs
[task 2019-10-02T22:17:51.892Z] 22:17:51     INFO - Removing tab.
[task 2019-10-02T22:17:51.896Z] 22:17:51     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2019-10-02T22:17:51.898Z] 22:17:51     INFO - TEST-PASS | devtools/client/aboutdebugging/test/browser/browser_aboutdebugging_serviceworker_unregister.js | The main process DebuggerServer has no pending connection when the test ends - 
[task 2019-10-02T22:17:51.914Z] 22:17:51     INFO - GECKO(1155) | MEMORY STAT | vsize 4074MB | residentFast 755MB | heapAllocated 308MB
[task 2019-10-02T22:17:51.915Z] 22:17:51     INFO - TEST-OK | devtools/client/aboutdebugging/test/browser/browser_aboutdebugging_serviceworker_unregister.js | took 45127ms
[task 2019-10-02T22:17:52.003Z] 22:17:52     INFO - checking window state
[task 2019-10-02T22:17:52.007Z] 22:17:52     INFO - Not taking screenshot here: see the one that was previously logged
[task 2019-10-02T22:17:52.007Z] 22:17:52     INFO - TEST-UNEXPECTED-FAIL | devtools/client/aboutdebugging/test/browser/browser_aboutdebugging_serviceworker_unregister.js | Uncaught exception received from previously timed out test - at chrome://mochitests/content/browser/devtools/client/shared/test/shared-head.js:240 - ReferenceError: info is not defined
[task 2019-10-02T22:17:52.007Z] 22:17:52     INFO - Stack trace:
[task 2019-10-02T22:17:52.008Z] 22:17:52     INFO - removeTab@chrome://mochitests/content/browser/devtools/client/shared/test/shared-head.js:240:3
[task 2019-10-02T22:17:52.008Z] 22:17:52     INFO - async*@chrome://mochitests/content/browser/devtools/client/aboutdebugging/test/browser/browser_aboutdebugging_serviceworker_unregister.js:49:9

Comment 1

[Daniel Varga [:dvarga]]

:ochameau, can you please take a look at this?

Comment 2

[Intermittent Failures Robot]

25 failures in 930 pushes (0.027 failures/push) were associated with this bug yesterday.

Repository breakdown:

• mozilla-central: 8
• autoland: 17

Platform breakdown:

• linux64: 24
• windows10-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1585829&startday=2019-10-02&endday=2019-10-02&tree=all

Comment 3

[Alexandre Poirot [:ochameau]]

Attachment: Bug 1585829 - Ensure releasing Service workers when the connection drops.

With fission, we most likely have a process switch and the existing worker
target isn't properly detached. We should ensure releasing the SW whenever
the connection to the server drops

Comment 4

[Intermittent Failures Robot]

25 failures in 619 pushes (0.04 failures/push) were associated with this bug yesterday.

Repository breakdown:

• mozilla-central: 10
• autoland: 15

Platform breakdown:

• linux64: 5
• windows10-64: 5
• macosx1014-64-shippable: 11
• linux64-shippable: 2
• windows10-64-shippable: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1585829&startday=2019-10-04&endday=2019-10-04&tree=all

Comment 5

[Intermittent Failures Robot]

73 failures in 4292 pushes (0.017 failures/push) were associated with this bug in the last 7 days.

This is the #15 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• mozilla-central: 41
• autoland: 32

Platform breakdown:

• linux64: 43
• windows10-64: 15
• macosx1014-64-shippable: 11
• linux64-shippable: 2
• windows10-64-shippable: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1585829&startday=2019-09-30&endday=2019-10-06&tree=all

Comment 6

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/cb4d08254ca7
Ensure releasing Service workers when the connection drops. r=jdescottes

Comment 7

[Arthur Iakab [arthur_iakab]]

https://hg.mozilla.org/mozilla-central/rev/cb4d08254ca7

Comment 8

[Intermittent Failures Robot]

23 failures in 3801 pushes (0.006 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 18
• try: 5

Platform breakdown:

• linux64: 10
• windows10-64: 13

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1585829&startday=2019-10-07&endday=2019-10-13&tree=all

Comment 9

[Chris Peterson [:cpeterson]]

Retroactively moving fixed bugs whose summaries mention "Fission" (or other Fission-related keywords) but are not assigned to a Fission Milestone to an appropriate Fission Milestone.

This will generate a lot of bugmail, so you can filter your bugmail for the following UUID and delete them en masse:

0ee3c76a-bc79-4eb2-8d12-05dc0b68e732