Closed Bug 1601492 Opened 6 years ago Closed 4 years ago

Intermittent TEST-UNEXPECTED-TIMEOUT | /fetch/api/abort/serviceworker-intercepted.https.html | Already aborted request does not land in service worker - Test timed out

Categories

(Core :: DOM: Networking, defect, P3)

Product:
Core
Component:
DOM: Networking
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, Whiteboard: [necko-triaged])

Filed by: apavel [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=279639165&repo=mozilla-esr68
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/IjRd8_dDS9eo_8vzsvqgnA/runs/0/artifacts/public/logs/live_backing.log

[task 2019-12-04T22:01:21.860Z] 22:01:21 INFO - TEST-START | /fetch/api/abort/serviceworker-intercepted.https.html
[task 2019-12-04T22:01:21.860Z] 22:01:21 INFO - Clearing pref dom.serviceWorkers.enabled
[task 2019-12-04T22:01:21.881Z] 22:01:21 INFO - Clearing pref javascript.options.streams
[task 2019-12-04T22:01:21.922Z] 22:01:21 INFO - Setting pref dom.serviceWorkers.enabled (true)
[task 2019-12-04T22:01:21.958Z] 22:01:21 INFO - Setting pref javascript.options.streams (true)
[task 2019-12-04T22:01:21.974Z] 22:01:21 INFO - Closing window 19327352833
[task 2019-12-04T22:01:22.030Z] 22:01:22 INFO - PID 25942 | [Child 26024, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 662
[task 2019-12-04T22:01:22.099Z] 22:01:22 INFO - PID 25942 | [Child 26377, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 574
[task 2019-12-04T22:01:22.099Z] 22:01:22 INFO - PID 25942 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2019-12-04T22:01:22.136Z] 22:01:22 INFO - PID 25942 | ++DOMWINDOW == 7 (0x7fc552540c00) [pid = 26024] [serial = 13] [outer = 0x7fc5583a7d40]
[task 2019-12-04T22:01:22.215Z] 22:01:22 INFO - PID 25942 | --DOCSHELL 0x7f50f7d7f000 == 1 [pid = 26377] [id = {9495b385-a178-47cc-bade-500aac50f97b}] [url = about:srcdoc]
[task 2019-12-04T22:01:22.216Z] 22:01:22 INFO - PID 25942 | --DOCSHELL 0x7f50f7d38800 == 0 [pid = 26377] [id = {d8e8c4d6-8504-4176-9c07-6c1726c40a4d}] [url = http://web-platform.test:8000/fetch/api/abort/keepalive.html]
[task 2019-12-04T22:01:22.297Z] 22:01:22 INFO - PID 25942 | --DOMWINDOW == 5 (0x7f50f82d1d40) [pid = 26377] [serial = 1] [outer = (nil)] [url = http://web-platform.test:8000/fetch/api/abort/keepalive.html]
[task 2019-12-04T22:01:22.297Z] 22:01:22 INFO - PID 25942 | --DOMWINDOW == 4 (0x7f50f8378c00) [pid = 26377] [serial = 2] [outer = (nil)] [url = about:blank]
[task 2019-12-04T22:01:22.298Z] 22:01:22 INFO - PID 25942 | --DOMWINDOW == 3 (0x7f50f4c8d020) [pid = 26377] [serial = 5] [outer = (nil)] [url = about:srcdoc]
[task 2019-12-04T22:01:22.298Z] 22:01:22 INFO - PID 25942 | --DOMWINDOW == 2 (0x7f50f7d8d800) [pid = 26377] [serial = 3] [outer = (nil)] [url = about:blank]
[task 2019-12-04T22:01:22.300Z] 22:01:22 INFO - PID 25942 | --DOMWINDOW == 1 (0x7f50f7d95c00) [pid = 26377] [serial = 4] [outer = (nil)] [url = http://web-platform.test:8000/fetch/api/abort/keepalive.html]
[task 2019-12-04T22:01:22.302Z] 22:01:22 INFO - PID 25942 | --DOMWINDOW == 0 (0x7f50f7d98000) [pid = 26377] [serial = 6] [outer = (nil)] [url = about:srcdoc]
[task 2019-12-04T22:01:22.328Z] 22:01:22 INFO - PID 25942 | nsStringStats
[task 2019-12-04T22:01:22.328Z] 22:01:22 INFO - PID 25942 | => mAllocCount: 9512
[task 2019-12-04T22:01:22.328Z] 22:01:22 INFO - PID 25942 | => mReallocCount: 0
[task 2019-12-04T22:01:22.328Z] 22:01:22 INFO - PID 25942 | => mFreeCount: 9512
[task 2019-12-04T22:01:22.328Z] 22:01:22 INFO - PID 25942 | => mShareCount: 8501
[task 2019-12-04T22:01:22.328Z] 22:01:22 INFO - PID 25942 | => mAdoptCount: 548
[task 2019-12-04T22:01:22.328Z] 22:01:22 INFO - PID 25942 | => mAdoptFreeCount: 556
[task 2019-12-04T22:01:22.329Z] 22:01:22 INFO - PID 25942 | => Process ID: 26377, Thread ID: 139986178529088
[task 2019-12-04T22:01:22.385Z] 22:01:22 INFO - PID 25942 | ++DOCSHELL 0x7f082b831000 == 1 [pid = 26440] [id = {cea77311-8ab3-4d2b-95b6-8db8035cc42d}]
[task 2019-12-04T22:01:22.442Z] 22:01:22 INFO - PID 25942 | ++DOMWINDOW == 1 (0x7f082d13bd40) [pid = 26440] [serial = 1] [outer = (nil)]
[task 2019-12-04T22:01:22.450Z] 22:01:22 INFO - PID 25942 | [Child 26440, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 662
[task 2019-12-04T22:01:22.471Z] 22:01:22 INFO - PID 25942 | ++DOMWINDOW == 2 (0x7f082bd74c00) [pid = 26440] [serial = 2] [outer = 0x7f082d13bd40]
[task 2019-12-04T22:01:22.649Z] 22:01:22 INFO - PID 25942 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpJKTgFV.mozrunner/runtests_leaks_878_tab_pid26477.log
[task 2019-12-04T22:01:22.773Z] 22:01:22 INFO - PID 25942 | ++DOMWINDOW == 3 (0x7f082d08b800) [pid = 26440] [serial = 3] [outer = 0x7f082d13bd40]
[task 2019-12-04T22:01:22.778Z] 22:01:22 INFO - PID 25942 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2019-12-04T22:01:22.920Z] 22:01:22 INFO - PID 25942 | ++DOMWINDOW == 4 (0x7f082d090400) [pid = 26440] [serial = 4] [outer = 0x7f082d13bd40]
[task 2019-12-04T22:01:23.138Z] 22:01:23 INFO - PID 25942 | [Child 26440, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 574
[task 2019-12-04T22:01:34.247Z] 22:01:34 INFO - PID 25942 | --DOMWINDOW == 6 (0x7fc552540800) [pid = 26024] [serial = 12] [outer = (nil)] [url = http://web-platform.test:8000/testharness_runner.html]
[task 2019-12-04T22:01:36.953Z] 22:01:36 INFO - PID 25942 | --DOMWINDOW == 3 (0x7f082bd74c00) [pid = 26440] [serial = 2] [outer = (nil)] [url = about:blank]
[task 2019-12-04T22:01:36.953Z] 22:01:36 INFO - PID 25942 | --DOMWINDOW == 2 (0x7f082d08b800) [pid = 26440] [serial = 3] [outer = (nil)] [url = about:blank]
[task 2019-12-04T22:01:53.125Z] 22:01:53 INFO -
[task 2019-12-04T22:01:53.126Z] 22:01:53 INFO - TEST-UNEXPECTED-TIMEOUT | /fetch/api/abort/serviceworker-intercepted.https.html | Already aborted request does not land in service worker - Test timed out
[task 2019-12-04T22:01:53.126Z] 22:01:53 INFO -
[task 2019-12-04T22:01:53.127Z] 22:01:53 INFO - TEST-UNEXPECTED-NOTRUN | /fetch/api/abort/serviceworker-intercepted.https.html | response.arrayBuffer() rejects if already aborted - expected PASS
[task 2019-12-04T22:01:53.129Z] 22:01:53 INFO -
[task 2019-12-04T22:01:53.129Z] 22:01:53 INFO - TEST-UNEXPECTED-NOTRUN | /fetch/api/abort/serviceworker-intercepted.https.html | response.blob() rejects if already aborted - expected PASS
[task 2019-12-04T22:01:53.130Z] 22:01:53 INFO -
[task 2019-12-04T22:01:53.130Z] 22:01:53 INFO - TEST-UNEXPECTED-NOTRUN | /fetch/api/abort/serviceworker-intercepted.https.html | response.formData() rejects if already aborted - expected PASS
[task 2019-12-04T22:01:53.130Z] 22:01:53 INFO -
[task 2019-12-04T22:01:53.130Z] 22:01:53 INFO - TEST-UNEXPECTED-NOTRUN | /fetch/api/abort/serviceworker-intercepted.https.html | response.json() rejects if already aborted - expected PASS
[task 2019-12-04T22:01:53.131Z] 22:01:53 INFO -
[task 2019-12-04T22:01:53.131Z] 22:01:53 INFO - TEST-UNEXPECTED-NOTRUN | /fetch/api/abort/serviceworker-intercepted.https.html | response.text() rejects if already aborted - expected PASS
[task 2019-12-04T22:01:53.132Z] 22:01:53 INFO -
[task 2019-12-04T22:01:53.132Z] 22:01:53 INFO - TEST-UNEXPECTED-NOTRUN | /fetch/api/abort/serviceworker-intercepted.https.html | Stream errors once aborted. - expected PASS
[task 2019-12-04T22:01:53.132Z] 22:01:53 INFO - TEST-UNEXPECTED-TIMEOUT | /fetch/api/abort/serviceworker-intercepted.https.html | expected OK
[task 2019-12-04T22:01:53.133Z] 22:01:53 INFO - TEST-INFO took 31270ms
[task 2019-12-04T22:01:53.162Z] 22:01:53 INFO - PID 25942 | 1575496913159 Marionette INFO Stopped listening on port 2828
[task 2019-12-04T22:01:53.426Z] 22:01:53 INFO - PID 25942 | [Child 26001, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 574
[task 2019-12-04T22:01:53.434Z] 22:01:53 INFO - PID 25942 | [Child 26024, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 574
[task 2019-12-04T22:01:53.501Z] 22:01:53 INFO - PID 25942 | --DOCSHELL 0x7fd5f91a5800 == 3 [pid = 26001] [id = {4a6f974b-9e57-4bb6-a1f2-239ac3851362}] [url = moz-extension://340425fa-5003-4b7b-88d8-aa1912ce8a5c/_generated_background_page.html]
[task 2019-12-04T22:01:53.502Z] 22:01:53 INFO - PID 25942 | --DOCSHELL 0x7fd5fa484000 == 2 [pid = 26001] [id = {b7463282-5dee-4580-9d13-fd27e8107af0}] [url = moz-extension://74caf3b6-6d5b-4177-b55c-5892b34203f1/_generated_background_page.html]
[task 2019-12-04T22:01:53.502Z] 22:01:53 INFO - PID 25942 | --DOCSHELL 0x7fd5f91a7800 == 1 [pid = 26001] [id = {55cc9b3b-9636-483f-8908-392ce6edb302}] [url = moz-extension://971908f3-9d98-43da-8f6b-4acef3f02f8e/_generated_background_page.html]
[task 2019-12-04T22:01:53.502Z] 22:01:53 INFO - PID 25942 | --DOCSHELL 0x7fd5f91a3800 == 0 [pid = 26001] [id = {eefbfabf-f6fb-4e5b-9db9-990a4a7e7146}] [url = moz-extension://4fee127a-a181-4854-9b2c-f1c961081fe4/_generated_background_page.html]
[task 2019-12-04T22:01:53.599Z] 22:01:53 INFO - PID 25942 | --DOMWINDOW == 7 (0x7fd5f90392e0) [pid = 26001] [serial = 3] [outer = (nil)] [url = moz-extension://340425fa-5003-4b7b-88d8-aa1912ce8a5c/_generated_background_page.html]
[task 2019-12-04T22:01:53.599Z] 22:01:53 INFO - PID 25942 | --DOMWINDOW == 6 (0x7fd5f90394c0) [pid = 26001] [serial = 4] [outer = (nil)] [url = moz-extension://971908f3-9d98-43da-8f6b-4acef3f02f8e/_generated_background_page.html]
[task 2019-12-04T22:01:53.599Z] 22:01:53 INFO - PID 25942 | --DOMWINDOW == 5 (0x7fd5f9038d40) [pid = 26001] [serial = 1] [outer = (nil)] [url = moz-extension://74caf3b6-6d5b-4177-b55c-5892b34203f1/_generated_background_page.html]
[task 2019-12-04T22:01:53.600Z] 22:01:53 INFO - PID 25942 | --DOMWINDOW == 4 (0x7fd5f9039100) [pid = 26001] [serial = 2] [outer = (nil)] [url = moz-extension://4fee127a-a181-4854-9b2c-f1c961081fe4/_generated_background_page.html]
[task 2019-12-04T22:01:53.601Z] 22:01:53 INFO - PID 25942 | --DOMWINDOW == 3 (0x7fd5f8b84c00) [pid = 26001] [serial = 14] [outer = (nil)] [url = moz-extension://971908f3-9d98-43da-8f6b-4acef3f02f8e/_generated_background_page.html]
[task 2019-12-04T22:01:53.601Z] 22:01:53 INFO - PID 25942 | --DOMWINDOW == 2 (0x7fd5f8b83800) [pid = 26001] [serial = 13] [outer = (nil)] [url = moz-extension://340425fa-5003-4b7b-88d8-aa1912ce8a5c/_generated_background_page.html]
[task 2019-12-04T22:01:53.603Z] 22:01:53 INFO - PID 25942 | --DOMWINDOW == 1 (0x7fd5f8b82400) [pid = 26001] [serial = 12] [outer = (nil)] [url = moz-extension://4fee127a-a181-4854-9b2c-f1c961081fe4/_generated_background_page.html]
[task 2019-12-04T22:01:53.603Z] 22:01:53 INFO - PID 25942 | --DOMWINDOW == 0 (0x7fd5f8b80c00) [pid = 26001] [serial = 11] [outer = (nil)] [url = moz-extension://74caf3b6-6d5b-4177-b55c-5892b34203f1/_generated_background_page.html]
[task 2019-12-04T22:01:53.642Z] 22:01:53 INFO - PID 25942 | nsStringStats

Priority: P5 → P3
Whiteboard: [necko-triaged]

Bulk closing some old intermittents.

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