Closed Bug 1658791 Opened 4 years ago Closed 4 years ago

Perma [Tier 2] dom/base/test/test_setting_opener.html | uncaught exception - NS_ERROR_ILLEGAL_VALUE: Illegal value at construct/<@resource://specialpowers/WrapPrivileged.jsm:229:17

Categories

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

defect

Tracking

()

RESOLVED FIXED
82 Branch
Fission Milestone M6b
Tracking Status
firefox82 --- fixed

People

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

References

Details

(Keywords: intermittent-failure)

Attachments

(4 files)

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


[task 2020-08-12T16:26:12.965Z] 16:26:12 INFO - TEST-START | http://mochi.test:8888/tests/dom/base/test/test_setting_opener.html
[task 2020-08-12T16:26:13.046Z] 16:26:13 INFO - JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-08-12T16:26:13.134Z] 16:26:13 INFO - GECKO(1481) | [Child 18399, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-08-12T16:26:13.182Z] 16:26:13 INFO - GECKO(1481) | [Child 18399, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp, line 4343
[task 2020-08-12T16:26:13.281Z] 16:26:13 INFO - GECKO(1481) | [18504, Unnamed thread 7fd20e05d5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-08-12T16:26:13.281Z] 16:26:13 INFO - GECKO(1481) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmp_lfYO6.mozrunner/runtests_leaks.log
[task 2020-08-12T16:26:13.281Z] 16:26:13 INFO - GECKO(1481) | [18504, Unnamed thread 7fd20e05d5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-08-12T16:26:13.290Z] 16:26:13 INFO - GECKO(1481) | [18504, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp, line 246
[task 2020-08-12T16:26:13.327Z] 16:26:13 INFO - GECKO(1481) | [Parent 1481, QuotaManager IO] WARNING: '!outputStream', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 2482
[task 2020-08-12T16:26:13.328Z] 16:26:13 INFO - GECKO(1481) | [Parent 1481, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8504
[task 2020-08-12T16:26:13.329Z] 16:26:13 INFO - GECKO(1481) | [Parent 1481, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8363
[task 2020-08-12T16:26:13.329Z] 16:26:13 INFO - GECKO(1481) | [Parent 1481, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8273
[task 2020-08-12T16:26:13.330Z] 16:26:13 INFO - GECKO(1481) | [Parent 1481, QuotaManager IO] WARNING: '!outputStream', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 2482
[task 2020-08-12T16:26:13.330Z] 16:26:13 INFO - GECKO(1481) | [Parent 1481, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8504
[task 2020-08-12T16:26:13.331Z] 16:26:13 INFO - GECKO(1481) | [Parent 1481, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8363
[task 2020-08-12T16:26:13.332Z] 16:26:13 INFO - GECKO(1481) | [Parent 1481, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8273
[task 2020-08-12T16:26:13.364Z] 16:26:13 INFO - JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-08-12T16:26:13.365Z] 16:26:13 INFO - JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-08-12T16:26:13.405Z] 16:26:13 INFO - GECKO(1481) | [Child 18426, Main Thread] WARNING: '!topWindow', file /builds/worker/checkouts/gecko/dom/html/HTMLIFrameElement.cpp, line 241
[task 2020-08-12T16:26:13.408Z] 16:26:13 INFO - GECKO(1481) | [Child 18426, Main Thread] WARNING: '!topWindow', file /builds/worker/checkouts/gecko/dom/html/HTMLIFrameElement.cpp, line 241
[task 2020-08-12T16:26:13.409Z] 16:26:13 INFO - GECKO(1481) | [Child 18426, Main Thread] WARNING: '!topWindow', file /builds/worker/checkouts/gecko/dom/html/HTMLIFrameElement.cpp, line 241
[task 2020-08-12T16:26:13.486Z] 16:26:13 INFO - GECKO(1481) | [Child 18504, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp, line 626
[task 2020-08-12T16:26:13.546Z] 16:26:13 INFO - GECKO(1481) | JavaScript error: resource://specialpowers/WrapPrivileged.jsm, line 229: NS_ERROR_ILLEGAL_VALUE: Illegal value
[task 2020-08-12T16:26:13.547Z] 16:26:13 INFO - JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-08-12T16:26:13.628Z] 16:26:13 INFO - TEST-INFO | started process screentopng
[task 2020-08-12T16:26:13.864Z] 16:26:13 INFO - JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-08-12T16:26:13.865Z] 16:26:13 INFO - JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-08-12T16:26:13.946Z] 16:26:13 INFO - TEST-INFO | screentopng: exit 0
[task 2020-08-12T16:26:13.946Z] 16:26:13 INFO - TEST-UNEXPECTED-FAIL | dom/base/test/test_setting_opener.html | uncaught exception - NS_ERROR_ILLEGAL_VALUE: Illegal value at construct/<@resource://specialpowers/WrapPrivileged.jsm:229:17

Summary: Intermittent Perma [Tier 2] dom/base/test/test_setting_opener.html | uncaught exception - NS_ERROR_ILLEGAL_VALUE: Illegal value at construct/<@resource://specialpowers/WrapPrivileged.jsm:229:17 → Perma [Tier 2] dom/base/test/test_setting_opener.html | uncaught exception - NS_ERROR_ILLEGAL_VALUE: Illegal value at construct/<@resource://specialpowers/WrapPrivileged.jsm:229:17

This fails permanently on Linux debug with fission and cross-origin enabled. Dimi, could this be from bug 1652244?

Flags: needinfo?(dlee)

(In reply to Sebastian Hengst [:aryx] (needinfo on intermittent or backout) from comment #2)

This fails permanently on Linux debug with fission and cross-origin enabled. Dimi, could this be from bug 1652244?

probably not, I reverted the changes made in the bug, but the issue still happens on try.
https://treeherder.mozilla.org/#/jobs?repo=try&revision=20c9f98cec1ce7b8325f14e86ff3bab162be7cc7

Flags: needinfo?(dlee)

There are 30 total failures in the last 7 days on linux1804-64 debug

Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=314423969&repo=mozilla-central&lineNumber=16955

[task 2020-08-30T23:28:28.117Z] 23:28:28 INFO - TEST-START | http://mochi.test:8888/tests/dom/base/test/test_setting_opener.html
[task 2020-08-30T23:28:28.280Z] 23:28:28 INFO - GECKO(1475) | [Child 18214, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-08-30T23:28:28.356Z] 23:28:28 INFO - GECKO(1475) | [Child 18214, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp, line 4286
[task 2020-08-30T23:28:28.371Z] 23:28:28 INFO - GECKO(1475) | [18323, Unnamed thread 7f4ea515d5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-08-30T23:28:28.371Z] 23:28:28 INFO - GECKO(1475) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpWeDRSg.mozrunner/runtests_leaks.log
[task 2020-08-30T23:28:28.372Z] 23:28:28 INFO - GECKO(1475) | [18323, Unnamed thread 7f4ea515d5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-08-30T23:28:28.373Z] 23:28:28 INFO - GECKO(1475) | [18323, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp, line 246
[task 2020-08-30T23:28:28.434Z] 23:28:28 INFO - GECKO(1475) | [Parent 1475, QuotaManager IO] WARNING: '!outputStream', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 2493
[task 2020-08-30T23:28:28.434Z] 23:28:28 INFO - GECKO(1475) | [Parent 1475, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8531
[task 2020-08-30T23:28:28.435Z] 23:28:28 INFO - GECKO(1475) | [Parent 1475, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8390
[task 2020-08-30T23:28:28.435Z] 23:28:28 INFO - GECKO(1475) | [Parent 1475, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8300
[task 2020-08-30T23:28:28.435Z] 23:28:28 INFO - GECKO(1475) | [Parent 1475, QuotaManager IO] WARNING: '!outputStream', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 2493
[task 2020-08-30T23:28:28.436Z] 23:28:28 INFO - GECKO(1475) | [Parent 1475, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8531
[task 2020-08-30T23:28:28.436Z] 23:28:28 INFO - GECKO(1475) | [Parent 1475, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8390
[task 2020-08-30T23:28:28.437Z] 23:28:28 INFO - GECKO(1475) | [Parent 1475, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8300
[task 2020-08-30T23:28:28.479Z] 23:28:28 INFO - JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-08-30T23:28:28.479Z] 23:28:28 INFO - JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-08-30T23:28:28.480Z] 23:28:28 INFO - JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-08-30T23:28:28.521Z] 23:28:28 INFO - GECKO(1475) | [Child 18323, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp, line 626
[task 2020-08-30T23:28:28.521Z] 23:28:28 INFO - GECKO(1475) | [Child 18242, Main Thread] WARNING: '!topWindow', file /builds/worker/checkouts/gecko/dom/html/HTMLIFrameElement.cpp, line 241
[task 2020-08-30T23:28:28.521Z] 23:28:28 INFO - GECKO(1475) | [Child 18242, Main Thread] WARNING: '!topWindow', file /builds/worker/checkouts/gecko/dom/html/HTMLIFrameElement.cpp, line 241
[task 2020-08-30T23:28:28.537Z] 23:28:28 INFO - GECKO(1475) | [Child 18242, Main Thread] WARNING: '!topWindow', file /builds/worker/checkouts/gecko/dom/html/HTMLIFrameElement.cpp, line 241
[task 2020-08-30T23:28:28.658Z] 23:28:28 INFO - GECKO(1475) | JavaScript error: resource://specialpowers/WrapPrivileged.jsm, line 231: NS_ERROR_ILLEGAL_VALUE: Illegal value
[task 2020-08-30T23:28:28.708Z] 23:28:28 INFO - TEST-INFO | started process screentopng
[task 2020-08-30T23:28:28.980Z] 23:28:28 INFO - JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-08-30T23:28:28.981Z] 23:28:28 INFO - JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-08-30T23:28:28.984Z] 23:28:28 INFO - JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-08-30T23:28:29.267Z] 23:28:29 INFO - TEST-INFO | screentopng: exit 0
[task 2020-08-30T23:28:29.267Z] 23:28:29 INFO - TEST-UNEXPECTED-FAIL | dom/base/test/test_setting_opener.html | uncaught exception - NS_ERROR_ILLEGAL_VALUE: Illegal value at construct/<@resource://specialpowers/WrapPrivileged.jsm:231:17
[task 2020-08-30T23:28:29.268Z] 23:28:29 INFO - wrapExceptions@resource://specialpowers/WrapPrivileged.jsm:206:12
[task 2020-08-30T23:28:29.268Z] 23:28:29 INFO - construct@resource://specialpowers/WrapPrivileged.jsm:229:12
[task 2020-08-30T23:28:29.268Z] 23:28:29 INFO - testOpenerSet@http://mochi.test:8888/tests/dom/base/test/test_setting_opener.html?currentTestURL=dom%2Fbase%2Ftest%2Ftest_setting_opener.html&closeWhenDone=1&showTestReport=false&expected=pass:26:11
[task 2020-08-30T23:28:29.269Z] 23:28:29 INFO - callStackHandler@http://mochi.test:8888/tests/SimpleTest/SimpleTest.js:279:24
[task 2020-08-30T23:28:29.269Z] 23:28:29 INFO -
[task 2020-08-30T23:28:29.269Z] 23:28:29 INFO - simpletestOnerror@SimpleTest/SimpleTest.js:2063:18
[task 2020-08-30T23:28:29.270Z] 23:28:29 INFO - GECKO(1475) | MEMORY STAT | vsize 2591MB | residentFast 169MB | heapAllocated 12MB
[task 2020-08-30T23:28:29.270Z] 23:28:29 INFO - TEST-OK | http://mochi.test:8888/tests/dom/base/test/test_setting_opener.html | took 676ms
[task 2020-08-30T23:28:29.270Z] 23:28:29 INFO - GECKO(1475) | [Parent 1475, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/workspace/obj-build/dist/include/mozilla/ipc/ProtocolUtils.h, line 295
[task 2020-08-30T23:28:29.270Z] 23:28:29 INFO - GECKO(1475) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost

Jens can you please assign this to someone to take a look?

Flags: needinfo?(jstutte)

(In reply to Sebastian Hengst [:aryx] (needinfo on intermittent or backout) from comment #2)

This fails permanently on Linux debug with fission and cross-origin enabled. Dimi, could this be from bug 1652244?

Hi Neha, can you confirm that this is fission specific?

Flags: needinfo?(jstutte) → needinfo?(nkochar)

Yes, as mentioned in comment 2, these failures are all from fission cross-origin mode.

Flags: needinfo?(nkochar)
Whiteboard: [stockwell disable-recommended]

Should this be disabled on fission?

Whiteboard: [stockwell needswork:owner]

Yes, until it's fixed, we should add a "fail-if = (xorigin && fission)" for this test.
Jens, please assign someone to debug the failure.

Flags: needinfo?(jstutte)
Assignee: nobody → apavel
Status: NEW → ASSIGNED
Pushed by ccoroiu@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/83829cf1fa2b
disable test_setting_opener.html on xorig fission r#?intermittent-reviewers r=intermittent-reviewers,jmaher DONTBUILD
Keywords: leave-open
Whiteboard: [stockwell needswork:owner] → [stockwell disabled]

Hi Neha, can we have a fission milestone associated here? That would help me with prioritization. Thank you!

Severity: normal → S3
Flags: needinfo?(jstutte) → needinfo?(nkochar)

(In reply to Jens Stutte [:jstutte] (REO for FF 81) from comment #17)

Hi Neha, can we have a fission milestone associated here? That would help me with prioritization. Thank you!

Setting for M6b. Here's the failure:
TEST-UNEXPECTED-FAIL | dom/base/test/test_setting_opener.html | uncaught exception - NS_ERROR_ILLEGAL_VALUE: Illegal value at construct/<@resource://specialpowers/WrapPrivileged.jsm:231:17

Fission Milestone: --- → M6b
Flags: needinfo?(nkochar)

./mach mochitest --enable-xorigin-tests --enable-fission dom/base/test/test_setting_opener.html passes locally. I'll run it on Try and if it passes I'll re-enable it on mozilla-central.

Pushed by mbrodesser@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/2ff07fdabcd7
enable "dom/base/test/test_setting_opener.html" for xorigin iframes with Fission. r=smaug

Hi Mirko, this is failing again since the test got re-enabled with 5 failures since yesterday

Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=315224598&repo=mozilla-central&lineNumber=16859

[task 2020-09-09T17:05:00.540Z] 17:05:00 INFO - TEST-START | http://mochi.test:8888/tests/dom/base/test/test_setting_opener.html
[task 2020-09-09T17:05:00.583Z] 17:05:00 INFO - GECKO(1476) | [Child 18268, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-09-09T17:05:00.624Z] 17:05:00 INFO - GECKO(1476) | [Child 18268, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp, line 4286
[task 2020-09-09T17:05:00.631Z] 17:05:00 INFO - JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-09-09T17:05:00.716Z] 17:05:00 INFO - GECKO(1476) | [18377, Unnamed thread 7f3ca015d5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-09T17:05:00.717Z] 17:05:00 INFO - GECKO(1476) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpregBi5.mozrunner/runtests_leaks.log
[task 2020-09-09T17:05:00.718Z] 17:05:00 INFO - GECKO(1476) | [18377, Unnamed thread 7f3ca015d5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-09T17:05:00.718Z] 17:05:00 INFO - GECKO(1476) | [18377, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp, line 246
[task 2020-09-09T17:05:00.834Z] 17:05:00 INFO - GECKO(1476) | [Child 18377, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp, line 626
[task 2020-09-09T17:05:00.835Z] 17:05:00 INFO - GECKO(1476) | [Parent 1476, QuotaManager IO] WARNING: '!outputStream', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 2506
[task 2020-09-09T17:05:00.836Z] 17:05:00 INFO - JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-09-09T17:05:00.837Z] 17:05:00 INFO - GECKO(1476) | [Parent 1476, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8545
[task 2020-09-09T17:05:00.837Z] 17:05:00 INFO - GECKO(1476) | [Parent 1476, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8404
[task 2020-09-09T17:05:00.837Z] 17:05:00 INFO - GECKO(1476) | [Parent 1476, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8314
[task 2020-09-09T17:05:00.842Z] 17:05:00 INFO - GECKO(1476) | [Parent 1476, QuotaManager IO] WARNING: '!outputStream', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 2506
[task 2020-09-09T17:05:00.843Z] 17:05:00 INFO - GECKO(1476) | [Parent 1476, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8545
[task 2020-09-09T17:05:00.844Z] 17:05:00 INFO - GECKO(1476) | [Parent 1476, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8404
[task 2020-09-09T17:05:00.844Z] 17:05:00 INFO - GECKO(1476) | [Parent 1476, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8314
[task 2020-09-09T17:05:00.844Z] 17:05:00 INFO - JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-09-09T17:05:00.943Z] 17:05:00 INFO - GECKO(1476) | [Child 18295, Main Thread] WARNING: '!topWindow', file /builds/worker/checkouts/gecko/dom/html/HTMLIFrameElement.cpp, line 241
[task 2020-09-09T17:05:00.944Z] 17:05:00 INFO - GECKO(1476) | [Child 18295, Main Thread] WARNING: '!topWindow', file /builds/worker/checkouts/gecko/dom/html/HTMLIFrameElement.cpp, line 241
[task 2020-09-09T17:05:00.945Z] 17:05:00 INFO - GECKO(1476) | [Child 18295, Main Thread] WARNING: '!topWindow', file /builds/worker/checkouts/gecko/dom/html/HTMLIFrameElement.cpp, line 241
[task 2020-09-09T17:05:01.046Z] 17:05:01 INFO - GECKO(1476) | JavaScript error: resource://specialpowers/WrapPrivileged.jsm, line 231: NS_ERROR_ILLEGAL_VALUE: Illegal value
[task 2020-09-09T17:05:01.068Z] 17:05:01 INFO - TEST-INFO | started process screentopng
[task 2020-09-09T17:05:01.132Z] 17:05:01 INFO - JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-09-09T17:05:01.336Z] 17:05:01 INFO - JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-09-09T17:05:01.343Z] 17:05:01 INFO - JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-09-09T17:05:01.629Z] 17:05:01 INFO - TEST-INFO | screentopng: exit 0
[task 2020-09-09T17:05:01.630Z] 17:05:01 INFO - TEST-UNEXPECTED-FAIL | dom/base/test/test_setting_opener.html | uncaught exception - NS_ERROR_ILLEGAL_VALUE: Illegal value at construct/<@resource://specialpowers/WrapPrivileged.jsm:231:17
[task 2020-09-09T17:05:01.631Z] 17:05:01 INFO - wrapExceptions@resource://specialpowers/WrapPrivileged.jsm:206:12
[task 2020-09-09T17:05:01.632Z] 17:05:01 INFO - construct@resource://specialpowers/WrapPrivileged.jsm:229:12
[task 2020-09-09T17:05:01.632Z] 17:05:01 INFO - testOpenerSet@http://mochi.test:8888/tests/dom/base/test/test_setting_opener.html?currentTestURL=dom%2Fbase%2Ftest%2Ftest_setting_opener.html&closeWhenDone=1&showTestReport=false&expected=pass:26:11
[task 2020-09-09T17:05:01.633Z] 17:05:01 INFO - callStackHandler@http://mochi.test:8888/tests/SimpleTest/SimpleTest.js:279:24
[task 2020-09-09T17:05:01.633Z] 17:05:01 INFO -
[task 2020-09-09T17:05:01.633Z] 17:05:01 INFO - simpletestOnerror@SimpleTest/SimpleTest.js:2063:18
[task 2020-09-09T17:05:01.633Z] 17:05:01 INFO - GECKO(1476) | MEMORY STAT | vsize 2594MB | residentFast 169MB | heapAllocated 11MB
[task 2020-09-09T17:05:01.634Z] 17:05:01 INFO - TEST-OK | http://mochi.test:8888/tests/dom/base/test/test_setting_opener.html | took 584ms

Please take a look.

Assignee: apavel → nobody
Status: ASSIGNED → NEW
Flags: needinfo?(mbrodesser)
Keywords: leave-open
Whiteboard: [stockwell disabled]
Flags: needinfo?(mbrodesser)
Flags: needinfo?(mbrodesser)

A passing run (on Try) emits the following:

[task 2020-09-08T09:07:25.278Z] 09:07:25     INFO - SimpleTest START
[task 2020-09-08T09:07:25.299Z] 09:07:25     INFO - TEST-START | http://mochi.test:8888/tests/dom/base/test/test_setting_opener.html
[task 2020-09-08T09:07:26.450Z] 09:07:26     INFO - GECKO(1471) | [1841, Unnamed thread 7efea815d5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-08T09:07:26.451Z] 09:07:26     INFO - GECKO(1471) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpkGGVZx.mozrunner/runtests_leaks.log
[task 2020-09-08T09:07:26.452Z] 09:07:26     INFO - GECKO(1471) | [1841, Unnamed thread 7efea815d5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-08T09:07:26.452Z] 09:07:26     INFO - GECKO(1471) | [1841, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp, line 246
[task 2020-09-08T09:07:26.617Z] 09:07:26     INFO - GECKO(1471) | [Child 1841, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp, line 626
[task 2020-09-08T09:07:26.968Z] 09:07:26     INFO - GECKO(1471) | [Child 1754, Main Thread] WARNING: '!topWindow', file /builds/worker/checkouts/gecko/dom/html/HTMLIFrameElement.cpp, line 241
[task 2020-09-08T09:07:26.969Z] 09:07:26     INFO - GECKO(1471) | [Child 1754, Main Thread] WARNING: '!topWindow', file /builds/worker/checkouts/gecko/dom/html/HTMLIFrameElement.cpp, line 241
[task 2020-09-08T09:07:26.972Z] 09:07:26     INFO - GECKO(1471) | [Child 1754, Main Thread] WARNING: '!topWindow', file /builds/worker/checkouts/gecko/dom/html/HTMLIFrameElement.cpp, line 241
[task 2020-09-08T09:07:30.891Z] 09:07:30     INFO - GECKO(1471) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2020-09-08T09:07:30.892Z] 09:07:30     INFO - GECKO(1471) | MEMORY STAT | vsize 2553MB | residentFast 149MB | heapAllocated 9MB
[task 2020-09-08T09:07:30.953Z] 09:07:30     INFO - TEST-OK | http://mochi.test:8888/tests/dom/base/test/test_setting_opener.html | took 5656ms

A failing run emitted:

[task 2020-08-18T10:55:26.508Z] 10:55:26     INFO - TEST-START | http://mochi.test:8888/tests/dom/base/test/test_setting_opener.html
[task 2020-08-18T10:55:26.616Z] 10:55:26     INFO - GECKO(1473) | [Child 18170, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-08-18T10:55:26.646Z] 10:55:26     INFO - GECKO(1473) | [Child 18170, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp, line 4343
[task 2020-08-18T10:55:26.666Z] 10:55:26     INFO -  JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-08-18T10:55:26.677Z] 10:55:26     INFO -  JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-08-18T10:55:26.678Z] 10:55:26     INFO -  JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-08-18T10:55:26.783Z] 10:55:26     INFO - GECKO(1473) | [18279, Unnamed thread 7f88ab95d5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-08-18T10:55:26.784Z] 10:55:26     INFO - GECKO(1473) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpmFlxwk.mozrunner/runtests_leaks.log
[task 2020-08-18T10:55:26.785Z] 10:55:26     INFO - GECKO(1473) | [18279, Unnamed thread 7f88ab95d5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-08-18T10:55:26.787Z] 10:55:26     INFO - GECKO(1473) | [18279, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp, line 246
[task 2020-08-18T10:55:26.802Z] 10:55:26     INFO - GECKO(1473) | [Parent 1473, QuotaManager IO] WARNING: '!outputStream', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 2482
[task 2020-08-18T10:55:26.803Z] 10:55:26     INFO - GECKO(1473) | [Parent 1473, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8504
[task 2020-08-18T10:55:26.804Z] 10:55:26     INFO - GECKO(1473) | [Parent 1473, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8363
[task 2020-08-18T10:55:26.805Z] 10:55:26     INFO - GECKO(1473) | [Parent 1473, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8273
[task 2020-08-18T10:55:26.806Z] 10:55:26     INFO - GECKO(1473) | [Parent 1473, QuotaManager IO] WARNING: '!outputStream', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 2482
[task 2020-08-18T10:55:26.806Z] 10:55:26     INFO - GECKO(1473) | [Parent 1473, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8504
[task 2020-08-18T10:55:26.807Z] 10:55:26     INFO - GECKO(1473) | [Parent 1473, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8363
[task 2020-08-18T10:55:26.808Z] 10:55:26     INFO - GECKO(1473) | [Parent 1473, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8273
[task 2020-08-18T10:55:26.885Z] 10:55:26     INFO - GECKO(1473) | [Child 18197, Main Thread] WARNING: '!topWindow', file /builds/worker/checkouts/gecko/dom/html/HTMLIFrameElement.cpp, line 241
[task 2020-08-18T10:55:26.886Z] 10:55:26     INFO - GECKO(1473) | [Child 18197, Main Thread] WARNING: '!topWindow', file /builds/worker/checkouts/gecko/dom/html/HTMLIFrameElement.cpp, line 241
[task 2020-08-18T10:55:26.887Z] 10:55:26     INFO - GECKO(1473) | [Child 18197, Main Thread] WARNING: '!topWindow', file /builds/worker/checkouts/gecko/dom/html/HTMLIFrameElement.cpp, line 241
[task 2020-08-18T10:55:26.936Z] 10:55:26     INFO - GECKO(1473) | [Child 18279, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp, line 626
[task 2020-08-18T10:55:27.012Z] 10:55:27     INFO - GECKO(1473) | JavaScript error: resource://specialpowers/WrapPrivileged.jsm, line 231: NS_ERROR_ILLEGAL_VALUE: Illegal value
[task 2020-08-18T10:55:27.070Z] 10:55:27     INFO - TEST-INFO | started process screentopng
[task 2020-08-18T10:55:27.164Z] 10:55:27     INFO -  JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:

Hence I'm wondering, if the failure is related to the error emitted from <httpd.js>.

Edit: presumably not, because other tests emitted the same error message(s) but passed. E.g.:

[task 2020-08-18T10:52:23.053Z] 10:52:23     INFO - TEST-START | http://mochi.test:8888/tests/dom/base/test/test_eventsourceservice_basic.html
[task 2020-08-18T10:52:23.054Z] 10:52:23     INFO -  JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-08-18T10:52:23.195Z] 10:52:23     INFO - GECKO(1473) | [Child 13892, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-08-18T10:52:23.276Z] 10:52:23     INFO - GECKO(1473) | [14001, Unnamed thread 7f7da775d5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-08-18T10:52:23.277Z] 10:52:23     INFO - GECKO(1473) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpmFlxwk.mozrunner/runtests_leaks.log
[task 2020-08-18T10:52:23.277Z] 10:52:23     INFO - GECKO(1473) | [14001, Unnamed thread 7f7da775d5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-08-18T10:52:23.280Z] 10:52:23     INFO - GECKO(1473) | [Child 13892, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp, line 4343
[task 2020-08-18T10:52:23.282Z] 10:52:23     INFO - GECKO(1473) | [14001, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp, line 246
[task 2020-08-18T10:52:23.351Z] 10:52:23     INFO - GECKO(1473) | [Parent 1473, QuotaManager IO] WARNING: '!outputStream', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 2482
[task 2020-08-18T10:52:23.352Z] 10:52:23     INFO - GECKO(1473) | [Parent 1473, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8504
[task 2020-08-18T10:52:23.353Z] 10:52:23     INFO - GECKO(1473) | [Parent 1473, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8363
[task 2020-08-18T10:52:23.353Z] 10:52:23     INFO - GECKO(1473) | [Parent 1473, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8273
[task 2020-08-18T10:52:23.354Z] 10:52:23     INFO - GECKO(1473) | [Parent 1473, QuotaManager IO] WARNING: '!outputStream', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 2482
[task 2020-08-18T10:52:23.355Z] 10:52:23     INFO - GECKO(1473) | [Parent 1473, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8504
[task 2020-08-18T10:52:23.356Z] 10:52:23     INFO - GECKO(1473) | [Parent 1473, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8363
[task 2020-08-18T10:52:23.359Z] 10:52:23     INFO - GECKO(1473) | [Parent 1473, QuotaManager IO] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp, line 8273
[task 2020-08-18T10:52:23.536Z] 10:52:23     INFO - GECKO(1473) | [Child 14001, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp, line 626
[task 2020-08-18T10:52:23.557Z] 10:52:23     INFO -  JavaScript error: /builds/worker/workspace/build/tests/bin/components/httpd.js, line 3829: NS_ERROR_NOT_AVAILABLE:
[task 2020-08-18T10:52:23.557Z] 10:52:23     INFO - GECKO(1473) | MEMORY STAT | vsize 2592MB | residentFast 167MB | heapAllocated 11MB
[task 2020-08-18T10:52:23.577Z] 10:52:23     INFO - TEST-OK | http://mochi.test:8888/tests/dom/base/test/test_eventsourceservice_basic.html | took 524ms

Presumably, window.open returns null which doesn't lead to an error for the first call of the Sandbox constructor, because there's a null check (Thanks, Nika).
The second call of Sandbox( fails, because an array with element null is passed to it.

Next step is to determine why window.open( returned null.

Assignee: nobody → kmaglione+bmo
Status: NEW → ASSIGNED

MOZ_CHAOSMODE=1 when executing the single test didn't reproduce the failure locally.

However, managed to reproduce the failure locally by running the tests starting from (including) "dom/base/test/test_popup_middle_click.html".

After some bisecting and experiments: executing only "dom/base/test/test_popup_middle_click.html" before "test_popup_middle_click.html" suffices to reproduce the issue locally. Uploaded a rr trace to Pernosco, will post the link asap.

Edit: still waiting for the e-mail from Pernosco.

A Pernosco run.

:kmag: since you're assigned to this bug, are you actively working on it (would like to avoid duplicate work)?

Flags: needinfo?(kmaglione+bmo)

Yes, I'm working on it. It's just a bug in the SpecialPowers pushPermissions code.

Flags: needinfo?(kmaglione+bmo)

Yes, I'm working on it. It's just a bug in the SpecialPowers pushPermissions code.

:kmag: then bug 1659963 could be relevant too.

See Also: → 1659963
Priority: -- → P2
Whiteboard: ETA: 9/15

Some tests rely on SpecialPowers.pushPermissions/popPermissions/flushPermissions
operating on the same permissions stack no matter the SpecialPowers instance
they're called on. This works when all of those SpeicalPowers instances are in
the same process, but with out-of-process Fision frames, that isn't always the
case.

This patch updates the permission stack code to operate the same way as the
preference stack code, which was already updated to deal with this issue.

Pushed by maglione.k@gmail.com:
https://hg.mozilla.org/integration/autoland/rev/c11d55092b40
Fix red herring httpd.js error messages. r=nika
Blocks: 1659963
Pushed by maglione.k@gmail.com:
https://hg.mozilla.org/integration/autoland/rev/11889335ffb3
Fix red herring httpd.js error messages. r=nika
Whiteboard: ETA: 9/15 → patch in review
Flags: needinfo?(mbrodesser)
Status: ASSIGNED → RESOLVED
Closed: 4 years ago
Resolution: --- → FIXED
Target Milestone: --- → 82 Branch
Status: RESOLVED → REOPENED
Resolution: FIXED → ---
Target Milestone: 82 Branch → ---
Pushed by maglione.k@gmail.com:
https://hg.mozilla.org/integration/autoland/rev/761ef7b1a349
Make SpecialPowers.pushPermissions Fission-compatible. r=mccr8
Whiteboard: patch in review
Status: REOPENED → RESOLVED
Closed: 4 years ago4 years ago
Resolution: --- → FIXED
Target Milestone: --- → 82 Branch
Flags: needinfo?(kmaglione+bmo)
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: