1610444 - Intermittent TEST-UNEXPECTED-TIMEOUT | /html/cross-origin-opener-policy/popup-same-origin-with-same-origin.https.html | same-origin document opening popup to https://web-platform.test:8443 with COOP: "same-origin-allow-popups" - Test timed out

Status: RESOLVED WORKSFORME

(Core :: DOM: Core & HTML, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2020-01-21T05:07:11.267Z] 05:07:11 INFO - TEST-START | /html/cross-origin-opener-policy/popup-same-origin-with-same-origin.https.html
[task 2020-01-21T05:07:11.286Z] 05:07:11 INFO - Closing window 181
[task 2020-01-21T05:07:11.302Z] 05:07:11 INFO - PID 20356 | [Child 21971, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/workspace/build/src/dom/events/DOMEventTargetHelper.cpp, line 321
[task 2020-01-21T05:07:11.306Z] 05:07:11 INFO - PID 20356 | [Child 21954, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/workspace/build/src/dom/events/DOMEventTargetHelper.cpp, line 321
[task 2020-01-21T05:07:11.306Z] 05:07:11 INFO - PID 20356 | [Child 21954, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/workspace/build/src/dom/events/DOMEventTargetHelper.cpp, line 321
[task 2020-01-21T05:07:11.363Z] 05:07:11 INFO - PID 20356 | [Child 21954, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/workspace/build/src/dom/events/DOMEventTargetHelper.cpp, line 321
[task 2020-01-21T05:07:11.364Z] 05:07:11 INFO - PID 20356 | [Child 21954, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/workspace/build/src/dom/events/DOMEventTargetHelper.cpp, line 321
[task 2020-01-21T05:07:11.364Z] 05:07:11 INFO - PID 20356 | [Child 21971, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/workspace/build/src/xpcom/base/nsCycleCollector.cpp, line 3362
[task 2020-01-21T05:07:11.424Z] 05:07:11 INFO - PID 20356 | [Child 21954, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/workspace/build/src/xpcom/base/nsCycleCollector.cpp, line 3362
[task 2020-01-21T05:07:11.467Z] 05:07:11 INFO - PID 20356 | nsStringStats
[task 2020-01-21T05:07:11.468Z] 05:07:11 INFO - PID 20356 | => mAllocCount: 9028
[task 2020-01-21T05:07:11.469Z] 05:07:11 INFO - PID 20356 | => mReallocCount: 0
[task 2020-01-21T05:07:11.471Z] 05:07:11 INFO - PID 20356 | => mFreeCount: 9028
[task 2020-01-21T05:07:11.471Z] 05:07:11 INFO - PID 20356 | => mShareCount: 7342
[task 2020-01-21T05:07:11.472Z] 05:07:11 INFO - PID 20356 | => mAdoptCount: 398
[task 2020-01-21T05:07:11.473Z] 05:07:11 INFO - PID 20356 | => mAdoptFreeCount: 408
[task 2020-01-21T05:07:11.473Z] 05:07:11 INFO - PID 20356 | => Process ID: 21971, Thread ID: 140263788971904
[task 2020-01-21T05:07:11.563Z] 05:07:11 INFO - PID 20356 | nsStringStats
[task 2020-01-21T05:07:11.563Z] 05:07:11 INFO - PID 20356 | => mAllocCount: 10714
[task 2020-01-21T05:07:11.563Z] 05:07:11 INFO - PID 20356 | => mReallocCount: 0
[task 2020-01-21T05:07:11.564Z] 05:07:11 INFO - PID 20356 | => mFreeCount: 10714
[task 2020-01-21T05:07:11.564Z] 05:07:11 INFO - PID 20356 | => mShareCount: 10433
[task 2020-01-21T05:07:11.565Z] 05:07:11 INFO - PID 20356 | => mAdoptCount: 416
[task 2020-01-21T05:07:11.565Z] 05:07:11 INFO - PID 20356 | => mAdoptFreeCount: 436
[task 2020-01-21T05:07:11.566Z] 05:07:11 INFO - PID 20356 | => Process ID: 21954, Thread ID: 139821453608832
[task 2020-01-21T05:07:11.588Z] 05:07:11 INFO - PID 20356 | [Child 22022, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/workspace/build/src/dom/events/DOMEventTargetHelper.cpp, line 321
[task 2020-01-21T05:07:11.652Z] 05:07:11 INFO - PID 20356 | [Child 22054, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/workspace/build/src/layout/base/nsPresContext.cpp, line 845
[task 2020-01-21T05:07:11.652Z] 05:07:11 INFO - PID 20356 | [Child 22022, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/workspace/build/src/dom/events/DOMEventTargetHelper.cpp, line 321
[task 2020-01-21T05:07:11.653Z] 05:07:11 INFO - PID 20356 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties

[task 2020-01-21T05:07:43.603Z] 05:07:43 INFO - TEST-PASS | /html/cross-origin-opener-policy/popup-same-origin-with-same-origin.https.html | same-origin document opening popup to https://web-platform.test:8443 with COOP: "same-site unsafe-allow-outgoing"
[task 2020-01-21T05:07:43.603Z] 05:07:43 INFO - TEST-PASS | /html/cross-origin-opener-policy/popup-same-origin-with-same-origin.https.html | same-origin document opening popup to https://web-platform.test:8443 with COOP: "same-origin unsafe-allow-outgoing"
[task 2020-01-21T05:07:43.603Z] 05:07:43 INFO - TEST-PASS | /html/cross-origin-opener-policy/popup-same-origin-with-same-origin.https.html | same-origin document opening popup to https://web-platform.test:8443 with COOP: "same-origin"
[task 2020-01-21T05:07:43.603Z] 05:07:43 INFO - TEST-UNEXPECTED-TIMEOUT | /html/cross-origin-opener-policy/popup-same-origin-with-same-origin.https.html | same-origin document opening popup to https://web-platform.test:8443 with COOP: "same-origin-allow-popups" - Test timed out
[task 2020-01-21T05:07:43.603Z] 05:07:43 INFO - TEST-UNEXPECTED-TIMEOUT | /html/cross-origin-opener-policy/popup-same-origin-with-same-origin.https.html | expected OK
[task 2020-01-21T05:07:43.603Z] 05:07:43 INFO - TEST-INFO took 32334ms
[task 2020-01-21T05:07:43.628Z] 05:07:43 INFO - PID 20356 | 1579583263625 Marionette INFO Stopped listening on port 38322
[task 2020-01-21T05:07:43.649Z] 05:07:43 INFO - PID 20356 | JavaScript error: chrome://browser/content/browser.js, line 8107: TypeError: can't access property "processMessageManager", browser.messageManager is null
[task 2020-01-21T05:07:43.876Z] 05:07:43 INFO - PID 20356 | WARNING: A blocker encountered an error while we were waiting.
[task 2020-01-21T05:07:43.876Z] 05:07:43 INFO - PID 20356 | Blocker: SessionStore: flushing all windows
[task 2020-01-21T05:07:43.877Z] 05:07:43 INFO - PID 20356 | Phase: quit-application-granted
[task 2020-01-21T05:07:43.877Z] 05:07:43 INFO - PID 20356 | State: {"total":-1,"current":-1}
[task 2020-01-21T05:07:43.877Z] 05:07:43 INFO - PID 20356 | WARNING: TypeError: can't access property "sendAsyncMessage", mm is null
[task 2020-01-21T05:07:43.877Z] 05:07:43 INFO - PID 20356 | WARNING: flush@resource:///modules/sessionstore/TabStateFlusher.jsm:97:5
[task 2020-01-21T05:07:43.877Z] 05:07:43 INFO - PID 20356 | flushWindow@resource:///modules/sessionstore/TabStateFlusher.jsm:127:28
[task 2020-01-21T05:07:43.880Z] 05:07:43 INFO - PID 20356 | flushWindow@resource:///modules/sessionstore/TabStateFlusher.jsm:31:36
[task 2020-01-21T05:07:43.880Z] 05:07:43 INFO - PID 20356 | flushAllWindowsAsync@resource:///modules/sessionstore/SessionStore.jsm:1906:50
[task 2020-01-21T05:07:43.881Z] 05:07:43 INFO - PID 20356 | ssi_onQuitApplicationGranted/<@resource:///modules/sessionstore/SessionStore.jsm:1830:32
[task 2020-01-21T05:07:43.881Z] 05:07:43 INFO - PID 20356 | trigger@resource://gre/modules/AsyncShutdown.jsm:725:23
[task 2020-01-21T05:07:43.890Z] 05:07:43 INFO - PID 20356 | _wait@resource://gre/modules/AsyncShutdown.jsm:877:15
[task 2020-01-21T05:07:43.890Z] 05:07:43 INFO - PID 20356 | wait@resource://gre/modules/AsyncShutdown.jsm:858:34
[task 2020-01-21T05:07:43.890Z] 05:07:43 INFO - PID 20356 | observe@resource://gre/modules/AsyncShutdown.jsm:533:10
[task 2020-01-21T05:07:43.890Z] 05:07:43 INFO - PID 20356 | GeckoDriver.prototype.quit@chrome://marionette/content/driver.js:3502:20
[task 2020-01-21T05:07:43.890Z] 05:07:43 INFO - PID 20356 | despatch@chrome://marionette/content/server.js:305:40
[task 2020-01-21T05:07:43.890Z] 05:07:43 INFO - PID 20356 | execute@chrome://marionette/content/server.js:275:16
[task 2020-01-21T05:07:43.895Z] 05:07:43 INFO - PID 20356 | onPacket/<@chrome://marionette/content/server.js:248:20
[task 2020-01-21T05:07:43.895Z] 05:07:43 INFO - PID 20356 | onPacket@chrome://marionette/content/server.js:249:9
[task 2020-01-21T05:07:43.895Z] 05:07:43 INFO - PID 20356 | _onJSONObjectReady/<@chrome://marionette/content/transport.js:501:20
[task 2020-01-21T05:07:43.895Z] 05:07:43 INFO - PID 20356 | JavaScript error: resource:///modules/sessionstore/SessionStore.jsm, line 5686: TypeError: can't access property "sendAsyncMessage", browser.messageManager is null

Comment 1

[Intermittent Failures Robot]

1 failures in 4004 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1

Platform breakdown:

• linux1804-64-qr: 1

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

Comment 2

[Intermittent Failures Robot]

1 failures in 2190 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• try: 1

Platform breakdown:

• linux1804-64-qr: 1

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

Comment 3

[Intermittent Failures Robot]

3 failures in 4690 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1
• mozilla-central: 2

Platform breakdown:

• macosx1014-64: 1
• linux1804-64-qr: 2

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

Comment 4

[Intermittent Failures Robot]

4 failures in 4045 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 3
• autoland: 1

Platform breakdown:

• linux1804-64-ccov: 3
• macosx1014-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1610444&startday=2020-02-17&endday=2020-02-23&tree=all

Comment 5

[Intermittent Failures Robot]

1 failures in 5233 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1

Platform breakdown:

• macosx1014-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1610444&startday=2020-02-24&endday=2020-03-01&tree=all

Comment 6

[Intermittent Failures Robot]

1 failures in 5483 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-release: 1

Platform breakdown:

• macosx1014-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1610444&startday=2020-03-02&endday=2020-03-08&tree=all

Comment 7

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

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

Comment 8

[Alexandru Michis [:malexandru]]

Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=297356857&repo=try&lineNumber=21491

Comment 9

[Intermittent Failures Robot]

1 failures in 4528 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• try: 1

Platform breakdown:

• linux1804-64-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1610444&startday=2020-04-13&endday=2020-04-19&tree=all

Comment 10

[Intermittent Failures Robot]

2 failures in 5582 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 2

Platform breakdown:

• linux1804-64: 2

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

Comment 11

[Intermittent Failures Robot]

1 failures in 5423 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1

Platform breakdown:

• linux1804-64-ccov: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1610444&startday=2020-04-27&endday=2020-05-03&tree=all

Comment 12

[Intermittent Failures Robot]

1 failures in 5276 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform breakdown:

• macosx1014-64: 1

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

Comment 13

[Intermittent Failures Robot]

2 failures in 5488 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 2

Platform breakdown:

• macosx1014-64: 2

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

Comment 14

[Intermittent Failures Robot]

2 failures in 4727 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1
• try: 1

Platform breakdown:

• linux1804-64: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1610444&startday=2020-05-18&endday=2020-05-24&tree=all

Comment 15

[Anne (:annevk)]

Nothing in the last month.

Comment 16

[Dorel Luca [:dluca]]

Recent log:
https://treeherder.mozilla.org/logviewer?job_id=341426470&repo=autoland&lineNumber=2094

INFO - TEST-START | /html/cross-origin-opener-policy/popup-same-origin-with-same-origin.https.html
[task 2021-06-01T15:21:26.470Z] 15:21:26     INFO - Closing window 006c7218-ca5d-49ea-9931-d5c22a8e34cb
[task 2021-06-01T15:24:36.439Z] 15:24:36     INFO - Browser not responding, setting status to CRASH
[task 2021-06-01T15:24:36.543Z] 15:24:36     INFO - TEST-UNEXPECTED-CRASH | /html/cross-origin-opener-policy/popup-same-origin-with-same-origin.https.html | expected OK
[task 2021-06-01T15:24:36.543Z] 15:24:36     INFO - TEST-INFO took 190119ms
[task 2021-06-01T15:24:36.650Z] 15:24:36 CRITICAL - Test harness output was not a valid structured log message: 
[task 2021-06-01T15:24:36.650Z] 15:24:36 CRITICAL - Exception ignored in: <bound method Marionette.__del__ of <marionette_driver.marionette.Marionette object at 0x7f181b693cf8>>
[task 2021-06-01T15:24:36.650Z] 15:24:36 CRITICAL - Traceback (most recent call last):
[task 2021-06-01T15:24:36.651Z] 15:24:36 CRITICAL -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/marionette.py", line 536, in __del__
[task 2021-06-01T15:24:36.651Z] 15:24:36 CRITICAL -     self.cleanup()
[task 2021-06-01T15:24:36.651Z] 15:24:36 CRITICAL -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/marionette.py", line 521, in cleanup
[task 2021-06-01T15:24:36.652Z] 15:24:36 CRITICAL -     self.delete_session()
[task 2021-06-01T15:24:36.652Z] 15:24:36 CRITICAL -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/marionette.py", line 1228, in delete_session
[task 2021-06-01T15:24:36.652Z] 15:24:36 CRITICAL -     self._send_message("WebDriver:DeleteSession")
[task 2021-06-01T15:24:36.653Z] 15:24:36 CRITICAL -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/decorators.py", line 27, in _
[task 2021-06-01T15:24:36.653Z] 15:24:36 CRITICAL -     return func(*args, **kwargs)
[task 2021-06-01T15:24:36.654Z] 15:24:36 CRITICAL -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/marionette.py", line 621, in _send_message
[task 2021-06-01T15:24:36.654Z] 15:24:36 CRITICAL -     msg = self.client.request(name, params)
[task 2021-06-01T15:24:36.654Z] 15:24:36 CRITICAL -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/transport.py", line 292, in request
[task 2021-06-01T15:24:36.655Z] 15:24:36 CRITICAL -     return self.receive()
[task 2021-06-01T15:24:36.655Z] 15:24:36 CRITICAL -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/transport.py", line 178, in receive
[task 2021-06-01T15:24:36.655Z] 15:24:36 CRITICAL -     if len(remaining) == int(length):
[task 2021-06-01T15:24:36.655Z] 15:24:36 CRITICAL - ValueError: invalid literal for int() with base 10: b'ue"'
[task 2021-06-01T15:24:36.855Z] 15:24:36     INFO - STDOUT: cleanup aborted: Unable to remount device
[task 2021-06-01T15:24:36.973Z] 15:24:36     INFO - STDOUT: cleanup aborted: Unable to remount device
[task 2021-06-01T15:24:36.976Z] 15:24:36     INFO - Closing logging queue
[task 2021-06-01T15:24:36.976Z] 15:24:36     INFO - queue closed
[task 2021-06-01T15:24:36.999Z] 15:24:36     INFO - Setting up ssl
[task 2021-06-01T15:24:37.021Z] 15:24:37     INFO - certutil | b''
[task 2021-06-01T15:24:37.039Z] 15:24:37     INFO - certutil | b''
[task 2021-06-01T15:24:37.058Z] 15:24:37     INFO - certutil | b'\nCertificate Nickname                                         Trust Attributes\n                                                             SSL,S/MIME,JAR/XPI\n\nweb-platform-tests                                           CT,, \n'
[task 2021-06-01T15:24:37.880Z] 15:24:37     INFO - adb Granting important runtime permissions to org.mozilla.geckoview.test
[task 2021-06-01T15:24:39.204Z] 15:24:39     INFO - adb launch_application: am start -W -n org.mozilla.geckoview.test/org.mozilla.geckoview.test.TestRunnerActivity -a android.intent.action.MAIN --es env0 MOZ_CRASHREPORTER=1 --es env1 MOZ_CRASHREPORTER_NO_REPORT=1 --es env2 MOZ_CRASHREPORTER_SHUTDOWN=1 --es env3 MOZ_HIDE_RESULTS_TABLE=1 --es env4 MOZ_IN_AUTOMATION=1 --es env5 MOZ_LOG=signaling:3,mtransport:4,DataChannel:4,jsep:4 --es env6 R_LOG_LEVEL=6 --es env7 R_LOG_DESTINATION=stderr --es env8 R_LOG_VERBOSE=1 --es env9 MOZ_PROCESS_LOG=/tmp/tmprh8dfwg8pidlog --es env10 MOZ_DISABLE_NONLOCAL_CONNECTIONS=1 --es env11 STYLO_THREADS=1 --es env12 MOZ_WEBRENDER=1 --es arg0 -no-remote --es arg1 -profile --es arg2 /data/local/tmp/test_root/profile --es arg3 --marionette --es arg4 about:blank --ez use_multiprocess True
[task 2021-06-01T15:24:40.054Z] 15:24:40     INFO - Starting runner
[task 2021-06-01T15:24:40.752Z] 15:24:40     INFO - TEST-START | /html/cross-origin-opener-policy/popup-same-origin-with-same-site.https.html

Comment 17

[Intermittent Failures Robot]

1 failures in 3065 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• android-em-7-0-x86_64-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1610444&startday=2021-05-31&endday=2021-06-06&tree=all

Comment 18

[Intermittent Failures Robot]

1 failures in 723 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• android-em-7-0-x86_64: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1610444&startday=2021-06-28&endday=2021-07-04&tree=all