Closed Bug 1626943 Opened 5 years ago Closed 4 years ago

Intermittent TEST-UNEXPECTED-TIMEOUT | /html/cross-origin-embedder-policy/cache-storage-reporting-shared-worker.https.html | expected CRASH

Categories

(Core :: DOM: Workers, defect, P2)

defect

Tracking

()

RESOLVED INACTIVE

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Blocks 1 open bug, Regression)

Details

(Keywords: intermittent-failure, regression, Whiteboard: [stockwell unknown])

Filed by: dluca [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=295916918&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/B0ckRNuRQY6Vf8H9URC7LQ/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/B0ckRNuRQY6Vf8H9URC7LQ/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1


INFO - TEST-START | /html/cross-origin-embedder-policy/cache-storage-reporting-shared-worker.https.html
[task 2020-04-02T11:12:10.728Z] 11:12:10     INFO - Run 0/10
[task 2020-04-02T11:12:10.836Z] 11:12:10     INFO - PID 1062 | [Child 1654, Main Thread] WARNING: could not set real-time limit at process startup: file /builds/worker/checkouts/gecko/dom/ipc/ContentChild.cpp, line 1692
[task 2020-04-02T11:12:10.836Z] 11:12:10     INFO - Setting pref browser.tabs.remote.useCrossOriginEmbedderPolicy (true)
[task 2020-04-02T11:12:10.837Z] 11:12:10     INFO - PID 1062 | [Child 1654, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/checkouts/gecko/layout/base/nsPresContext.cpp, line 839
[task 2020-04-02T11:12:10.852Z] 11:12:10     INFO - PID 1062 | [2020-04-02T11:12:10Z WARN  rkv::backend::impl_safe::environment] Ignoring `map_size=16777216`
[task 2020-04-02T11:12:11.030Z] 11:12:11     INFO - PID 1062 | [Parent 1062, Main Thread] WARNING: '!mName', file /builds/worker/checkouts/gecko/editor/libeditor/EditAggregateTransaction.cpp, line 91
[task 2020-04-02T11:12:11.030Z] 11:12:11     INFO - PID 1062 | [Parent 1062, Main Thread] WARNING: EditAggregationTransaction::GetName() failed: 'NS_SUCCEEDED(rv)', file /builds/worker/checkouts/gecko/editor/libeditor/PlaceholderTransaction.cpp, line 217
[task 2020-04-02T11:12:11.030Z] 11:12:11     INFO - PID 1062 | [Parent 1062, Main Thread] WARNING: nsIAbsorbingTransaction::GetTxnName() failed, but ignored: 'NS_SUCCEEDED(rvIgnored)', file /builds/worker/checkouts/gecko/editor/libeditor/PlaceholderTransaction.cpp, line 188
[task 2020-04-02T11:12:11.287Z] 11:12:11     INFO - PID 1062 | [Child 1592, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/checkouts/gecko/layout/base/nsPresContext.cpp, line 839
[task 2020-04-02T11:12:11.538Z] 11:12:11     INFO - PID 1062 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpzMnd2N/runtests_leaks_1002_tab_pid1728.log
[task 2020-04-02T11:12:11.881Z] 11:12:11     INFO - PID 1062 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2020-04-02T11:12:11.902Z] 11:12:11     INFO - PID 1062 | [Parent 1062, Main Thread] WARNING: '!mName', file /builds/worker/checkouts/gecko/editor/libeditor/EditAggregateTransaction.cpp, line 91
[task 2020-04-02T11:12:11.944Z] 11:12:11     INFO - PID 1062 | [Parent 1062, Main Thread] WARNING: EditAggregationTransaction::GetName() failed: 'NS_SUCCEEDED(rv)', file /builds/worker/checkouts/gecko/editor/libeditor/PlaceholderTransaction.cpp, line 217
[task 2020-04-02T11:12:11.945Z] 11:12:11     INFO - PID 1062 | [Parent 1062, Main Thread] WARNING: nsIAbsorbingTransaction::GetTxnName() failed, but ignored: 'NS_SUCCEEDED(rvIgnored)', file /builds/worker/checkouts/gecko/editor/libeditor/PlaceholderTransaction.cpp, line 188
[task 2020-04-02T11:12:11.946Z] 11:12:11     INFO - PID 1062 | [Parent 1062, Main Thread] WARNING: '!mName', file /builds/worker/checkouts/gecko/editor/libeditor/EditAggregateTransaction.cpp, line 91
[task 2020-04-02T11:12:11.946Z] 11:12:11     INFO - PID 1062 | [Parent 1062, Main Thread] WARNING: EditAggregationTransaction::GetName() failed: 'NS_SUCCEEDED(rv)', file /builds/worker/checkouts/gecko/editor/libeditor/PlaceholderTransaction.cpp, line 217
[task 2020-04-02T11:12:11.948Z] 11:12:11     INFO - PID 1062 | [Parent 1062, Main Thread] WARNING: nsIAbsorbingTransaction::GetTxnName() failed, but ignored: 'NS_SUCCEEDED(rvIgnored)', file /builds/worker/checkouts/gecko/editor/libeditor/PlaceholderTransaction.cpp, line 188
[task 2020-04-02T11:12:11.949Z] 11:12:11     INFO - PID 1062 | [Parent 1062, Main Thread] WARNING: '!mName', file /builds/worker/checkouts/gecko/editor/libeditor/EditAggregateTransaction.cpp, line 91
[task 2020-04-02T11:12:11.951Z] 11:12:11     INFO - PID 1062 | [Parent 1062, Main Thread] WARNING: EditAggregationTransaction::GetName() failed: 'NS_SUCCEEDED(rv)', file /builds/worker/checkouts/gecko/editor/libeditor/PlaceholderTransaction.cpp, line 217
[task 2020-04-02T11:12:11.952Z] 11:12:11     INFO - PID 1062 | [Parent 1062, Main Thread] WARNING: nsIAbsorbingTransaction::GetTxnName() failed, but ignored: 'NS_SUCCEEDED(rvIgnored)', file /builds/worker/checkouts/gecko/editor/libeditor/PlaceholderTransaction.cpp, line 188
[task 2020-04-02T11:12:12.081Z] 11:12:12     INFO - PID 1062 | [Child 1728, Main Thread] WARNING: could not set real-time limit at process startup: file /builds/worker/checkouts/gecko/dom/ipc/ContentChild.cpp, line 1692
[task 2020-04-02T11:12:12.340Z] 11:12:12     INFO - PID 1062 | [Child 1654, Main Thread] WARNING: '!aWin', file /builds/worker/checkouts/gecko/dom/base/Document.cpp, line 1397
[task 2020-04-02T11:12:12.396Z] 11:12:12     INFO - PID 1062 | [Child 1654, Main Thread] WARNING: '!aWin', file /builds/worker/checkouts/gecko/dom/base/Document.cpp, line 1397
[task 2020-04-02T11:12:13.157Z] 11:12:13     INFO - PID 1062 | [Child 1592, Main Thread] WARNING: Workers don't support the 'mem.mem.' preference!: file /builds/worker/checkouts/gecko/dom/workers/RuntimeService.cpp, line 538
[task 2020-04-02T11:15:12.321Z] 11:15:12     INFO - TEST-UNEXPECTED-TIMEOUT | /html/cross-origin-embedder-policy/cache-storage-reporting-shared-worker.https.html | expected CRASH
[task 2020-04-02T11:15:12.322Z] 11:15:12     INFO - TEST-INFO expected CRASH | took 181594ms
[task 2020-04-02T11:15:12.358Z] 11:15:12     INFO - PID 1062 | 1585826112352	Marionette	INFO	Stopped listening on port 51120
[task 2020-04-02T11:15:12.641Z] 11:15:12     INFO - PID 1062 | [Parent 1062, URL Classifier] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/netwerk/url-classifier/AsyncUrlChannelClassifier.cpp, line 245
[task 2020-04-02T11:15:12.641Z] 11:15:12     INFO - PID 1062 | [Parent 1062, URL Classifier] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/netwerk/url-classifier/AsyncUrlChannelClassifier.cpp, line 245
[task 2020-04-02T11:15:12.641Z] 11:15:12     INFO - PID 1062 | [Parent 1062, URL Classifier] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/netwerk/url-classifier/AsyncUrlChannelClassifier.cpp, line 245
[task 2020-04-02T11:15:12.641Z] 11:15:12     INFO - PID 1062 | [Parent 1062, URL Classifier] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/netwerk/url-classifier/AsyncUrlChannelClassifier.cpp, line 245
[task 2020-04-02T11:15:12.642Z] 11:15:12     INFO - PID 1062 | [Parent 1062, URL Classifier] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/netwerk/url-classifier/AsyncUrlChannelClassifier.cpp, line 245
[task 2020-04-02T11:15:12.642Z] 11:15:12     INFO - PID 1062 | [Parent 1062, URL Classifier] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/netwerk/url-classifier/AsyncUrlChannelClassifier.cpp, line 245
[task 2020-04-02T11:15:12.642Z] 11:15:12     INFO - PID 1062 | [Parent 1062, URL Classifier] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/netwerk/url-classifier/AsyncUrlChannelClassifier.cpp, line 245
[task 2020-04-02T11:15:12.642Z] 11:15:12     INFO - PID 1062 | [Parent 1062, URL Classifier] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/netwerk/url-classifier/AsyncUrlChannelClassifier.cpp, line 245
[task 2020-04-02T11:15:12.642Z] 11:15:12     INFO - PID 1062 | [Parent 1062, URL Classifier] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/netwerk/url-classifier/AsyncUrlChannelClassifier.cpp, line 245
[task 2020-04-02T11:15:12.643Z] 11:15:12     INFO - PID 1062 | [Parent 1062, URL Classifier] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/netwerk/url-classifier/AsyncUrlChannelClassifier.cpp, line 245
[task 2020-04-02T11:15:12.663Z] 11:15:12     INFO - PID 1062 | ###!!! [Child][MessageChannel] Error: (msgtype=0x5A000D,name=PHttpChannel::Msg_DeletingChannel) Channel closing: too late to send/recv, messages will be lost
[task 2020-04-02T11:15:12.664Z] 11:15:12     INFO - PID 1062 | [Child 1592, Main Thread] WARNING: MsgDropped in ContentChild: file /builds/worker/checkouts/gecko/dom/ipc/ContentChild.cpp, line 2253
[task 2020-04-02T11:15:12.679Z] 11:15:12     INFO - PID 1062 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-04-02T11:15:12.680Z] 11:15:12     INFO - PID 1062 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-04-02T11:15:12.680Z] 11:15:12     INFO - PID 1062 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-04-02T11:15:12.680Z] 11:15:12     INFO - PID 1062 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-04-02T11:15:12.680Z] 11:15:12     INFO - PID 1062 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-04-02T11:15:12.684Z] 11:15:12     INFO - PID 1062 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-04-02T11:15:12.685Z] 11:15:12     INFO - PID 1062 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-04-02T11:15:12.766Z] 11:15:12     INFO - PID 1062 | [Child 1479, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3352
[task 2020-04-02T11:15:12.782Z] 11:15:12     INFO - PID 1062 | [2020-04-02T11:15:12Z WARN  xulstore::persist] tried to remove key that isn't in the store
[task 2020-04-02T11:15:12.783Z] 11:15:12     INFO - PID 1062 | [2020-04-02T11:15:12Z WARN  xulstore::persist] tried to remove key that isn't in the store
[task 2020-04-02T11:15:12.792Z] 11:15:12     INFO - PID 1062 | nsStringStats
[task 2020-04-02T11:15:12.793Z] 11:15:12     INFO - PID 1062 |  => mAllocCount:          11639
[task 2020-04-02T11:15:12.793Z] 11:15:12     INFO - PID 1062 |  => mReallocCount:            0
[task 2020-04-02T11:15:12.793Z] 11:15:12     INFO - PID 1062 |  => mFreeCount:           11639
[task 2020-04-02T11:15:12.794Z] 11:15:12     INFO - PID 1062 |  => mShareCount:           9721
[task 2020-04-02T11:15:12.794Z] 11:15:12     INFO - PID 1062 |  => mAdoptCount:            501
[task 2020-04-02T11:15:12.796Z] 11:15:12     INFO - PID 1062 |  => mAdoptFreeCount:        509
[task 2020-04-02T11:15:12.796Z] 11:15:12     INFO - PID 1062 |  => Process ID: 1479, Thread ID: 139811500193664
[task 2020-04-02T11:15:12.873Z] 11:15:12     INFO - PID 1062 | [Child 1218, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3352
[task 2020-04-02T11:15:12.888Z] 11:15:12     INFO - PID 1062 | nsStringStats
[task 2020-04-02T11:15:12.889Z] 11:15:12     INFO - PID 1062 |  => mAllocCount:          24406
[task 2020-04-02T11:15:12.889Z] 11:15:12     INFO - PID 1062 |  => mReallocCount:            0
[task 2020-04-02T11:15:12.889Z] 11:15:12     INFO - PID 1062 |  => mFreeCount:           24406
[task 2020-04-02T11:15:12.889Z] 11:15:12     INFO - PID 1062 |  => mShareCount:          11622
[task 2020-04-02T11:15:12.890Z] 11:15:12     INFO - PID 1062 |  => mAdoptCount:            447
[task 2020-04-02T11:15:12.890Z] 11:15:12     INFO - PID 1062 |  => mAdoptFreeCount:        479
[task 2020-04-02T11:15:12.890Z] 11:15:12     INFO - PID 1062 |  => Process ID: 1218, Thread ID: 140553800095616
[task 2020-04-02T11:15:12.926Z] 11:15:12     INFO - PID 1062 | [Child 1592, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3352
[task 2020-04-02T11:15:12.946Z] 11:15:12     INFO - PID 1062 | nsStringStats
[task 2020-04-02T11:15:12.947Z] 11:15:12     INFO - PID 1062 |  => mAllocCount:        2950627
[task 2020-04-02T11:15:12.948Z] 11:15:12     INFO - PID 1062 |  => mReallocCount:            0
[task 2020-04-02T11:15:12.949Z] 11:15:12     INFO - PID 1062 |  => mFreeCount:         2950627
[task 2020-04-02T11:15:12.949Z] 11:15:12     INFO - PID 1062 |  => mShareCount:        6254259
[task 2020-04-02T11:15:12.949Z] 11:15:12     INFO - PID 1062 |  => mAdoptCount:          14376
[task 2020-04-02T11:15:12.949Z] 11:15:12     INFO - PID 1062 |  => mAdoptFreeCount:      14388
[task 2020-04-02T11:15:12.950Z] 11:15:12     INFO - PID 1062 |  => Process ID: 1592, Thread ID: 139700403050368
[task 2020-04-02T11:15:13.107Z] 11:15:13     INFO - PID 1062 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-04-02T11:15:13.123Z] 11:15:13     INFO - PID 1062 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-04-02T11:15:13.179Z] 11:15:13     INFO - PID 1062 | nsStringStats
[task 2020-04-02T11:15:13.179Z] 11:15:13     INFO - PID 1062 |  => mAllocCount:           6940
[task 2020-04-02T11:15:13.179Z] 11:15:13     INFO - PID 1062 |  => mReallocCount:            0
[task 2020-04-02T11:15:13.179Z] 11:15:13     INFO - PID 1062 |  => mFreeCount:            6940
[task 2020-04-02T11:15:13.180Z] 11:15:13     INFO - PID 1062 |  => mShareCount:           3045
[task 2020-04-02T11:15:13.180Z] 11:15:13     INFO - PID 1062 |  => mAdoptCount:             72
[task 2020-04-02T11:15:13.180Z] 11:15:13     INFO - PID 1062 |  => mAdoptFreeCount:         72
[task 2020-04-02T11:15:13.180Z] 11:15:13     INFO - PID 1062 |  => Process ID: 1728, Thread ID: 139987998754688
[task 2020-04-02T11:15:13.180Z] 11:15:13     INFO - PID 1062 | [Parent 1062, Main Thread] WARNING: NS_ENSURE_SUCCESS_VOID(rv) failed with result 0x80070057: file /builds/worker/checkouts/gecko/extensions/permissions/nsPermissionManager.cpp, line 1663
[task 2020-04-02T11:15:13.382Z] 11:15:13     INFO - PID 1062 | [Child 1654, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3352
[task 2020-04-02T11:15:13.423Z] 11:15:13     INFO - PID 1062 | nsStringStats
[task 2020-04-02T11:15:13.423Z] 11:15:13     INFO - PID 1062 |  => mAllocCount:          12591
[task 2020-04-02T11:15:13.423Z] 11:15:13     INFO - PID 1062 |  => mReallocCount:            0
[task 2020-04-02T11:15:13.424Z] 11:15:13     INFO - PID 1062 |  => mFreeCount:           12591
[task 2020-04-02T11:15:13.424Z] 11:15:13     INFO - PID 1062 |  => mShareCount:          14141
[task 2020-04-02T11:15:13.424Z] 11:15:13     INFO - PID 1062 |  => mAdoptCount:            572
[task 2020-04-02T11:15:13.424Z] 11:15:13     INFO - PID 1062 |  => mAdoptFreeCount:        576
[task 2020-04-02T11:15:13.424Z] 11:15:13     INFO - PID 1062 |  => Process ID: 1654, Thread ID: 139641456260992
[task 2020-04-02T11:15:13.541Z] 11:15:13     INFO - PID 1062 | [Parent 1062, Main Thread] WARNING: NS_ENSURE_TRUE(mDB) failed: file /builds/worker/checkouts/gecko/netwerk/cache/nsDiskCacheDeviceSQL.cpp, line 1279
[task 2020-04-02T11:15:13.597Z] 11:15:13     INFO - PID 1062 | [Parent 1062, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/worker/checkouts/gecko/js/xpconnect/loader/mozJSComponentLoader.cpp, line 228
[task 2020-04-02T11:15:13.597Z] 11:15:13     INFO - PID 1062 | [Parent 1062, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/worker/checkouts/gecko/js/xpconnect/loader/mozJSComponentLoader.cpp, line 255
[task 2020-04-02T11:15:14.566Z] 11:15:14     INFO - PID 1062 | nsStringStats
[task 2020-04-02T11:15:14.566Z] 11:15:14     INFO - PID 1062 |  => mAllocCount:        1077468
[task 2020-04-02T11:15:14.567Z] 11:15:14     INFO - PID 1062 |  => mReallocCount:            0
[task 2020-04-02T11:15:14.567Z] 11:15:14     INFO - PID 1062 |  => mFreeCount:         1077468
[task 2020-04-02T11:15:14.568Z] 11:15:14     INFO - PID 1062 |  => mShareCount:         834804
[task 2020-04-02T11:15:14.568Z] 11:15:14     INFO - PID 1062 |  => mAdoptCount:          16321
[task 2020-04-02T11:15:14.569Z] 11:15:14     INFO - PID 1062 |  => mAdoptFreeCount:      16427
[task 2020-04-02T11:15:14.569Z] 11:15:14     INFO - PID 1062 |  => Process ID: 1062, Thread ID: 139944544651136
[task 2020-04-02T11:15:14.637Z] 11:15:14     INFO - Browser exited with return code 0
[task 2020-04-02T11:15:14.638Z] 11:15:14     INFO - PROCESS LEAKS /tmp/tmpzMnd2N/runtests_leaks_1002.log

This looks to be a regression of Bug 1626224.

James: can you please take a look at this bug?

Flags: needinfo?(james)
Regressed by: 1626224
Summary: Intermittent TEST-UNEXPECTED-TIMEOUT | /html/cross-origin-embedder-policy/cache-storage-reporting-shared-worker.https.html | expected CRASH → Intermittent TCw TEST-UNEXPECTED-TIMEOUT | /html/cross-origin-embedder-policy/cache-storage-reporting-shared-worker.https.html | expected CRASH
Summary: Intermittent TCw TEST-UNEXPECTED-TIMEOUT | /html/cross-origin-embedder-policy/cache-storage-reporting-shared-worker.https.html | expected CRASH → Intermittent TEST-UNEXPECTED-TIMEOUT | /html/cross-origin-embedder-policy/cache-storage-reporting-shared-worker.https.html | expected CRASH
Has Regression Range: --- → yes
Keywords: regression
Flags: needinfo?(james)
Component: DOM: Core & HTML → DOM: Workers
Priority: -- → P2

No failures in >21 days.

Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → DUPLICATE

(In reply to Valentin Gosu [:valentin] (he/him) from comment #8)

No failures in >21 days.

Resolution: DUPLICATE → INACTIVE
You need to log in before you can comment on or make changes to this bug.