Closed Bug 1555960 Opened 7 years ago Closed 7 years ago

Intermittent TEST-UNEXPECTED-TIMEOUT | /web-locks/<random>.https.any.serviceworker.html | expected OK

Categories

(Testing :: web-platform-tests, defect, P5)

Version 3
defect

Tracking

(Not tracked)

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, regression)

Filed by: malexandru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=249364368&repo=autoland
Full log: https://queue.taskcluster.net/v1/task/XE3fWxL1RoKZkIL78E_SJQ/runs/0/artifacts/public/logs/live_backing.log


[task 2019-05-31T12:30:20.383Z] 12:30:20 INFO - TEST-OK | /web-locks/mode-exclusive.tentative.https.any.sharedworker.html | took 793ms
[task 2019-05-31T12:30:20.384Z] 12:30:20 INFO - TEST-START | /web-locks/mode-exclusive.tentative.https.any.serviceworker.html
[task 2019-05-31T12:30:20.387Z] 12:30:20 INFO - Closing window 55834574849
[task 2019-05-31T12:30:20.415Z] 12:30:20 INFO - PID 4871 | [Child 4962, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 662
[task 2019-05-31T12:30:20.492Z] 12:30:20 INFO - PID 4871 | [Child 5865, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 575
[task 2019-05-31T12:30:20.492Z] 12:30:20 INFO - PID 4871 | [Child 5865, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 575
[task 2019-05-31T12:30:20.492Z] 12:30:20 INFO - PID 4871 | [Child 5865, Main Thread] WARNING: A runnable was posted to a worker that is already shutting down!: file /builds/worker/workspace/build/src/dom/workers/WorkerPrivate.cpp, line 1384
[task 2019-05-31T12:30:20.492Z] 12:30:20 INFO - PID 4871 | [Child 5865, Main Thread] WARNING: Failed to dispatch offline status change event!: file /builds/worker/workspace/build/src/dom/workers/WorkerPrivate.cpp, line 1851
[task 2019-05-31T12:30:20.492Z] 12:30:20 INFO - PID 4871 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2019-05-31T12:30:20.500Z] 12:30:20 INFO - PID 4871 | ++DOCSHELL 0x7ff3b6ed7000 == 1 [pid = 5898] [id = {9dc32308-df5a-4795-89ad-716a240cb539}]
[task 2019-05-31T12:30:20.548Z] 12:30:20 INFO - PID 4871 | ++DOMWINDOW == 1 (0x7ff3b6e2ad40) [pid = 5898] [serial = 1] [outer = (nil)]
[task 2019-05-31T12:30:20.556Z] 12:30:20 INFO - PID 4871 | [Child 5898, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 662
[task 2019-05-31T12:30:20.572Z] 12:30:20 INFO - PID 4871 | --DOCSHELL 0x7f9b9a8d7000 == 0 [pid = 5865] [id = {b3f3144d-a6de-4d9d-8158-2fc8adba1e56}] [url = https://web-platform.test:8443/web-locks/mode-exclusive.tentative.https.any.sharedworker.html]
[task 2019-05-31T12:30:20.572Z] 12:30:20 INFO - PID 4871 | ++DOMWINDOW == 2 (0x7ff3b6e60000) [pid = 5898] [serial = 2] [outer = 0x7ff3b6e2ad40]
[task 2019-05-31T12:30:20.629Z] 12:30:20 INFO - PID 4871 | --DOMWINDOW == 3 (0x7f9b9a812d40) [pid = 5865] [serial = 1] [outer = (nil)] [url = https://web-platform.test:8443/web-locks/mode-exclusive.tentative.https.any.sharedworker.html]
[task 2019-05-31T12:30:20.629Z] 12:30:20 INFO - PID 4871 | --DOMWINDOW == 2 (0x7f9b9a717c00) [pid = 5865] [serial = 2] [outer = (nil)] [url = about:blank]
[task 2019-05-31T12:30:20.629Z] 12:30:20 INFO - PID 4871 | --DOMWINDOW == 1 (0x7f9b9c3a1000) [pid = 5865] [serial = 3] [outer = (nil)] [url = about:blank]
[task 2019-05-31T12:30:20.630Z] 12:30:20 INFO - PID 4871 | --DOMWINDOW == 0 (0x7f9b9c3a6000) [pid = 5865] [serial = 4] [outer = (nil)] [url = https://web-platform.test:8443/web-locks/mode-exclusive.tentative.https.any.sharedworker.html]
[task 2019-05-31T12:30:20.633Z] 12:30:20 INFO - PID 4871 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmplafiXz.mozrunner/runtests_leaks_863_tab_pid5933.log
[task 2019-05-31T12:30:20.655Z] 12:30:20 INFO - PID 4871 | [Child 5865, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/workspace/build/src/xpcom/base/nsTraceRefcnt.cpp, line 194
[task 2019-05-31T12:30:20.657Z] 12:30:20 INFO - PID 4871 | [Child 5865, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/workspace/build/src/xpcom/base/nsTraceRefcnt.cpp, line 194
[task 2019-05-31T12:30:20.657Z] 12:30:20 INFO - PID 4871 | nsStringStats
[task 2019-05-31T12:30:20.659Z] 12:30:20 INFO - PID 4871 | => mAllocCount: 9150
[task 2019-05-31T12:30:20.659Z] 12:30:20 INFO - PID 4871 | => mReallocCount: 0
[task 2019-05-31T12:30:20.659Z] 12:30:20 INFO - PID 4871 | => mFreeCount: 9150
[task 2019-05-31T12:30:20.660Z] 12:30:20 INFO - PID 4871 | => mShareCount: 8127
[task 2019-05-31T12:30:20.661Z] 12:30:20 INFO - PID 4871 | => mAdoptCount: 550
[task 2019-05-31T12:30:20.661Z] 12:30:20 INFO - PID 4871 | => mAdoptFreeCount: 562
[task 2019-05-31T12:30:20.661Z] 12:30:20 INFO - PID 4871 | => Process ID: 5865, Thread ID: 140306742617920
[task 2019-05-31T12:30:20.764Z] 12:30:20 INFO - PID 4871 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2019-05-31T12:30:20.780Z] 12:30:20 INFO - PID 4871 | ++DOMWINDOW == 3 (0x7ff3b6abe400) [pid = 5898] [serial = 3] [outer = 0x7ff3b6e2ad40]
[task 2019-05-31T12:30:20.978Z] 12:30:20 INFO - PID 4871 | ++DOMWINDOW == 4 (0x7ff3b6d30400) [pid = 5898] [serial = 4] [outer = 0x7ff3b6e2ad40]
[task 2019-05-31T12:30:21.107Z] 12:30:21 INFO - PID 4871 | [Child 5898, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 575
[task 2019-05-31T12:30:21.114Z] 12:30:21 INFO - PID 4871 | [Parent 4871, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 575
[task 2019-05-31T12:30:21.118Z] 12:30:21 INFO - PID 4871 | [Child 5048, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 575
[task 2019-05-31T12:30:21.118Z] 12:30:21 INFO - PID 4871 | [Child 4962, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 575
[task 2019-05-31T12:30:21.118Z] 12:30:21 INFO - PID 4871 | [Child 4935, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 575
[task 2019-05-31T12:30:21.118Z] 12:30:21 INFO - PID 4871 | [Child 5898, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 575
[task 2019-05-31T12:30:21.122Z] 12:30:21 INFO - PID 4871 | [Child 5933, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 575
[task 2019-05-31T12:30:34.950Z] 12:30:34 INFO - PID 4871 | --DOMWINDOW == 3 (0x7ff3b6e60000) [pid = 5898] [serial = 2] [outer = (nil)] [url = about:blank]
[task 2019-05-31T12:30:34.950Z] 12:30:34 INFO - PID 4871 | --DOMWINDOW == 2 (0x7ff3b6abe400) [pid = 5898] [serial = 3] [outer = (nil)] [url = about:blank]
[task 2019-05-31T12:30:51.136Z] 12:30:51 INFO - TEST-UNEXPECTED-TIMEOUT | /web-locks/mode-exclusive.tentative.https.any.serviceworker.html | expected OK
[task 2019-05-31T12:30:51.136Z] 12:30:51 INFO - TEST-INFO took 30752ms
[task 2019-05-31T12:30:51.164Z] 12:30:51 INFO - PID 4871 | 1559305851157 Marionette INFO Stopped listening on port 2828
[task 2019-05-31T12:30:51.422Z] 12:30:51 INFO - PID 4871 | [Child 4935, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 575
[task 2019-05-31T12:30:51.426Z] 12:30:51 INFO - PID 4871 | [Child 5898, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 575
[task 2019-05-31T12:30:51.427Z] 12:30:51 INFO - PID 4871 | [Child 4962, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 575
[task 2019-05-31T12:30:51.428Z] 12:30:51 INFO - PID 4871 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2019-05-31T12:30:51.429Z] 12:30:51 INFO - PID 4871 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2019-05-31T12:30:51.433Z] 12:30:51 INFO - PID 4871 | [Child 5898, Main Thread] WARNING: Could not open cache.: file /builds/worker/workspace/build/src/dom/serviceworkers/ServiceWorkerScriptCache.cpp, line 1248
[task 2019-05-31T12:30:51.433Z] 12:30:51 INFO - PID 4871 | [Child 5898, Main Thread] WARNING: 'Canceled() || !swm', file /builds/worker/workspace/build/src/dom/serviceworkers/ServiceWorkerUpdateJob.cpp, line 311
[task 2019-05-31T12:30:51.497Z] 12:30:51 INFO - PID 4871 | --DOCSHELL 0x7f46454d5000 == 0 [pid = 4962] [id = {abd71bd1-6e69-4eb9-be53-2b9151200e5d}] [url = https://web-platform.test:8443/testharness_runner.html]
[task 2019-05-31T12:30:51.499Z] 12:30:51 INFO - PID 4871 | --DOCSHELL 0x7ff3b6ed7000 == 0 [pid = 5898] [id = {9dc32308-df5a-4795-89ad-716a240cb539}] [url = https://web-platform.test:8443/web-locks/mode-exclusive.tentative.https.any.serviceworker.html]
[task 2019-05-31T12:30:51.519Z] 12:30:51 INFO - PID 4871 | --DOCSHELL 0x7f0e3eedb000 == 3 [pid = 4935] [id = {2b92a990-d802-498c-bf8a-dee3ca643990}] [url = moz-extension://d4e9e5f8-3be4-4dc3-8c16-3a333ab61b64/_generated_background_page.html]
[task 2019-05-31T12:30:51.519Z] 12:30:51 INFO - PID 4871 | --DOCSHELL 0x7f0e3f73f000 == 2 [pid = 4935] [id = {1b39912b-aa4e-420d-93b6-dbcf0a1dda12}] [url = moz-extension://fec20b34-57d0-41b2-b8f0-537525124668/_generated_background_page.html]
[task 2019-05-31T12:30:51.520Z] 12:30:51 INFO - PID 4871 | --DOCSHELL 0x7f0e3f741000 == 1 [pid = 4935] [id = {aafc999a-1fb4-4d91-a0e4-00e05877f502}] [url = moz-extension://da6fe9c5-b5ec-4495-b9a1-f4817e4ff75e/_generated_background_page.html]
[task 2019-05-31T12:30:51.520Z] 12:30:51 INFO - PID 4871 | --DOCSHELL 0x7f0e5887a800 == 0 [pid = 4935] [id = {cde47793-b40e-4ed3-ab4e-ea0211e04dc5}] [url = moz-extension://7b2cd119-6310-491f-8edc-7e79914a9659/_generated_background_page.html]
[task 2019-05-31T12:30:51.540Z] 12:30:51 INFO - PID 4871 | --DOMWINDOW == 1 (0x7f46450d8400) [pid = 4962] [serial = 6] [outer = (nil)] [url = https://web-platform.test:8443/testharness_runner.html]
[task 2019-05-31T12:30:51.541Z] 12:30:51 INFO - PID 4871 | --DOMWINDOW == 0 (0x7f4645309d40) [pid = 4962] [serial = 1] [outer = (nil)] [url = https://web-platform.test:8443/testharness_runner.html]
[task 2019-05-31T12:30:51.541Z] 12:30:51 INFO - PID 4871 | --DOMWINDOW == 1 (0x7ff3b6e2ad40) [pid = 5898] [serial = 1] [outer = (nil)] [url = https://web-platform.test:8443/web-locks/mode-exclusive.tentative.https.any.serviceworker.html]
[task 2019-05-31T12:30:51.541Z] 12:30:51 INFO - PID 4871 | --DOMWINDOW == 0 (0x7ff3b6d30400) [pid = 5898] [serial = 4] [outer = (nil)] [url = https://web-platform.test:8443/web-locks/mode-exclusive.tentative.https.any.serviceworker.html]
[task 2019-05-31T12:30:51.565Z] 12:30:51 INFO - PID 4871 | [Child 4962, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/workspace/build/src/xpcom/base/nsTraceRefcnt.cpp, line 194
[task 2019-05-31T12:30:51.567Z] 12:30:51 INFO - PID 4871 | [Child 4962, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/workspace/build/src/xpcom/base/nsTraceRefcnt.cpp, line 194
[task 2019-05-31T12:30:51.569Z] 12:30:51 INFO - PID 4871 | nsStringStats
[task 2019-05-31T12:30:51.569Z] 12:30:51 INFO - PID 4871 | => mAllocCount: 11130
[task 2019-05-31T12:30:51.570Z] 12:30:51 INFO - PID 4871 | => mReallocCount: 0
[task 2019-05-31T12:30:51.570Z] 12:30:51 INFO - PID 4871 | => mFreeCount: 11130
[task 2019-05-31T12:30:51.570Z] 12:30:51 INFO - PID 4871 | => mShareCount: 14696
[task 2019-05-31T12:30:51.570Z] 12:30:51 INFO - PID 4871 | => mAdoptCount: 684
[task 2019-05-31T12:30:51.570Z] 12:30:51 INFO - PID 4871 | => mAdoptFreeCount: 704
[task 2019-05-31T12:30:51.570Z] 12:30:51 INFO - PID 4871 | => Process ID: 4962, Thread ID: 139940240799552

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