Closed Bug 1712132 Opened 3 years ago Closed 3 years ago

Intermittent [tier2] TV browser/components/sessionstore/test/browser_sessionStorage.js | Uncaught exception - SecurityError: Permission denied to access property "sessionStorage" on cross-origin object

Categories

(Firefox :: Session Restore, defect, P5)

Product:
Firefox
Component:
Session Restore
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE
Tracking Flags:
Tracking Status
firefox-esr78 --- unaffected
firefox88 --- unaffected
firefox89 --- unaffected
firefox90 --- affected

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Regression)

Details

(Keywords: intermittent-failure, regression)

Filed by: abutkovits [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=340320655&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/fcJLATs8Ry-70QZObtnxqg/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/fcJLATs8Ry-70QZObtnxqg/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

[task 2021-05-20T14:27:49.728Z] 14:27:49     INFO -  'PATH': '/builds/worker/workspace/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/builds/worker/bin',
[task 2021-05-20T14:27:49.728Z] 14:27:49     INFO -  'PWD': '/builds/worker/workspace',
[task 2021-05-20T14:27:49.728Z] 14:27:49     INFO -  'RUN_ID': '0',
[task 2021-05-20T14:27:49.729Z] 14:27:49     INFO -  'RUST_BACKTRACE': 'full',
[task 2021-05-20T14:27:49.730Z] 14:27:49     INFO -  'SCCACHE_DISABLE': '1',
[task 2021-05-20T14:27:49.730Z] 14:27:49     INFO -  'SHELL': '/bin/bash',
[task 2021-05-20T14:27:49.730Z] 14:27:49     INFO -  'SHLVL': '1',
[task 2021-05-20T14:27:49.730Z] 14:27:49     INFO -  'STYLO_THREADS': '4',
[task 2021-05-20T14:27:49.730Z] 14:27:49     INFO -  'TASKCLUSTER_INSTANCE_TYPE': 'm5.large',
[task 2021-05-20T14:27:49.730Z] 14:27:49     INFO -  'TASKCLUSTER_NAME': '/trusting_gates/taskcluster',
[task 2021-05-20T14:27:49.730Z] 14:27:49     INFO -  'TASKCLUSTER_PORT': 'tcp://172.17.0.2:80',
[task 2021-05-20T14:27:49.731Z] 14:27:49     INFO -  'TASKCLUSTER_PORT_80_TCP': 'tcp://172.17.0.2:80',
[task 2021-05-20T14:27:49.731Z] 14:27:49     INFO -  'TASKCLUSTER_PORT_80_TCP_ADDR': '172.17.0.2',
[task 2021-05-20T14:27:49.731Z] 14:27:49     INFO -  'TASKCLUSTER_PORT_80_TCP_PORT': '80',
[task 2021-05-20T14:27:49.732Z] 14:27:49     INFO -  'TASKCLUSTER_PORT_80_TCP_PROTO': 'tcp',
[task 2021-05-20T14:27:49.733Z] 14:27:49     INFO -  'TASKCLUSTER_PROXY_URL': 'http://taskcluster',
[task 2021-05-20T14:27:49.733Z] 14:27:49     INFO -  'TASKCLUSTER_PUBLIC_IP': '54.177.64.85',
[task 2021-05-20T14:27:49.733Z] 14:27:49     INFO -  'TASKCLUSTER_ROOT_URL': 'https://firefox-ci-tc.services.mozilla.com',
[task 2021-05-20T14:27:49.734Z] 14:27:49     INFO -  'TASKCLUSTER_WORKER_GROUP': 'us-west-1',
[task 2021-05-20T14:27:49.734Z] 14:27:49     INFO -  'TASKCLUSTER_WORKER_LOCATION': '{"availabilityZone":"us-west-1b","cloud":"aws","region":"us-west-1"}',
[task 2021-05-20T14:27:49.736Z] 14:27:49     INFO -  'TASKCLUSTER_WORKER_TYPE': 't-linux-large',
[task 2021-05-20T14:27:49.736Z] 14:27:49     INFO -  'TASK_ID': 'fcJLATs8Ry-70QZObtnxqg',
[task 2021-05-20T14:27:49.736Z] 14:27:49     INFO -  'TERM': 'xterm',
[task 2021-05-20T14:27:49.736Z] 14:27:49     INFO -  'TEST_SUITE': 'mochitest-browser-chrome',
[task 2021-05-20T14:27:49.736Z] 14:27:49     INFO -  'TOOLTOOL_CACHE': '/builds/worker/tooltool-cache',
[task 2021-05-20T14:27:49.737Z] 14:27:49     INFO -  'USER': 'worker',
[task 2021-05-20T14:27:49.737Z] 14:27:49     INFO -  'VIRTUAL_ENV': '/builds/worker/workspace/build/venv',
[task 2021-05-20T14:27:49.737Z] 14:27:49     INFO -  'WORKING_DIR': '/builds/worker'}
[task 2021-05-20T14:27:49.737Z] 14:27:49     INFO - Calling ['/builds/worker/workspace/build/venv/bin/python', '-u', '/builds/worker/workspace/build/tests/mochitest/runtests.py', '--enable-webrender', '--setpref=fission.autostart=true', '--setpref=dom.serviceWorkers.parent_intercept=true', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', '--setpref=layers.d3d11.enable-blacklist=false', '--appname=/builds/worker/workspace/build/application/firefox/firefox', '--utility-path=tests/bin', '--extra-profile-file=tests/bin/plugins', u'--symbols-path=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/B3x1IckcSbC_kxaZ-O4RCg/artifacts/public/build/target.crashreporter-symbols.zip', '--certificate-path=tests/certs', '--setpref=webgl.force-enabled=true', '--quiet', '--log-raw=/builds/worker/workspace/build/blobber_upload_dir/mochitest-browser-chrome-test1_raw.log', '--log-errorsummary=/builds/worker/workspace/build/blobber_upload_dir/mochitest-browser-chrome-test1_errorsummary.log', '--use-test-media-devices', '--screenshot-on-fail', '--cleanup-crashes', '--marionette-startup-timeout=180', '--sandbox-read-whitelist=/builds/worker/workspace/build', '--log-raw=-', '--flavor=browser', '--chunk-by-runtime', '--verify-max-time=900', '--verify', u'browser/components/sessionstore/test/browser_sessionStorage.js'] with output_timeout 1000
[task 2021-05-20T14:27:50.001Z] 14:27:50     INFO - :::
[task 2021-05-20T14:27:50.001Z] 14:27:50     INFO - ::: Running test verification step "1. Run each test 10 times in one browser."...
[task 2021-05-20T14:27:50.001Z] 14:27:50     INFO - :::
[task 2021-05-20T14:27:50.001Z] 14:27:50     INFO - Checking for ssltunnel processes...
[task 2021-05-20T14:27:50.008Z] 14:27:50     INFO - Checking for xpcshell processes...
[task 2021-05-20T14:27:50.225Z] 14:27:50     INFO - SUITE-START | Running 1 tests
[task 2021-05-20T14:27:50.225Z] 14:27:50     INFO - Running manifest: browser/components/sessionstore/test/browser.ini
[task 2021-05-20T14:27:50.225Z] 14:27:50     INFO - The following extra prefs will be set:
[task 2021-05-20T14:27:50.225Z] 14:27:50     INFO -   network.cookie.cookieBehavior=5
[task 2021-05-20T14:27:50.226Z] 14:27:50     INFO -   gfx.font_rendering.fallback.async=false
[task 2021-05-20T14:27:50.326Z] 14:27:50     INFO -  error: XDG_RUNTIME_DIR not set in the environment.
[task 2021-05-20T14:27:50.447Z] 14:27:50     INFO -  Setting pipeline to PAUSED ...
[task 2021-05-20T14:27:50.447Z] 14:27:50     INFO -  Pipeline is PREROLLING ...
[task 2021-05-20T14:27:50.448Z] 14:27:50     INFO -  Pipeline is PREROLLED ...
[task 2021-05-20T14:27:50.448Z] 14:27:50     INFO -  Setting pipeline to PLAYING ...
[task 2021-05-20T14:27:50.448Z] 14:27:50     INFO -  New clock: GstSystemClock
[task 2021-05-20T14:27:50.484Z] 14:27:50     INFO -  Got EOS from element "pipeline0".
[task 2021-05-20T14:27:50.485Z] 14:27:50     INFO -  Execution ended after 0:00:00.033398114
[task 2021-05-20T14:27:50.486Z] 14:27:50     INFO -  Setting pipeline to PAUSED ...
[task 2021-05-20T14:27:50.487Z] 14:27:50     INFO -  Setting pipeline to READY ...
[task 2021-05-20T14:27:50.487Z] 14:27:50     INFO -  (gst-launch-1.0:1481): GStreamer-CRITICAL **: 14:27:50.478: gst_object_unref: assertion '((GObject *) object)->ref_count > 0' failed
[task 2021-05-20T14:27:50.487Z] 14:27:50     INFO -  Setting pipeline to NULL ...
[task 2021-05-20T14:27:50.487Z] 14:27:50     INFO -  Freeing pipeline ...
[task 2021-05-20T14:27:50.681Z] 14:27:50     INFO - PID 1498 | pk12util: PKCS12 IMPORT SUCCESSFUL
[task 2021-05-20T14:27:50.917Z] 14:27:50     INFO - MochitestServer : launching [u'/builds/worker/workspace/build/tests/bin/xpcshell', '-g', '/builds/worker/workspace/build/application/firefox', '-f', '/builds/worker/workspace/build/tests/bin/components/httpd.js', '-e', "const _PROFILE_PATH = '/tmp/tmpXwW3J7.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false;", '-f', '/builds/worker/workspace/build/tests/mochitest/server.js']
[task 2021-05-20T14:27:50.917Z] 14:27:50     INFO - runtests.py | Server pid: 1510
[task 2021-05-20T14:27:50.933Z] 14:27:50     INFO - runtests.py | Websocket server pid: 1513
[task 2021-05-20T14:27:50.948Z] 14:27:50     INFO - runtests.py | SSL tunnel pid: 1517
[task 2021-05-20T14:27:51.047Z] 14:27:51     INFO - runtests.py | Running with scheme: http
[task 2021-05-20T14:27:51.054Z] 14:27:51     INFO - runtests.py | Running with e10s: True
[task 2021-05-20T14:27:51.055Z] 14:27:51     INFO - runtests.py | Running with fission: True
[task 2021-05-20T14:27:51.056Z] 14:27:51     INFO - runtests.py | Running with cross-origin iframes: False
[task 2021-05-20T14:27:51.056Z] 14:27:51     INFO - runtests.py | Running with serviceworker_e10s: True
[task 2021-05-20T14:27:51.058Z] 14:27:51     INFO - runtests.py | Running with socketprocess_e10s: False
[task 2021-05-20T14:27:51.059Z] 14:27:51     INFO - runtests.py | Running tests: start.
[task 2021-05-20T14:27:51.059Z] 14:27:51     INFO - 
[task 2021-05-20T14:27:51.075Z] 14:27:51     INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox -marionette -foreground -profile /tmp/tmpXwW3J7.mozrunner
[task 2021-05-20T14:27:51.091Z] 14:27:51     INFO - runtests.py | Application pid: 1536
[task 2021-05-20T14:27:51.092Z] 14:27:51     INFO - TEST-INFO | started process GECKO(1536)
[task 2021-05-20T14:27:51.651Z] 14:27:51     INFO - GECKO(1536) | 1621520871640	Marionette	INFO	Marionette enabled
[task 2021-05-20T14:27:51.747Z] 14:27:51     INFO - GECKO(1536) | 1621520871734	Marionette	TRACE	Received observer notification toplevel-window-ready
[task 2021-05-20T14:27:55.714Z] 14:27:55     INFO - GECKO(1536) | console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at /tmp/tmpXwW3J7.mozrunner/search.json.mozlz4", (void 0)))
[task 2021-05-20T14:27:56.477Z] 14:27:56     INFO - GECKO(1536) | 1621520876471	Marionette	TRACE	Received observer notification marionette-startup-requested
[task 2021-05-20T14:27:56.477Z] 14:27:56     INFO - GECKO(1536) | 1621520876472	Marionette	TRACE	Waiting until startup recorder finished recording startup scripts...
[task 2021-05-20T14:27:56.493Z] 14:27:56     INFO - GECKO(1536) | 1621520876483	Marionette	TRACE	All scripts recorded.
[task 2021-05-20T14:27:56.494Z] 14:27:56     INFO - GECKO(1536) | 1621520876484	Marionette	INFO	Listening on port 2828
[task 2021-05-20T14:27:56.494Z] 14:27:56     INFO - GECKO(1536) | 1621520876484	Marionette	DEBUG	Marionette is listening
[task 2021-05-20T14:27:56.521Z] 14:27:56     INFO - GECKO(1536) | 1621520876515	Marionette	DEBUG	Accepted connection 0 from 127.0.0.1:46614
[task 2021-05-20T14:27:56.521Z] 14:27:56     INFO - GECKO(1536) | 1621520876518	Marionette	DEBUG	Closed connection 0
[task 2021-05-20T14:27:56.522Z] 14:27:56     INFO - GECKO(1536) | 1621520876519	Marionette	DEBUG	Accepted connection 1 from 127.0.0.1:46616
[task 2021-05-20T14:27:56.537Z] 14:27:56     INFO - GECKO(1536) | 1621520876529	Marionette	DEBUG	1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2021-05-20T14:27:56.552Z] 14:27:56     INFO - GECKO(1536) | 1621520876544	Marionette	DEBUG	1 <- [1,1,null,{"sessionId":"95ed0937-a3b1-41c6-b371-71750d3589b1","capabilities":{"browserName":"firefox","browserVersion":"90.0a ... 7.mozrunner","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true,"proxy":{}}}]
[task 2021-05-20T14:27:56.576Z] 14:27:56     INFO - GECKO(1536) | 1621520876573	Marionette	DEBUG	1 -> [0,2,"Addon:Install",{"path":"/tmp/tmpeZxAYj.zip","temporary":false}]
[task 2021-05-20T14:27:56.612Z] 14:27:56     INFO - GECKO(1536) | 1621520876607	Marionette	TRACE	[39] MarionetteEvents actor created for window id 22
[task 2021-05-20T14:27:56.758Z] 14:27:56     INFO - GECKO(1536) | 1621520876755	Marionette	DEBUG	1 <- [1,2,null,{"value":"special-powers@mozilla.org"}]
[task 2021-05-20T14:27:56.792Z] 14:27:56     INFO - GECKO(1536) | 1621520876786	Marionette	DEBUG	1 -> [0,3,"Addon:Install",{"path":"/tmp/tmpcN5Ojq.zip","temporary":false}]
[task 2021-05-20T14:27:56.833Z] 14:27:56     INFO - GECKO(1536) | 1621520876823	Marionette	DEBUG	1 <- [1,3,null,{"value":"mochikit@mozilla.org"}]
[task 2021-05-20T14:27:56.833Z] 14:27:56     INFO - GECKO(1536) | 1621520876824	Marionette	DEBUG	1 -> [0,4,"Marionette:GetContext",{}]
[task 2021-05-20T14:27:56.833Z] 14:27:56     INFO - GECKO(1536) | 1621520876824	Marionette	DEBUG	1 <- [1,4,null,{"value":"content"}]
[task 2021-05-20T14:27:56.833Z] 14:27:56     INFO - GECKO(1536) | 1621520876825	Marionette	DEBUG	1 -> [0,5,"Marionette:SetContext",{"value":"chrome"}]
[task 2021-05-20T14:27:56.833Z] 14:27:56     INFO - GECKO(1536) | 1621520876825	Marionette	DEBUG	1 <- [1,5,null,{"value":null}]
[task 2021-05-20T14:27:56.840Z] 14:27:56     INFO - GECKO(1536) | 1621520876834	Marionette	DEBUG	1 -> [0,6,"WebDriver:ExecuteScript",{"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, ... testUrl":"about:blank","flavor":"browser-chrome"}],"filename":"tests/mochitest/runtests.py","sandbox":"default","line":1935}]
[task 2021-05-20T14:27:56.841Z] 14:27:56     INFO - GECKO(1536) | 1621520876839	Marionette	TRACE	[7] MarionetteCommands actor created for window id 2
[task 2021-05-20T14:27:56.849Z] 14:27:56     INFO - GECKO(1536) | 1621520876847	Marionette	TRACE	[19] MarionetteEvents actor created for window id 2147483649
[task 2021-05-20T14:27:56.869Z] 14:27:56     INFO - GECKO(1536) | 1621520876862	Marionette	TRACE	Received observer notification toplevel-window-ready
[task 2021-05-20T14:27:56.870Z] 14:27:56     INFO - GECKO(1536) | 1621520876866	Marionette	DEBUG	1 <- [1,6,null,{"value":null}]
[task 2021-05-20T14:27:56.872Z] 14:27:56     INFO - GECKO(1536) | 1621520876867	Marionette	DEBUG	1 -> [0,7,"Marionette:SetContext",{"value":"content"}]
[task 2021-05-20T14:27:56.873Z] 14:27:56     INFO - GECKO(1536) | 1621520876867	Marionette	DEBUG	1 <- [1,7,null,{"value":null}]
[task 2021-05-20T14:27:56.875Z] 14:27:56     INFO - GECKO(1536) | 1621520876869	Marionette	DEBUG	1 -> [0,8,"WebDriver:DeleteSession",{}]
[task 2021-05-20T14:27:56.876Z] 14:27:56     INFO - GECKO(1536) | 1621520876872	Marionette	DEBUG	1 <- [1,8,null,{"value":null}]
[task 2021-05-20T14:27:56.877Z] 14:27:56     INFO - GECKO(1536) | JavaScript error: , line 0: NotFoundError: No such JSWindowActor 'MarionetteEvents'
[task 2021-05-20T14:27:56.892Z] 14:27:56     INFO - runtests.py | Waiting for browser...
[task 2021-05-20T14:27:56.920Z] 14:27:56     INFO - GECKO(1536) | 1621520876914	Marionette	DEBUG	Closed connection 1
[task 2021-05-20T14:27:57.704Z] 14:27:57     INFO - *** Start BrowserChrome Test Results ***
[task 2021-05-20T14:27:57.800Z] 14:27:57     INFO - checking window state
[task 2021-05-20T14:27:57.864Z] 14:27:57     INFO - TEST-START | browser/components/sessionstore/test/browser_sessionStorage.js
[task 2021-05-20T14:27:58.749Z] 14:27:58     INFO - TEST-INFO | started process screentopng
[task 2021-05-20T14:27:59.334Z] 14:27:59     INFO - TEST-INFO | screentopng: exit 0
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - Buffered messages logged at 14:27:57
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - Entering test bound session_storage
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - Buffered messages logged at 14:27:58
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - Console message: [JavaScript Error: "Unknown Collection "main/partitioning-exempt-urls"" {file: "resource://services-settings/RemoteSettingsClient.jsm" line: 160}]
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - UnknownCollectionError@resource://services-settings/RemoteSettingsClient.jsm:160:5
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - sync@resource://services-settings/RemoteSettingsClient.jsm:470:13
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - 
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - TEST-PASS | browser/components/sessionstore/test/browser_sessionStorage.js | sessionStorage data for example.com has been serialized correctly - 
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - TEST-PASS | browser/components/sessionstore/test/browser_sessionStorage.js | sessionStorage data for mochi.test has been serialized correctly - 
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://example.com/browser/browser/components/sessionstore/test/browser_sessionStorage.html?0.6570436727321457” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://example.com/browser/browser/components/sessionstore/test/browser_sessionStorage.html?0.6570436727321457” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - Buffered messages finished
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_sessionStorage.js | Uncaught exception - SecurityError: Permission denied to access property "sessionStorage" on cross-origin object
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - Stack trace:
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - @chrome://mochitests/content/browser/browser/components/sessionstore/test/head.js:563:21
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - execute@resource://specialpowers/SpecialPowersSandbox.jsm:141:12
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - _spawnTask@resource://specialpowers/SpecialPowersChild.jsm:1604:15
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - receiveMessage@resource://specialpowers/SpecialPowersChild.jsm:310:21
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - Leaving test bound session_storage
[task 2021-05-20T14:27:59.335Z] 14:27:59     INFO - Entering test bound purge_domain
[task 2021-05-20T14:27:59.472Z] 14:27:59     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://example.com/browser/browser/components/sessionstore/test/browser_sessionStorage.html?0.6570436727321457” because it is loaded in the third-party context and dynamic state partitioning is enabled."]
[task 2021-05-20T14:27:59.473Z] 14:27:59     INFO - Console message: [JavaScript Warning: "Partitioned cookie or storage access was provided to “http://example.com/browser/browser/components/sessionstore/test/browser_sessionStorage.html?0.6570436727321457” because it is loaded in the third-party context and dynamic state partitioning is enabled."]```
Regressed by: 1700623
Has Regression Range: --- → yes

Set release status flags based on info from the regressing bug 1700623

status-firefox88: --- → unaffected
status-firefox89: --- → unaffected
status-firefox90: --- → affected
status-firefox-esr78: --- → unaffected

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

Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.