Closed Bug 1585829 Opened 5 months ago Closed 5 months ago

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

Categories

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

defect

Tracking

(Fission Milestone:M4, firefox-esr60 unaffected, firefox-esr68 unaffected, firefox67 unaffected, firefox68 unaffected, firefox69 unaffected, firefox70 unaffected, firefox71 fixed)

RESOLVED FIXED
Firefox 71
Fission Milestone M4
Tracking Status
firefox-esr60 --- unaffected
firefox-esr68 --- unaffected
firefox67 --- unaffected
firefox68 --- unaffected
firefox69 --- unaffected
firefox70 --- unaffected
firefox71 --- fixed

People

(Reporter: intermittent-bug-filer, Assigned: ochameau)

References

(Blocks 1 open bug, Regression)

Details

(Keywords: intermittent-failure, regression)

Attachments

(1 file)

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
Regressed by: 1571703

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

Flags: needinfo?(poirot.alex)
Assignee: nobody → poirot.alex
Flags: needinfo?(poirot.alex)

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

Blocks: 1456995
Pushed by apoirot@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/cb4d08254ca7
Ensure releasing Service workers when the connection drops. r=jdescottes
Status: NEW → RESOLVED
Closed: 5 months ago
Resolution: --- → FIXED
Target Milestone: --- → Firefox 71

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

Fission Milestone: --- → M4
You need to log in before you can comment on or make changes to this bug.