1674025 - Perma fission TEST-UNEXPECTED-FAIL | /infrastructure/testdriver/actions/crossOrigin.sub.html | Actions in cross-origin iframe - uncaught exception: Error: assert_unreached: actions failed Reached unreachable code

Status: RESOLVED WORKSFORME

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

Description

[Treeherder Bug Filer]

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

---

[task 2020-10-28T22:50:56.953Z] 22:50:56     INFO - TEST-OK | /infrastructure/testdriver/actions/actionsWithKeyPressed.html | took 959ms
[task 2020-10-28T22:50:56.954Z] 22:50:56     INFO - TEST-START | /infrastructure/testdriver/actions/crossOrigin.sub.html
[task 2020-10-28T22:50:56.957Z] 22:50:56     INFO - Closing window 6442450945
[task 2020-10-28T22:50:57.068Z] 22:50:57     INFO - PID 29883 | [Parent 29883, Main Thread] WARNING: Not implemented in the parent process!: file /builds/worker/checkouts/gecko/docshell/shistory/SessionHistoryEntry.cpp:503
[task 2020-10-28T22:50:57.760Z] 22:50:57     INFO - PID 29883 | [Child 30120, Main Thread] WARNING: NS_ENSURE_TRUE(currentInner) failed: file /builds/worker/checkouts/gecko/dom/base/WindowDestroyedEvent.cpp:106
[task 2020-10-28T22:50:57.816Z] 22:50:57     INFO - PID 29883 | [30499, Unnamed thread 7ff25fc5f5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:202
[task 2020-10-28T22:50:57.817Z] 22:50:57     INFO - PID 29883 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpBBRc68/runtests_leaks_1128.log
[task 2020-10-28T22:50:57.818Z] 22:50:57     INFO - PID 29883 | [30499, Unnamed thread 7ff25fc5f5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:202
[task 2020-10-28T22:50:57.819Z] 22:50:57     INFO - PID 29883 | [30499, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:251
[task 2020-10-28T22:50:57.978Z] 22:50:57     INFO - PID 29883 | [Child 30499, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:628
[task 2020-10-28T22:50:58.239Z] 22:50:58     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': 0, u'x': 0, u'type': u'pointerMove', u'origin': {'element-6066-11e4-a52e-4f735466cecf': u'423e26a3-9db2-4630-b620-8952d2fd0845', 'chromeelement-9fc5-4b51-a3c8-01716eedeb04': u'423e26a3-9db2-4630-b620-8952d2fd0845'}}, {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 2020-10-28T22:50:58.349Z] 22:50:58     INFO - PID 29883 | [Parent 29883, Main Thread] WARNING: '!mLastFocusedWindow', file /builds/worker/checkouts/gecko/widget/gtk/IMContextWrapper.cpp:3110
[task 2020-10-28T22:50:59.165Z] 22:50:59     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'duration': 16, u'type': u'pause'}, {u'duration': 16, u'type': u'pause'}, {u'duration': 16, u'type': u'pause'}, {u'duration': 16, u'type': u'pause'}, {u'duration': 16, u'type': u'pause'}]}, {u'type': u'key', u'id': u'3', u'actions': [{u'type': u'keyDown', u'value': u'P'}, {u'type': u'keyUp', u'value': u'P'}, {u'type': u'keyDown', u'value': u'A'}, {u'type': u'keyUp', u'value': u'A'}, {u'type': u'keyDown', u'value': u'S'}, {u'type': u'keyUp', u'value': u'S'}, {u'type': u'keyDown', u'value': u'S'}, {u'type': u'keyUp', u'value': u'S'}]}]}
[task 2020-10-28T22:50:59.200Z] 22:50:59     INFO - PID 29883 | [Child 30120, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp:348
[task 2020-10-28T22:50:59.200Z] 22:50:59     INFO - PID 29883 | [Child 30120, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp:348
[task 2020-10-28T22:50:59.332Z] 22:50:59     INFO - PID 29883 | JavaScript error: http://web-platform.test:8000/resources/testharness.js, line 3603: uncaught exception: Error: assert_unreached: actions failed Reached unreachable code
[task 2020-10-28T22:50:59.396Z] 22:50:59     INFO - 
[task 2020-10-28T22:50:59.396Z] 22:50:59     INFO - TEST-UNEXPECTED-FAIL | /infrastructure/testdriver/actions/crossOrigin.sub.html | Actions in cross-origin iframe - uncaught exception: Error: assert_unreached: actions failed Reached unreachable code
[task 2020-10-28T22:50:59.396Z] 22:50:59     INFO - @http://web-platform.test:8000/infrastructure/testdriver/actions/crossOrigin.sub.html:17:25
[task 2020-10-28T22:50:59.396Z] 22:50:59     INFO - TEST-UNEXPECTED-OK | /infrastructure/testdriver/actions/crossOrigin.sub.html | expected TIMEOUT
[task 2020-10-28T22:50:59.396Z] 22:50:59     INFO - TEST-INFO expected TIMEOUT | took 2444ms
[task 2020-10-28T22:50:59.412Z] 22:50:59     INFO - PID 29883 | 1603925459410	Marionette	INFO	Stopped listening on port 35733
[task 2020-10-28T22:50:59.468Z] 22:50:59     INFO - PID 29883 | [Child 30068, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:41
[task 2020-10-28T22:50:59.469Z] 22:50:59     INFO - PID 29883 | [Child 30068, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:41
[task 2020-10-28T22:50:59.489Z] 22:50:59     INFO - PID 29883 | [Child 30068, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:41
[task 2020-10-28T22:50:59.489Z] 22:50:59     INFO - PID 29883 | [Child 30068, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:41
[task 2020-10-28T22:50:59.492Z] 22:50:59     INFO - PID 29883 | [Child 30068, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:41
[task 2020-10-28T22:50:59.517Z] 22:50:59     INFO - PID 29883 | [Parent 29883, Main Thread] WARNING: Not implemented in the parent process!: file /builds/worker/checkouts/gecko/docshell/shistory/SessionHistoryEntry.cpp:503
[task 2020-10-28T22:50:59.518Z] 22:50:59     INFO - PID 29883 | [Parent 29883, Main Thread] WARNING: Not implemented in the parent process!: file /builds/worker/checkouts/gecko/docshell/shistory/SessionHistoryEntry.cpp:503
[task 2020-10-28T22:50:59.521Z] 22:50:59     INFO - PID 29883 | [Parent 29883, Main Thread] WARNING: Not implemented in the parent process!: file /builds/worker/checkouts/gecko/docshell/shistory/SessionHistoryEntry.cpp:503
[task 2020-10-28T22:50:59.638Z] 22:50:59     INFO - PID 29883 | [Parent 29883, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:370
[task 2020-10-28T22:50:59.694Z] 22:50:59     INFO - PID 29883 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-10-28T22:50:59.694Z] 22:50:59     INFO - PID 29883 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-10-28T22:50:59.701Z] 22:50:59     INFO - PID 29883 | [Child 30120, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:511
[task 2020-10-28T22:50:59.702Z] 22:50:59     INFO - PID 29883 | [Child 30120, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:511
[task 2020-10-28T22:50:59.705Z] 22:50:59     INFO - PID 29883 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost```

Comment 1

[James Graham [:jgraham]]

I'm not sure if this is a marionette issue or a general fission issue. Obviously there is a metadata patch to be made, to paper over the permafail, and I can make that.

Comment 2

[James Graham [:jgraham]]

I made the metadata fix in 1674202 so we can use this to track the underlying issue.

Comment 3

[Cristina Coroiu [:ccoroiu]]

This should be fixed based on Comment 2.

Comment 4

[Intermittent Failures Robot]

31 failures in 4275 pushes (0.007 failures/push) were associated with this bug in the last 7 days.

This is the #43 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• mozilla-central: 31

Platform breakdown:

• linux1804-64-qr: 15
• linux1804-64-shippable-qr: 8
• windows10-64-shippable-qr: 8

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1674025&startday=2020-10-26&endday=2020-11-01&tree=all

Comment 5

[James Graham [:jgraham]]

I fixed the underlying issue upstream in https://github.com/web-platform-tests/wpt/pull/26411 so we need that to land and sync.

Comment 6

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Comment 7

[Chris Peterson [:cpeterson]]

(In reply to James Graham [:jgraham] from comment #5)

I fixed the underlying issue upstream in https://github.com/web-platform-tests/wpt/pull/26411 so we need that to land and sync.

Reopening this Fission WPT bug because that upstream issue is still open.

https://searchfox.org/mozilla-central/rev/16388511162ac6bbf5399e69e500e174a2f3972c/testing/web-platform/meta/infrastructure/testdriver/actions/crossOrigin.sub.html.ini#4

[crossOrigin.sub.html]
  [Actions in cross-origin iframe]
    expected:
      if fission: FAIL

Comment 8

[Karl Dubost💡 :karlcow]

According to https://github.com/web-platform-tests/wpt/pull/26411
This has not been landed yet.
There seems to be a failure on Safari

Is this a blocker for Fx91?

Comment 9

[James Graham [:jgraham]]

Yeah, for reasons that are unclear to me that change seems to trigger a race in Safari which then causes tests to be intermittent. So what looked like a simple correctness fix has become a bit of a nightmare. This is still on my radar but fixing Safari issues is tricky :/ I'll give it another go today.

Comment 10

[James Graham [:jgraham]]

The upstream PR is now on m-c and the annotation has been removed from the ini file, so I'm going to close this one; if it's still a problem feel free to reopen.