ubuntu1804 - /uievents/click/click_events_on_input.html | assertion count 4 is more than expected 0 assertions
Categories
(Core :: DOM: Events, defect, P5)
Tracking
()
Tracking | Status | |
---|---|---|
firefox73 | --- | fixed |
People
(Reporter: intermittent-bug-filer, Assigned: egao)
References
(Blocks 1 open bug)
Details
Attachments
(1 file)
Filed by: egao [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=281834418&repo=try
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/W9eM2lWmQcaWFcEIMLVLXA/runs/0/artifacts/public/logs/live_backing.log
suite: web-platform-tests
chunk: 8
notes: debug
context:
[task 2019-12-19T02:19:50.021Z] 02:19:50 INFO - TEST-START | /uievents/click/click_events_on_input.html
[task 2019-12-19T02:19:50.022Z] 02:19:50 INFO - Closing window 29
[task 2019-12-19T02:19:50.099Z] 02:19:50 INFO - PID 19881 | [Child 20141, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/workspace/build/src/ipc/glue/ProtocolUtils.cpp, line 481
[task 2019-12-19T02:19:50.115Z] 02:19:50 INFO - PID 19881 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2019-12-19T02:19:50.155Z] 02:19:50 INFO - PID 19881 | [Child 20183, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/workspace/build/src/layout/base/nsPresContext.cpp, line 848
[task 2019-12-19T02:19:50.345Z] 02:19:50 INFO - PID 19881 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmp7ZX_wb.mozrunner/runtests_leaks_1006_tab_pid20217.log
[task 2019-12-19T02:19:50.393Z] 02:19:50 INFO - PID 19881 | [Child 20141, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/workspace/build/src/xpcom/base/nsCycleCollector.cpp, line 3361
[task 2019-12-19T02:19:50.409Z] 02:19:50 INFO - PID 19881 | [Child 20217, Main Thread] WARNING: No CID found when attempting to map contract ID: file /builds/worker/workspace/build/src/xpcom/components/nsComponentManager.cpp, line 727
[task 2019-12-19T02:19:50.429Z] 02:19:50 INFO - PID 19881 | nsStringStats
[task 2019-12-19T02:19:50.429Z] 02:19:50 INFO - PID 19881 | => mAllocCount: 9298
[task 2019-12-19T02:19:50.429Z] 02:19:50 INFO - PID 19881 | => mReallocCount: 0
[task 2019-12-19T02:19:50.430Z] 02:19:50 INFO - PID 19881 | => mFreeCount: 9298
[task 2019-12-19T02:19:50.430Z] 02:19:50 INFO - PID 19881 | => mShareCount: 9784
[task 2019-12-19T02:19:50.430Z] 02:19:50 INFO - PID 19881 | => mAdoptCount: 470
[task 2019-12-19T02:19:50.431Z] 02:19:50 INFO - PID 19881 | => mAdoptFreeCount: 474
[task 2019-12-19T02:19:50.432Z] 02:19:50 INFO - PID 19881 | => Process ID: 20141, Thread ID: 140531848939392
[task 2019-12-19T02:19:50.529Z] 02:19:50 INFO - PID 19881 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2019-12-19T02:19:50.645Z] 02:19:50 INFO - PID 19881 | [Child 20217, Main Thread] WARNING: could not set real-time limit at process startup: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 1819
[task 2019-12-19T02:19:50.782Z] 02:19:50 INFO - PID 19881 | [Parent 19881, Main Thread] WARNING: we only accept nsIURI interface type, patch welcome: file /builds/worker/workspace/build/src/dom/ipc/PropertyBagUtils.cpp, line 112
[task 2019-12-19T02:19:50.782Z] 02:19:50 INFO - PID 19881 | [Child 20183, Main Thread] WARNING: Trying to request nsIHttpChannel from DocumentChannelChild, this is likely broken: file /builds/worker/workspace/build/src/netwerk/ipc/DocumentChannelChild.cpp, line 63
[task 2019-12-19T02:19:51.104Z] 02:19:51 INFO - {'actions': [{u'type': u'none', u'id': u'0', u'actions': [{u'duration': 16, u'type': u'pause'}, {u'duration': 16, u'type': u'pause'}, {u'duration': 16, u'type': u'pause'}]}, {u'type': u'pointer', u'actions': [{u'y': 17, u'x': 48, u'frame': {u'frame': u'window'}, u'type': u'pointerMove', u'origin': {'element-6066-11e4-a52e-4f735466cecf': u'09d54816-f898-4f48-907d-6d6f2d48ae02', 'chromeelement-9fc5-4b51-a3c8-01716eedeb04': u'09d54816-f898-4f48-907d-6d6f2d48ae02'}}, {u'button': 0, u'type': u'pointerDown'}, {u'button': 0, u'type': u'pointerUp'}], u'parameters': {u'pointerType': u'mouse'}, u'id': u'1'}]}
[task 2019-12-19T02:19:51.145Z] 02:19:51 INFO - PID 19881 | 1576721991137 Marionette WARN TimedPromise timed out after 16 ms: stacktrace:
[task 2019-12-19T02:19:51.145Z] 02:19:51 INFO - PID 19881 | bail@chrome://marionette/content/sync.js:237:64
[task 2019-12-19T02:19:51.161Z] 02:19:51 INFO - PID 19881 | [Child 20183, Main Thread] ###!!! ASSERTION: Unexpected document: 'aCapturingContent->GetComposedDoc() == GetDocument()', file /builds/worker/workspace/build/src/layout/base/PresShell.cpp, line 7335
[task 2019-12-19T02:19:51.161Z] 02:19:51 INFO - PID 19881 | [Child 20183, Main Thread] ###!!! ASSERTION: Unexpected document: 'capturingContent->GetComposedDoc() == GetDocument()', file /builds/worker/workspace/build/src/layout/base/PresShell.cpp, line 6623
[task 2019-12-19T02:19:51.162Z] 02:19:51 INFO - PID 19881 | 1576721991161 Marionette WARN TimedPromise timed out after 16 ms: stacktrace:
[task 2019-12-19T02:19:51.164Z] 02:19:51 INFO - PID 19881 | bail@chrome://marionette/content/sync.js:237:64
[task 2019-12-19T02:19:51.165Z] 02:19:51 INFO - PID 19881 | [Child 20183, Main Thread] ###!!! ASSERTION: Unexpected document: 'aCapturingContent->GetComposedDoc() == GetDocument()', file /builds/worker/workspace/build/src/layout/base/PresShell.cpp, line 7335
[task 2019-12-19T02:19:51.165Z] 02:19:51 INFO - PID 19881 | [Child 20183, Main Thread] ###!!! ASSERTION: Unexpected document: 'capturingContent->GetComposedDoc() == GetDocument()', file /builds/worker/workspace/build/src/layout/base/PresShell.cpp, line 6623
[task 2019-12-19T02:19:51.181Z] 02:19:51 INFO - PID 19881 | 1576721991178 Marionette WARN TimedPromise timed out after 16 ms: stacktrace:
[task 2019-12-19T02:19:51.181Z] 02:19:51 INFO - PID 19881 | bail@chrome://marionette/content/sync.js:237:64
[task 2019-12-19T02:19:51.239Z] 02:19:51 INFO - {'actions': [{u'type': u'none', u'id': u'2', u'actions': [{u'duration': 16, u'type': u'pause'}, {u'duration': 16, u'type': u'pause'}, {u'duration': 16, u'type': u'pause'}]}, {u'type': u'pointer', u'actions': [{u'y': 17, u'x': 48, u'frame': {u'frame': u'window'}, u'type': u'pointerMove', u'origin': {'element-6066-11e4-a52e-4f735466cecf': u'09d54816-f898-4f48-907d-6d6f2d48ae02', 'chromeelement-9fc5-4b51-a3c8-01716eedeb04': u'09d54816-f898-4f48-907d-6d6f2d48ae02'}}, {u'button': 1, u'type': u'pointerDown'}, {u'button': 1, u'type': u'pointerUp'}], u'parameters': {u'pointerType': u'mouse'}, u'id': u'3'}]}
[task 2019-12-19T02:19:51.280Z] 02:19:51 INFO - PID 19881 | 1576721991270 Marionette WARN TimedPromise timed out after 16 ms: stacktrace:
[task 2019-12-19T02:19:51.280Z] 02:19:51 INFO - PID 19881 | bail@chrome://marionette/content/sync.js:237:64
[task 2019-12-19T02:19:51.296Z] 02:19:51 INFO - PID 19881 | 1576721991291 Marionette WARN TimedPromise timed out after 16 ms: stacktrace:
[task 2019-12-19T02:19:51.296Z] 02:19:51 INFO - PID 19881 | bail@chrome://marionette/content/sync.js:237:64
[task 2019-12-19T02:19:51.316Z] 02:19:51 INFO - PID 19881 | 1576721991309 Marionette WARN TimedPromise timed out after 16 ms: stacktrace:
[task 2019-12-19T02:19:51.317Z] 02:19:51 INFO - PID 19881 | bail@chrome://marionette/content/sync.js:237:64
[task 2019-12-19T02:19:51.367Z] 02:19:51 INFO - {'actions': [{u'type': u'none', u'id': u'4', u'actions': [{u'duration': 16, u'type': u'pause'}, {u'duration': 16, u'type': u'pause'}, {u'duration': 16, u'type': u'pause'}]}, {u'type': u'pointer', u'actions': [{u'y': 17, u'x': 48, u'frame': {u'frame': u'window'}, u'type': u'pointerMove', u'origin': {'element-6066-11e4-a52e-4f735466cecf': u'09d54816-f898-4f48-907d-6d6f2d48ae02', 'chromeelement-9fc5-4b51-a3c8-01716eedeb04': u'09d54816-f898-4f48-907d-6d6f2d48ae02'}}, {u'button': 2, u'type': u'pointerDown'}, {u'button': 2, u'type': u'pointerUp'}], u'parameters': {u'pointerType': u'mouse'}, u'id': u'5'}]}
[task 2019-12-19T02:19:51.404Z] 02:19:51 INFO - PID 19881 | 1576721991396 Marionette WARN TimedPromise timed out after 16 ms: stacktrace:
[task 2019-12-19T02:19:51.404Z] 02:19:51 INFO - PID 19881 | bail@chrome://marionette/content/sync.js:237:64
[task 2019-12-19T02:19:51.427Z] 02:19:51 INFO - PID 19881 | 1576721991422 Marionette WARN TimedPromise timed out after 16 ms: stacktrace:
[task 2019-12-19T02:19:51.427Z] 02:19:51 INFO - PID 19881 | bail@chrome://marionette/content/sync.js:237:64
[task 2019-12-19T02:19:51.443Z] 02:19:51 INFO - PID 19881 | 1576721991439 Marionette WARN TimedPromise timed out after 16 ms: stacktrace:
[task 2019-12-19T02:19:51.443Z] 02:19:51 INFO - PID 19881 | bail@chrome://marionette/content/sync.js:237:64
[task 2019-12-19T02:19:51.520Z] 02:19:51 INFO - Got content assert count 4
[task 2019-12-19T02:19:51.521Z] 02:19:51 INFO - TEST-UNEXPECTED-FAIL | /uievents/click/click_events_on_input.html | assertion count 4 is more than expected 0 assertions
[task 2019-12-19T02:19:51.521Z] 02:19:51 INFO - .
[task 2019-12-19T02:19:51.521Z] 02:19:51 INFO - TEST-OK | /uievents/click/click_events_on_input.html | took 1501ms
Assignee | ||
Comment 1•5 years ago
|
||
Assignee | ||
Comment 2•5 years ago
•
|
||
:smaug - this is a new permafailing test observed on linux64 debug builds when run with ubuntu1804 test image (instead of the current ubuntu1604 image).
I'm working on migrating the test image to ubuntu1804, and the expected migration date is end of December 2019. I understand it is end of year, but would you have bandwidth to take a look at this?
Alternatively, I can mark this as a permafail on ubuntu1804 debug builds for the time being.
Assignee | ||
Comment 3•5 years ago
|
||
I had a push where I tried marking the test as expecting a failure, in case I was asked to annotate - but then this happens:
[task 2019-12-19T22:16:19.393Z] 22:16:19 INFO - TEST-START | /uievents/click/click_events_on_input.html
[task 2019-12-19T22:16:19.398Z] 22:16:19 INFO - Closing window 29
[task 2019-12-19T22:16:19.487Z] 22:16:19 INFO - PID 20242 | [Child 20502, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/workspace/build/src/ipc/glue/ProtocolUtils.cpp, line 481
[task 2019-12-19T22:16:19.543Z] 22:16:19 INFO - PID 20242 | [Child 20538, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/workspace/build/src/layout/base/nsPresContext.cpp, line 848
[task 2019-12-19T22:16:19.727Z] 22:16:19 INFO - PID 20242 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpWbde1z.mozrunner/runtests_leaks_1009_tab_pid20578.log
[task 2019-12-19T22:16:19.734Z] 22:16:19 INFO - PID 20242 | [Child 20502, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/workspace/build/src/xpcom/base/nsCycleCollector.cpp, line 3361
[task 2019-12-19T22:16:19.770Z] 22:16:19 INFO - PID 20242 | nsStringStats
[task 2019-12-19T22:16:19.770Z] 22:16:19 INFO - PID 20242 | => mAllocCount: 9297
[task 2019-12-19T22:16:19.771Z] 22:16:19 INFO - PID 20242 | => mReallocCount: 0
[task 2019-12-19T22:16:19.771Z] 22:16:19 INFO - PID 20242 | => mFreeCount: 9297
[task 2019-12-19T22:16:19.771Z] 22:16:19 INFO - PID 20242 | => mShareCount: 9786
[task 2019-12-19T22:16:19.771Z] 22:16:19 INFO - PID 20242 | => mAdoptCount: 470
[task 2019-12-19T22:16:19.771Z] 22:16:19 INFO - PID 20242 | => mAdoptFreeCount: 474
[task 2019-12-19T22:16:19.772Z] 22:16:19 INFO - PID 20242 | => Process ID: 20502, Thread ID: 140458296133504
[task 2019-12-19T22:16:19.799Z] 22:16:19 INFO - PID 20242 | [Child 20578, Main Thread] WARNING: No CID found when attempting to map contract ID: file /builds/worker/workspace/build/src/xpcom/components/nsComponentManager.cpp, line 727
[task 2019-12-19T22:16:19.908Z] 22:16:19 INFO - PID 20242 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2019-12-19T22:16:20.025Z] 22:16:20 INFO - PID 20242 | [Child 20578, Main Thread] WARNING: could not set real-time limit at process startup: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 1819
[task 2019-12-19T22:16:20.203Z] 22:16:20 INFO - PID 20242 | [Parent 20242, Main Thread] WARNING: we only accept nsIURI interface type, patch welcome: file /builds/worker/workspace/build/src/dom/ipc/PropertyBagUtils.cpp, line 112
[task 2019-12-19T22:16:20.203Z] 22:16:20 INFO - PID 20242 | [Child 20538, Main Thread] WARNING: Trying to request nsIHttpChannel from DocumentChannelChild, this is likely broken: file /builds/worker/workspace/build/src/netwerk/ipc/DocumentChannelChild.cpp, line 63
[task 2019-12-19T22:16:20.570Z] 22:16:20 INFO - {'actions': [{u'type': u'none', u'id': u'0', u'actions': [{u'duration': 16, u'type': u'pause'}, {u'duration': 16, u'type': u'pause'}, {u'duration': 16, u'type': u'pause'}]}, {u'type': u'pointer', u'actions': [{u'y': 17, u'x': 48, u'frame': {u'frame': u'window'}, u'type': u'pointerMove', u'origin': {'element-6066-11e4-a52e-4f735466cecf': u'1fcb69f0-f481-4c13-bba2-14e8e0724300', 'chromeelement-9fc5-4b51-a3c8-01716eedeb04': u'1fcb69f0-f481-4c13-bba2-14e8e0724300'}}, {u'button': 0, u'type': u'pointerDown'}, {u'button': 0, u'type': u'pointerUp'}], u'parameters': {u'pointerType': u'mouse'}, u'id': u'1'}]}
[task 2019-12-19T22:16:20.606Z] 22:16:20 INFO - PID 20242 | 1576793780601 Marionette WARN TimedPromise timed out after 16 ms: stacktrace:
[task 2019-12-19T22:16:20.606Z] 22:16:20 INFO - PID 20242 | bail@chrome://marionette/content/sync.js:237:64
[task 2019-12-19T22:16:20.622Z] 22:16:20 INFO - PID 20242 | [Child 20538, Main Thread] ###!!! ASSERTION: Unexpected document: 'aCapturingContent->GetComposedDoc() == GetDocument()', file /builds/worker/workspace/build/src/layout/base/PresShell.cpp, line 7335
[task 2019-12-19T22:16:20.622Z] 22:16:20 INFO - PID 20242 | [Child 20538, Main Thread] ###!!! ASSERTION: Unexpected document: 'capturingContent->GetComposedDoc() == GetDocument()', file /builds/worker/workspace/build/src/layout/base/PresShell.cpp, line 6623
[task 2019-12-19T22:16:20.630Z] 22:16:20 INFO - PID 20242 | 1576793780625 Marionette WARN TimedPromise timed out after 16 ms: stacktrace:
[task 2019-12-19T22:16:20.631Z] 22:16:20 INFO - PID 20242 | bail@chrome://marionette/content/sync.js:237:64
[task 2019-12-19T22:16:20.631Z] 22:16:20 INFO - PID 20242 | [Child 20538, Main Thread] ###!!! ASSERTION: Unexpected document: 'aCapturingContent->GetComposedDoc() == GetDocument()', file /builds/worker/workspace/build/src/layout/base/PresShell.cpp, line 7335
[task 2019-12-19T22:16:20.632Z] 22:16:20 INFO - PID 20242 | [Child 20538, Main Thread] ###!!! ASSERTION: Unexpected document: 'capturingContent->GetComposedDoc() == GetDocument()', file /builds/worker/workspace/build/src/layout/base/PresShell.cpp, line 6623
[task 2019-12-19T22:16:20.648Z] 22:16:20 INFO - PID 20242 | 1576793780643 Marionette WARN TimedPromise timed out after 16 ms: stacktrace:
[task 2019-12-19T22:16:20.648Z] 22:16:20 INFO - PID 20242 | bail@chrome://marionette/content/sync.js:237:64
[task 2019-12-19T22:16:20.712Z] 22:16:20 INFO - {'actions': [{u'type': u'none', u'id': u'2', u'actions': [{u'duration': 16, u'type': u'pause'}, {u'duration': 16, u'type': u'pause'}, {u'duration': 16, u'type': u'pause'}]}, {u'type': u'pointer', u'actions': [{u'y': 17, u'x': 48, u'frame': {u'frame': u'window'}, u'type': u'pointerMove', u'origin': {'element-6066-11e4-a52e-4f735466cecf': u'1fcb69f0-f481-4c13-bba2-14e8e0724300', 'chromeelement-9fc5-4b51-a3c8-01716eedeb04': u'1fcb69f0-f481-4c13-bba2-14e8e0724300'}}, {u'button': 1, u'type': u'pointerDown'}, {u'button': 1, u'type': u'pointerUp'}], u'parameters': {u'pointerType': u'mouse'}, u'id': u'3'}]}
[task 2019-12-19T22:16:20.748Z] 22:16:20 INFO - PID 20242 | 1576793780742 Marionette WARN TimedPromise timed out after 16 ms: stacktrace:
[task 2019-12-19T22:16:20.749Z] 22:16:20 INFO - PID 20242 | bail@chrome://marionette/content/sync.js:237:64
[task 2019-12-19T22:16:20.769Z] 22:16:20 INFO - PID 20242 | 1576793780766 Marionette WARN TimedPromise timed out after 16 ms: stacktrace:
[task 2019-12-19T22:16:20.769Z] 22:16:20 INFO - PID 20242 | bail@chrome://marionette/content/sync.js:237:64
[task 2019-12-19T22:16:20.790Z] 22:16:20 INFO - PID 20242 | 1576793780783 Marionette WARN TimedPromise timed out after 16 ms: stacktrace:
[task 2019-12-19T22:16:20.790Z] 22:16:20 INFO - PID 20242 | bail@chrome://marionette/content/sync.js:237:64
[task 2019-12-19T22:16:20.847Z] 22:16:20 INFO - {'actions': [{u'type': u'none', u'id': u'4', u'actions': [{u'duration': 16, u'type': u'pause'}, {u'duration': 16, u'type': u'pause'}, {u'duration': 16, u'type': u'pause'}]}, {u'type': u'pointer', u'actions': [{u'y': 17, u'x': 48, u'frame': {u'frame': u'window'}, u'type': u'pointerMove', u'origin': {'element-6066-11e4-a52e-4f735466cecf': u'1fcb69f0-f481-4c13-bba2-14e8e0724300', 'chromeelement-9fc5-4b51-a3c8-01716eedeb04': u'1fcb69f0-f481-4c13-bba2-14e8e0724300'}}, {u'button': 2, u'type': u'pointerDown'}, {u'button': 2, u'type': u'pointerUp'}], u'parameters': {u'pointerType': u'mouse'}, u'id': u'5'}]}
[task 2019-12-19T22:16:20.887Z] 22:16:20 INFO - PID 20242 | 1576793780876 Marionette WARN TimedPromise timed out after 16 ms: stacktrace:
[task 2019-12-19T22:16:20.887Z] 22:16:20 INFO - PID 20242 | bail@chrome://marionette/content/sync.js:237:64
[task 2019-12-19T22:16:20.908Z] 22:16:20 INFO - PID 20242 | 1576793780904 Marionette WARN TimedPromise timed out after 16 ms: stacktrace:
[task 2019-12-19T22:16:20.908Z] 22:16:20 INFO - PID 20242 | bail@chrome://marionette/content/sync.js:237:64
[task 2019-12-19T22:16:20.928Z] 22:16:20 INFO - PID 20242 | 1576793780921 Marionette WARN TimedPromise timed out after 16 ms: stacktrace:
[task 2019-12-19T22:16:20.929Z] 22:16:20 INFO - PID 20242 | bail@chrome://marionette/content/sync.js:237:64
[task 2019-12-19T22:16:20.993Z] 22:16:20 INFO - Got content assert count 4
[task 2019-12-19T22:16:20.995Z] 22:16:20 INFO - TEST-UNEXPECTED-FAIL | /uievents/click/click_events_on_input.html | assertion count 4 is more than expected 0 assertions
[task 2019-12-19T22:16:20.995Z] 22:16:20 INFO - TEST-UNEXPECTED-OK | /uievents/click/click_events_on_input.html | expected FAIL
[task 2019-12-19T22:16:20.995Z] 22:16:20 INFO - TEST-INFO expected FAIL | took 1602ms
Notice that this test produced both unexpected-ok and unexpected-fail for some reason.
Comment 4•5 years ago
|
||
Looks like this isn't trivial enough to fix right now.
We have a native anonymous content as capturing content, but that node has been removed from document already.
Need to go through some code.
Disabling on debug build is fine. Even better would be if there was some annotation to tell that (non-fatal) assertions are ok.
Comment 5•5 years ago
|
||
Can you disable the test on debug, not just mark it failing?
Or mark it intermittent?
Assignee | ||
Comment 6•5 years ago
|
||
I can do that (disable on debug), and will leave a comment directing to this bug. I will also mark this bug as leave-open for the investigation.
Updated•5 years ago
|
Comment 8•5 years ago
|
||
bugherder |
Comment hidden (Intermittent Failures Robot) |
Description
•