Closed Bug 1593935 Opened 6 years ago Closed 6 years ago

Intermittent TEST-UNEXPECTED-TIMEOUT | /service-workers/service-worker/windowclient-navigate.https.html | invalid url (about:blank) - Test timed out

Categories

(Core :: DOM: Service Workers, defect, P5)

Product:
Core
Component:
DOM: Service Workers
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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

[task 2019-11-05T06:20:48.345Z] 06:20:48 INFO - TEST-PASS | /service-workers/service-worker/windowclient-navigate.https.html | cross orgin url
[task 2019-11-05T06:20:48.345Z] 06:20:48 INFO - TEST-PASS | /service-workers/service-worker/windowclient-navigate.https.html | invalid url (http://[example.com])
[task 2019-11-05T06:20:48.345Z] 06:20:48 INFO - TEST-PASS | /service-workers/service-worker/windowclient-navigate.https.html | invalid url (view-source://example.com)
[task 2019-11-05T06:20:48.345Z] 06:20:48 INFO - TEST-PASS | /service-workers/service-worker/windowclient-navigate.https.html | invalid url (file:///)
[task 2019-11-05T06:20:48.346Z] 06:20:48 INFO - TEST-UNEXPECTED-TIMEOUT | /service-workers/service-worker/windowclient-navigate.https.html | invalid url (about:blank) - Test timed out
[task 2019-11-05T06:20:48.346Z] 06:20:48 INFO - TEST-UNEXPECTED-TIMEOUT | /service-workers/service-worker/windowclient-navigate.https.html | expected OK
[task 2019-11-05T06:20:48.346Z] 06:20:48 INFO - TEST-INFO took 41736ms
[task 2019-11-05T06:20:48.381Z] 06:20:48 INFO - PID 18743 | 1572934848371 Marionette INFO Stopped listening on port 34966
[task 2019-11-05T06:20:48.680Z] 06:20:48 INFO - PID 18743 | --DOCSHELL 0x7f6d29f8b000 == 2 [pid = 18802] [id = {fe66cdc6-1bf9-4487-976e-08593ae20071}] [url = moz-extension://2a9daf79-2136-4371-9f86-ba418638a90a/_generated_background_page.html]
[task 2019-11-05T06:20:48.681Z] 06:20:48 INFO - PID 18743 | --DOCSHELL 0x7f6d00421000 == 1 [pid = 18802] [id = {8b362451-7a8f-4089-8f12-bc36170d095f}] [url = moz-extension://c65515a5-295f-42a7-bc6d-7bb396708c66/_generated_background_page.html]
[task 2019-11-05T06:20:48.681Z] 06:20:48 INFO - PID 18743 | --DOCSHELL 0x7f6cffbc5800 == 0 [pid = 18802] [id = {9ed00872-2fdc-40dd-a415-bf749553c4c3}] [url = moz-extension://fd83cabc-e33f-4a5b-bc49-18a4116be5cc/_generated_background_page.html]
[task 2019-11-05T06:20:48.900Z] 06:20:48 INFO - PID 18743 | --DOCSHELL 0x7f5804f29800 == 1 [pid = 25604] [id = {818e4ac8-dadc-4a9c-aa24-f1a4010aa936}] [url = https://web-platform.test:8443/service-workers/service-worker/resources/blank.html]
[task 2019-11-05T06:20:49.020Z] 06:20:49 INFO - PID 18743 | [2019-11-05T06:20:49Z WARN xulstore::persist] tried to remove key that isn't in the store
[task 2019-11-05T06:20:49.022Z] 06:20:49 INFO - PID 18743 | [2019-11-05T06:20:49Z WARN xulstore::persist] tried to remove key that isn't in the store
[task 2019-11-05T06:20:49.131Z] 06:20:49 INFO - PID 18743 | --DOCSHELL 0x7f5803cc0000 == 0 [pid = 25604] [id = {5dffe3bb-7a24-4daf-a8f5-e539a8859ed6}] [url = https://web-platform.test:8443/service-workers/service-worker/windowclient-navigate.https.html]
[task 2019-11-05T06:20:49.255Z] 06:20:49 INFO - PID 18743 | --DOMWINDOW == 3 (0x7f5803b0d4c0) [pid = 25604] [serial = 45] [outer = (nil)] [url = https://web-platform.test:8443/service-workers/service-worker/resources/blank.html]
[task 2019-11-05T06:20:49.255Z] 06:20:49 INFO - PID 18743 | --DOMWINDOW == 2 (0x7f5804f53000) [pid = 25604] [serial = 4] [outer = (nil)] [url = https://web-platform.test:8443/service-workers/service-worker/windowclient-navigate.https.html]
[task 2019-11-05T06:20:49.256Z] 06:20:49 INFO - PID 18743 | --DOMWINDOW == 1 (0x7f5803b0cf20) [pid = 25604] [serial = 1] [outer = (nil)] [url = https://web-platform.test:8443/service-workers/service-worker/windowclient-navigate.https.html]
[task 2019-11-05T06:20:49.256Z] 06:20:49 INFO - PID 18743 | --DOMWINDOW == 0 (0x7f580387d400) [pid = 25604] [serial = 46] [outer = (nil)] [url = https://web-platform.test:8443/service-workers/service-worker/resources/blank.html]
[task 2019-11-05T06:20:49.263Z] 06:20:49 INFO - PID 18743 | --DOMWINDOW == 5 (0x7f6d00ecc200) [pid = 18802] [serial = 5] [outer = (nil)] [url = moz-extension://2a9daf79-2136-4371-9f86-ba418638a90a/_generated_background_page.html]
[task 2019-11-05T06:20:49.264Z] 06:20:49 INFO - PID 18743 | --DOMWINDOW == 4 (0x7f6d00ecd4c0) [pid = 18802] [serial = 3] [outer = (nil)] [url = moz-extension://c65515a5-295f-42a7-bc6d-7bb396708c66/_generated_background_page.html]
[task 2019-11-05T06:20:49.264Z] 06:20:49 INFO - PID 18743 | --DOMWINDOW == 3 (0x7f6d00ecd2e0) [pid = 18802] [serial = 1] [outer = (nil)] [url = moz-extension://fd83cabc-e33f-4a5b-bc49-18a4116be5cc/_generated_background_page.html]
[task 2019-11-05T06:20:49.265Z] 06:20:49 INFO - PID 18743 | --DOMWINDOW == 2 (0x7f6cffba0000) [pid = 18802] [serial = 9] [outer = (nil)] [url = moz-extension://fd83cabc-e33f-4a5b-bc49-18a4116be5cc/_generated_background_page.html]
[task 2019-11-05T06:20:49.265Z] 06:20:49 INFO - PID 18743 | --DOMWINDOW == 1 (0x7f6cffba2400) [pid = 18802] [serial = 10] [outer = (nil)] [url = moz-extension://c65515a5-295f-42a7-bc6d-7bb396708c66/_generated_background_page.html]
[task 2019-11-05T06:20:49.267Z] 06:20:49 INFO - PID 18743 | --DOMWINDOW == 0 (0x7f6d00e42400) [pid = 18802] [serial = 11] [outer = (nil)] [url = moz-extension://2a9daf79-2136-4371-9f86-ba418638a90a/_generated_background_page.html]
[task 2019-11-05T06:20:49.312Z] 06:20:49 INFO - PID 18743 | nsStringStats
[task 2019-11-05T06:20:49.312Z] 06:20:49 INFO - PID 18743 | => mAllocCount: 16941
[task 2019-11-05T06:20:49.313Z] 06:20:49 INFO - PID 18743 | => mReallocCount: 0
[task 2019-11-05T06:20:49.313Z] 06:20:49 INFO - PID 18743 | => mFreeCount: 16941
[task 2019-11-05T06:20:49.313Z] 06:20:49 INFO - PID 18743 | => mShareCount: 10378
[task 2019-11-05T06:20:49.314Z] 06:20:49 INFO - PID 18743 | => mAdoptCount: 388
[task 2019-11-05T06:20:49.315Z] 06:20:49 INFO - PID 18743 | => mAdoptFreeCount: 412
[task 2019-11-05T06:20:49.315Z] 06:20:49 INFO - PID 18743 | => Process ID: 18802, Thread ID: 140106856396608
[task 2019-11-05T06:20:49.316Z] 06:20:49 INFO - PID 18743 | nsStringStats
[task 2019-11-05T06:20:49.318Z] 06:20:49 INFO - PID 18743 | => mAllocCount: 23181
[task 2019-11-05T06:20:49.318Z] 06:20:49 INFO - PID 18743 | => mReallocCount: 0
[task 2019-11-05T06:20:49.319Z] 06:20:49 INFO - PID 18743 | => mFreeCount: 23181
[task 2019-11-05T06:20:49.319Z] 06:20:49 INFO - PID 18743 | => mShareCount: 33648
[task 2019-11-05T06:20:49.320Z] 06:20:49 INFO - PID 18743 | => mAdoptCount: 871
[task 2019-11-05T06:20:49.320Z] 06:20:49 INFO - PID 18743 | => mAdoptFreeCount: 991
[task 2019-11-05T06:20:49.320Z] 06:20:49 INFO - PID 18743 | => Process ID: 25604, Thread ID: 140016730511168
[task 2019-11-05T06:20:57.063Z] 06:20:57 INFO - PID 18743 | --DOCSHELL 0x7fac357bd000 == 1 [pid = 18831] [id = {2743a2df-8caa-44a7-86dd-dee53430fa43}] [url = https://web-platform.test:8443/testharness_runner.html]
[task 2019-11-05T06:20:57.362Z] 06:20:57 INFO - PID 18743 | --DOCSHELL 0x7fac3619d000 == 0 [pid = 18831] [id = {679f2eac-8dba-4140-8618-46ac6619cf5a}] [url = about:newtab]
[task 2019-11-05T06:20:57.362Z] 06:20:57 INFO - PID 18743 | --DOMWINDOW == 4 (0x7fac36bc1f20) [pid = 18831] [serial = 1] [outer = (nil)] [url = https://web-platform.test:8443/testharness_runner.html]
[task 2019-11-05T06:20:57.362Z] 06:20:57 INFO - PID 18743 | --DOMWINDOW == 3 (0x7fac36bc24c0) [pid = 18831] [serial = 5] [outer = (nil)] [url = about:newtab]
[task 2019-11-05T06:20:59.074Z] 06:20:59 INFO - PID 18743 | WARNING: At least one completion condition is taking too long to complete. Conditions: [{"name":"ServiceWorkerShutdownBlocker: shutting down Service Workers","state":{"pendingPromises":2,"acceptingPromises":false},"filename":"/builds/worker/workspace/build/src/dom/serviceworkers/ServiceWorkerShutdownBlocker.cpp","lineNumber":82,"stack":"Service Workers shutdown"}] Barrier: profile-change-teardown
[task 2019-11-05T06:21:01.226Z] 06:21:01 INFO - PID 18743 | --DOMWINDOW == 2 (0x7fac36cb2800) [pid = 18831] [serial = 9] [outer = (nil)] [url = https://web-platform.test:8443/testharness_runner.html]
[task 2019-11-05T06:21:01.227Z] 06:21:01 INFO - PID 18743 | --DOMWINDOW == 1 (0x7fac361bd000) [pid = 18831] [serial = 7] [outer = (nil)] [url = about:newtab]
[task 2019-11-05T06:21:01.227Z] 06:21:01 INFO - PID 18743 | --DOMWINDOW == 0 (0x7fac36b85800) [pid = 18831] [serial = 8] [outer = (nil)] [url = http://web-platform.test:8000/testharness_runner.html]
[task 2019-11-05T06:21:03.881Z] 06:21:03 INFO - PID 18743 | console.error: (new Error("SessionFile is closed", "resource:///modules/sessionstore/SessionFile.jsm", 433))
[task 2019-11-05T06:21:50.079Z] 06:21:50 INFO - PID 18743 | FATAL ERROR: AsyncShutdown timeout in profile-change-teardown Conditions: [{"name":"ServiceWorkerShutdownBlocker: shutting down Service Workers","state":{"pendingPromises":2,"acceptingPromises":false},"filename":"/builds/worker/workspace/build/src/dom/serviceworkers/ServiceWorkerShutdownBlocker.cpp","lineNumber":82,"stack":"Service Workers shutdown"}] At least one completion condition failed to complete within a reasonable amount of time. Causing a crash to ensure that we do not leave the user with an unresponsive process draining resources.
[task 2019-11-05T06:21:50.080Z] 06:21:50 INFO - PID 18743 | [Parent 18743, Main Thread] ###!!! ABORT: file /builds/worker/workspace/build/src/dom/serviceworkers/ServiceWorkerShutdownBlocker.cpp, line 82
[task 2019-11-05T06:22:15.118Z] 06:22:15 INFO - PID 18743 | #01: nsDebugImpl::Abort(char const*, int) [xpcom/base/nsDebugImpl.cpp:135]
[task 2019-11-05T06:22:15.119Z] 06:22:15 INFO -
[task 2019-11-05T06:22:15.122Z] 06:22:15 INFO - PID 18743 | #02: NS_InvokeByIndex
[task 2019-11-05T06:22:15.123Z] 06:22:15 INFO -

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.