Closed Bug 1626431 Opened 4 years ago Closed 4 years ago

Intermittent TEST-UNEXPECTED-TIMEOUT | /origin-policy/ids/two-ids.https.html | expected OK

Categories

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

Version 3
defect

Tracking

(firefox76 fixed)

RESOLVED FIXED
mozilla76
Tracking Status
firefox76 --- fixed

People

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

References

(Regression)

Details

(Keywords: intermittent-failure, Whiteboard: [retriggered], [wptsync upstream])

Attachments

(1 file)

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


[task 2020-03-31T21:33:44.678Z] 21:33:44 INFO - TEST-START | /origin-policy/ids/two-ids.https.html
[task 2020-03-31T21:33:44.685Z] 21:33:44 INFO - Closing window 40
[task 2020-03-31T21:33:44.756Z] 21:33:44 INFO - PID 3520 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-03-31T21:33:44.829Z] 21:33:44 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: '!mName', file /builds/worker/checkouts/gecko/editor/libeditor/EditAggregateTransaction.cpp, line 91
[task 2020-03-31T21:33:44.829Z] 21:33:44 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: EditAggregationTransaction::GetName() failed: 'NS_SUCCEEDED(rv)', file /builds/worker/checkouts/gecko/editor/libeditor/PlaceholderTransaction.cpp, line 217
[task 2020-03-31T21:33:44.829Z] 21:33:44 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: nsIAbsorbingTransaction::GetTxnName() failed, but ignored: 'NS_SUCCEEDED(rvIgnored)', file /builds/worker/checkouts/gecko/editor/libeditor/PlaceholderTransaction.cpp, line 188
[task 2020-03-31T21:33:44.864Z] 21:33:44 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: '!mName', file /builds/worker/checkouts/gecko/editor/libeditor/EditAggregateTransaction.cpp, line 91
[task 2020-03-31T21:33:44.864Z] 21:33:44 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: EditAggregationTransaction::GetName() failed: 'NS_SUCCEEDED(rv)', file /builds/worker/checkouts/gecko/editor/libeditor/PlaceholderTransaction.cpp, line 217
[task 2020-03-31T21:33:44.864Z] 21:33:44 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: nsIAbsorbingTransaction::GetTxnName() failed, but ignored: 'NS_SUCCEEDED(rvIgnored)', file /builds/worker/checkouts/gecko/editor/libeditor/PlaceholderTransaction.cpp, line 188
[task 2020-03-31T21:33:44.939Z] 21:33:44 INFO - PID 3520 | [Child 7700, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3352
[task 2020-03-31T21:33:44.974Z] 21:33:44 INFO - PID 3520 | nsStringStats
[task 2020-03-31T21:33:44.975Z] 21:33:44 INFO - PID 3520 | => mAllocCount: 7940
[task 2020-03-31T21:33:44.977Z] 21:33:44 INFO - PID 3520 | => mReallocCount: 0
[task 2020-03-31T21:33:44.977Z] 21:33:44 INFO - PID 3520 | => mFreeCount: 7940
[task 2020-03-31T21:33:44.977Z] 21:33:44 INFO - PID 3520 | => mShareCount: 6475
[task 2020-03-31T21:33:44.977Z] 21:33:44 INFO - PID 3520 | => mAdoptCount: 456
[task 2020-03-31T21:33:44.977Z] 21:33:44 INFO - PID 3520 | => mAdoptFreeCount: 460
[task 2020-03-31T21:33:44.977Z] 21:33:44 INFO - PID 3520 | => Process ID: 7700, Thread ID: 2228
[task 2020-03-31T21:33:44.977Z] 21:33:44 INFO - PID 3520 | [Child 5032, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/widget/windows/nsLookAndFeel.cpp, line 853
[task 2020-03-31T21:33:44.978Z] 21:33:44 INFO - PID 3520 | [Child 5032, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/checkouts/gecko/layout/base/nsPresContext.cpp, line 839
[task 2020-03-31T21:33:44.992Z] 21:33:44 INFO - PID 3520 | [Child 5032, Main Thread] WARNING: 'NS_FAILED(GetAccentColor(unused))', file /builds/worker/checkouts/gecko/widget/windows/nsLookAndFeel.cpp, line 481
[task 2020-03-31T21:33:45.171Z] 21:33:45 INFO - PID 3520 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to c:\users\task_1585687669\appdata\local\temp\tmptkdygo\runtests_leaks_5748_tab_pid1396.log
[task 2020-03-31T21:33:45.206Z] 21:33:45 INFO - PID 3520 | [Child 1396, Main Thread] WARNING: No CID found when attempting to map contract ID: file /builds/worker/checkouts/gecko/xpcom/components/nsComponentManager.cpp, line 721
[task 2020-03-31T21:33:45.221Z] 21:33:45 INFO - PID 3520 | [Child 5032, Main Thread] WARNING: '!aWin', file /builds/worker/checkouts/gecko/dom/base/Document.cpp, line 1397
[task 2020-03-31T21:33:45.221Z] 21:33:45 INFO - PID 3520 | [Child 5032, Main Thread] WARNING: '!aWin', file /builds/worker/checkouts/gecko/dom/base/Document.cpp, line 1397
[task 2020-03-31T21:33:45.322Z] 21:33:45 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: '!mName', file /builds/worker/checkouts/gecko/editor/libeditor/EditAggregateTransaction.cpp, line 91
[task 2020-03-31T21:33:45.323Z] 21:33:45 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: EditAggregationTransaction::GetName() failed: 'NS_SUCCEEDED(rv)', file /builds/worker/checkouts/gecko/editor/libeditor/PlaceholderTransaction.cpp, line 217
[task 2020-03-31T21:33:45.323Z] 21:33:45 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: nsIAbsorbingTransaction::GetTxnName() failed, but ignored: 'NS_SUCCEEDED(rvIgnored)', file /builds/worker/checkouts/gecko/editor/libeditor/PlaceholderTransaction.cpp, line 188
[task 2020-03-31T21:33:45.326Z] 21:33:45 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: '!mName', file /builds/worker/checkouts/gecko/editor/libeditor/EditAggregateTransaction.cpp, line 91
[task 2020-03-31T21:33:45.327Z] 21:33:45 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: EditAggregationTransaction::GetName() failed: 'NS_SUCCEEDED(rv)', file /builds/worker/checkouts/gecko/editor/libeditor/PlaceholderTransaction.cpp, line 217
[task 2020-03-31T21:33:45.330Z] 21:33:45 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: nsIAbsorbingTransaction::GetTxnName() failed, but ignored: 'NS_SUCCEEDED(rvIgnored)', file /builds/worker/checkouts/gecko/editor/libeditor/PlaceholderTransaction.cpp, line 188
[task 2020-03-31T21:33:45.365Z] 21:33:45 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: '!mName', file /builds/worker/checkouts/gecko/editor/libeditor/EditAggregateTransaction.cpp, line 91
[task 2020-03-31T21:33:45.365Z] 21:33:45 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: EditAggregationTransaction::GetName() failed: 'NS_SUCCEEDED(rv)', file /builds/worker/checkouts/gecko/editor/libeditor/PlaceholderTransaction.cpp, line 217
[task 2020-03-31T21:33:45.366Z] 21:33:45 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: nsIAbsorbingTransaction::GetTxnName() failed, but ignored: 'NS_SUCCEEDED(rvIgnored)', file /builds/worker/checkouts/gecko/editor/libeditor/PlaceholderTransaction.cpp, line 188
[task 2020-03-31T21:33:45.601Z] 21:33:45 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp, line 476
[task 2020-03-31T21:33:45.601Z] 21:33:45 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: Error sending reply: file /builds/worker/workspace/obj-build/ipc/ipdl/PContentParent.cpp, line 11402
[task 2020-03-31T21:33:45.700Z] 21:33:45 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp, line 476
[task 2020-03-31T21:33:45.700Z] 21:33:45 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: Error sending reply: file /builds/worker/workspace/obj-build/ipc/ipdl/PContentParent.cpp, line 11402
[task 2020-03-31T21:33:45.707Z] 21:33:45 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp, line 476
[task 2020-03-31T21:33:45.707Z] 21:33:45 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: Error sending reply: file /builds/worker/workspace/obj-build/ipc/ipdl/PContentParent.cpp, line 11402
[task 2020-03-31T21:33:46.986Z] 21:33:46 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: Not resolving response because actor is dead.: file /builds/worker/workspace/obj-build/ipc/ipdl/PContentParent.cpp, line 11377
[task 2020-03-31T21:33:47.061Z] 21:33:47 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: Not resolving response because actor is dead.: file /builds/worker/workspace/obj-build/ipc/ipdl/PContentParent.cpp, line 11377
[task 2020-03-31T21:33:47.068Z] 21:33:47 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: Not resolving response because actor is dead.: file /builds/worker/workspace/obj-build/ipc/ipdl/PContentParent.cpp, line 11377
[task 2020-03-31T21:33:48.249Z] 21:33:48 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: Not resolving response because actor is dead.: file /builds/worker/workspace/obj-build/ipc/ipdl/PContentParent.cpp, line 11377
[task 2020-03-31T21:33:48.324Z] 21:33:48 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: Not resolving response because actor is dead.: file /builds/worker/workspace/obj-build/ipc/ipdl/PContentParent.cpp, line 11377
[task 2020-03-31T21:33:48.331Z] 21:33:48 INFO - PID 3520 | [Parent 3244, Main Thread] WARNING: Not resolving response because actor is dead.: file /builds/worker/workspace/obj-build/ipc/ipdl/PContentParent.cpp, line 11377
[task 2020-03-31T21:34:15.480Z] 21:34:15 INFO - TEST-UNEXPECTED-TIMEOUT | /origin-policy/ids/two-ids.https.html | expected OK
[task 2020-03-31T21:34:15.480Z] 21:34:15 INFO - TEST-INFO took 30796ms
[task 2020-03-31T21:34:15.495Z] 21:34:15 INFO - PID 3520 | 1585690455477 Marionette INFO Stopped listening on port 55568
[task 2020-03-31T21:34:15.680Z] 21:34:15 INFO - PID 3520 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-03-31T21:34:15.839Z] 21:34:15 INFO - PID 3520 | [2020-03-31T21:34:15Z WARN xulstore::persist] tried to remove key that isn't in the store
[task 2020-03-31T21:34:15.839Z] 21:34:15 INFO - PID 3520 | [2020-03-31T21:34:15Z WARN xulstore::persist] tried to remove key that isn't in the store
[task 2020-03-31T21:34:15.854Z] 21:34:15 INFO - PID 3520 | [Child 5908, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3352
[task 2020-03-31T21:34:15.854Z] 21:34:15 INFO - PID 3520 | [Child 5032, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3352
[task 2020-03-31T21:34:15.855Z] 21:34:15 INFO - PID 3520 | [Child 7704, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3352
[task 2020-03-31T21:34:15.870Z] 21:34:15 INFO - PID 3520 | nsStringStats
[task 2020-03-31T21:34:15.871Z] 21:34:15 INFO - PID 3520 | => mAllocCount: 23897
[task 2020-03-31T21:34:15.871Z] 21:34:15 INFO - PID 3520 | => mReallocCount: 0
[task 2020-03-31T21:34:15.872Z] 21:34:15 INFO - PID 3520 | => mFreeCount: 23897
[task 2020-03-31T21:34:15.872Z] 21:34:15 INFO - PID 3520 | => mShareCount: 19543
[task 2020-03-31T21:34:15.872Z] 21:34:15 INFO - PID 3520 | => mAdoptCount: 458
[task 2020-03-31T21:34:15.873Z] 21:34:15 INFO - PID 3520 | => mAdoptFreeCount: 490
[task 2020-03-31T21:34:15.873Z] 21:34:15 INFO - PID 3520 | => Process ID: 5908, Thread ID: 5456
[task 2020-03-31T21:34:15.874Z] 21:34:15 INFO - PID 3520 | nsStringStats
[task 2020-03-31T21:34:15.874Z] 21:34:15 INFO - PID 3520 | => mAllocCount: 12653
[task 2020-03-31T21:34:15.875Z] 21:34:15 INFO - PID 3520 | => mReallocCount: 0
[task 2020-03-31T21:34:15.875Z] 21:34:15 INFO - PID 3520 | => mFreeCount: 12653
[task 2020-03-31T21:34:15.876Z] 21:34:15 INFO - PID 3520 | => mShareCount: 23020
[task 2020-03-31T21:34:15.876Z] 21:34:15 INFO - PID 3520 | => mAdoptCount: 539
[task 2020-03-31T21:34:15.876Z] 21:34:15 INFO - PID 3520 | => mAdoptFreeCount: 555
[task 2020-03-31T21:34:15.877Z] 21:34:15 INFO - PID 3520 | => Process ID: 7704, Thread ID: 6640
[task 2020-03-31T21:34:15.877Z] 21:34:15 INFO - PID 3520 | nsStringStats
[task 2020-03-31T21:34:15.878Z] 21:34:15 INFO - PID 3520 | => mAllocCount: 16929
[task 2020-03-31T21:34:15.878Z] 21:34:15 INFO - PID 3520 | => mReallocCount: 0
[task 2020-03-31T21:34:15.879Z] 21:34:15 INFO - PID 3520 | => mFreeCount: 16929
[task 2020-03-31T21:34:15.879Z] 21:34:15 INFO - PID 3520 | => mShareCount: 35300
[task 2020-03-31T21:34:15.880Z] 21:34:15 INFO - PID 3520 | => mAdoptCount: 612
[task 2020-03-31T21:34:15.880Z] 21:34:15 INFO - PID 3520 | => mAdoptFreeCount: 622
[task 2020-03-31T21:34:15.880Z] 21:34:15 INFO - PID 3520 | => Process ID: 5032, Thread ID: 7796
[task 2020-03-31T21:34:16.167Z] 21:34:16 INFO - PID 3520 | [Parent 3244, Gecko_IOThread] WARNING: file /builds/worker/checkouts/gecko/ipc/chromium/src/base/process_util_win.cc, line 166
[task 2020-03-31T21:34:16.182Z] 21:34:16 INFO - PID 3520 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-03-31T21:34:16.197Z] 21:34:16 INFO - PID 3520 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-03-31T21:34:16.236Z] 21:34:16 INFO - PID 3520 | nsStringStats
[task 2020-03-31T21:34:16.236Z] 21:34:16 INFO - PID 3520 | => mAllocCount: 6216
[task 2020-03-31T21:34:16.236Z] 21:34:16 INFO - PID 3520 | => mReallocCount: 0
[task 2020-03-31T21:34:16.236Z] 21:34:16 INFO - PID 3520 | => mFreeCount: 6216
[task 2020-03-31T21:34:16.236Z] 21:34:16 INFO - PID 3520 | => mShareCount: 9692
[task 2020-03-31T21:34:16.237Z] 21:34:16 INFO - PID 3520 | => mAdoptCount: 72
[task 2020-03-31T21:34:16.237Z] 21:34:16 INFO - PID 3520 | => mAdoptFreeCount: 72
[task 2020-03-31T21:34:16.237Z] 21:34:16 INFO - PID 3520 | => Process ID: 1396, Thread ID: 7420
[task 2020-03-31T21:34:16.252Z] 21:34:16 INFO - PID 3520 | [Parent 3244, 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-03-31T21:34:16.387Z] 21:34:16 INFO - PID 3520 | [Child 3620, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3352

Flags: needinfo?(james)
Regressed by: 1625577
Whiteboard: [stockwell retriggerd]
Assignee: nobody → james
Status: NEW → ASSIGNED
Flags: needinfo?(james)
Pushed by james@hoppipolla.co.uk:
https://hg.mozilla.org/integration/autoland/rev/6d556deeb0a5
Try adding long timeout to origin-policy test that times out, r=annevk
Created web-platform-tests PR https://github.com/web-platform-tests/wpt/pull/22644 for changes under testing/web-platform/tests
Whiteboard: [stockwell retriggerd] → [stockwell retriggerd], [wptsync upstream]
Upstream web-platform-tests status checks passed, PR will merge once commit reaches central.
Whiteboard: [stockwell retriggerd], [wptsync upstream] → [retriggerd], [wptsync upstream]
Whiteboard: [retriggerd], [wptsync upstream] → [retriggered], [wptsync upstream]
Regressions: 1627000
Status: ASSIGNED → RESOLVED
Closed: 4 years ago
Resolution: --- → FIXED
Target Milestone: --- → mozilla76
Upstream PR merged by moz-wptsync-bot
Regressions: 1626409
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: