Closed Bug 1780060 Opened 2 years ago Closed 2 years ago

Intermittent [tier2] arsenic.errors.UnknownArsenicError: ('Only supported in content context', None, 'RemoteError@chrome://remote/content/shared/RemoteError.jsm:12:1\nWebDriverError@chrome://remote/content/shared/webdriver/Errors.jsm:192

Categories

(Testing :: Condprofile, defect, P5)

defect

Tracking

(firefox104 fixed)

RESOLVED FIXED
104 Branch
Tracking Status
firefox104 --- fixed

People

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

Details

(Keywords: intermittent-failure, Whiteboard: [retriggered])

Attachments

(1 file)

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


[task 2022-07-18T16:12:07.462Z] 2022-07-18 16:12.07 [error    ] error                          data={'error': 'unsupported operation', 'message': 'Only supported in content context', 'stacktrace': 'RemoteError@chrome://remote/content/shared/RemoteError.jsm:12:1\nWebDriverError@chrome://remote/content/shared/webdriver/Errors.jsm:192:5\nUnsupportedOperationError@chrome://remote/content/shared/webdriver/Errors.jsm:530:5\nassert.that/<@chrome://remote/content/shared/webdriver/Assert.jsm:493:13\nassert.content@chrome://remote/content/shared/webdriver/Assert.jsm:122:4\nGeckoDriver.prototype.navigateTo@chrome://remote/content/marionette/driver.js:818:15\ndespatch@chrome://remote/content/marionette/server.js:304:40\nexecute@chrome://remote/content/marionette/server.js:277:16\nonPacket/<@chrome://remote/content/marionette/server.js:250:20\nonPacket@chrome://remote/content/marionette/server.js:251:9\n_onJSONObjectReady/<@chrome://remote/content/marionette/transport.js:502:20\n'} message=Only supported in content context stacktrace=RemoteError@chrome://remote/content/shared/RemoteError.jsm:12:1
[task 2022-07-18T16:12:07.462Z] WebDriverError@chrome://remote/content/shared/webdriver/Errors.jsm:192:5
[task 2022-07-18T16:12:07.462Z] UnsupportedOperationError@chrome://remote/content/shared/webdriver/Errors.jsm:530:5
[task 2022-07-18T16:12:07.462Z] assert.that/<@chrome://remote/content/shared/webdriver/Assert.jsm:493:13
[task 2022-07-18T16:12:07.462Z] assert.content@chrome://remote/content/shared/webdriver/Assert.jsm:122:4
[task 2022-07-18T16:12:07.462Z] GeckoDriver.prototype.navigateTo@chrome://remote/content/marionette/driver.js:818:15
[task 2022-07-18T16:12:07.462Z] despatch@chrome://remote/content/marionette/server.js:304:40
[task 2022-07-18T16:12:07.462Z] execute@chrome://remote/content/marionette/server.js:277:16
[task 2022-07-18T16:12:07.462Z] onPacket/<@chrome://remote/content/marionette/server.js:250:20
[task 2022-07-18T16:12:07.462Z] onPacket@chrome://remote/content/marionette/server.js:251:9
[task 2022-07-18T16:12:07.462Z] _onJSONObjectReady/<@chrome://remote/content/marionette/transport.js:502:20
[task 2022-07-18T16:12:07.462Z]  status=500 type=<class 'arsenic.errors.UnknownArsenicError'>
[task 2022-07-18T16:12:07.462Z] 2022-07-18 16:12.07 [info     ] request                        body=None headers={} method=DELETE url=http://localhost:49254/session/9e2d85bf-a0be-4c8e-8e56-d13b30b6cb7e
[task 2022-07-18T16:12:07.468Z] 2022-07-18 16:12.07 [info     ] response                       body={"context": "content"} data={'value': None} method=POST response=<ClientResponse(http://localhost:49254/session/9e2d85bf-a0be-4c8e-8e56-d13b30b6cb7e/moz/context) [200 OK]>
[task 2022-07-18T16:12:07.468Z] <CIMultiDictProxy('Content-Type': 'application/json; charset=utf-8', 'Cache-Control': 'no-cache', 'Content-Length': '14', 'Date': 'Mon, 18 Jul 2022 16:12:07 GMT')>
[task 2022-07-18T16:12:07.468Z]  url=http://localhost:49254/session/9e2d85bf-a0be-4c8e-8e56-d13b30b6cb7e/moz/context
[task 2022-07-18T16:12:14.693Z] 2022-07-18 16:12.14 [info     ] response                       body=None data={'value': None} method=DELETE response=<ClientResponse(http://localhost:49254/session/9e2d85bf-a0be-4c8e-8e56-d13b30b6cb7e) [200 OK]>
[task 2022-07-18T16:12:14.693Z] <CIMultiDictProxy('Content-Type': 'application/json; charset=utf-8', 'Cache-Control': 'no-cache', 'Content-Length': '14', 'Date': 'Mon, 18 Jul 2022 16:12:07 GMT')>
[task 2022-07-18T16:12:14.693Z]  url=http://localhost:49254/session/9e2d85bf-a0be-4c8e-8e56-d13b30b6cb7e
[task 2022-07-18T16:12:14.696Z] condprof ERROR | full scenario broke!
[task 2022-07-18T16:12:14.696Z] condprof INFO  | Could not run the scenario, probably a faulty scenario
[task 2022-07-18T16:12:14.698Z] condprof ERROR | full x condprof\..\condprof\customization\default.json failed.
[task 2022-07-18T16:12:14.698Z] Traceback (most recent call last):
[task 2022-07-18T16:12:14.698Z]   File "condprof\..\condprof\runner.py", line 172, in run_all
[task 2022-07-18T16:12:14.698Z]     res.append(await self.one_run(scenario, customization))
[task 2022-07-18T16:12:14.698Z]   File "condprof\..\condprof\runner.py", line 148, in one_run
[task 2022-07-18T16:12:14.698Z]     ).run(not self.visible)
[task 2022-07-18T16:12:14.698Z]   File "condprof\..\condprof\creator.py", line 100, in run
[task 2022-07-18T16:12:14.698Z]     metadata = await self.build_profile(device, headless)
[task 2022-07-18T16:12:14.698Z]   File "condprof\..\condprof\creator.py", line 190, in build_profile
[task 2022-07-18T16:12:14.698Z]     metadata.update(await scenario_func(session, options))
[task 2022-07-18T16:12:14.698Z]   File "condprof\..\condprof\scenarii\full.py", line 140, in full
[task 2022-07-18T16:12:14.698Z]     return await builder(session)
[task 2022-07-18T16:12:14.698Z]   File "condprof\..\condprof\scenarii\full.py", line 116, in __call__
[task 2022-07-18T16:12:14.698Z]     await self._visit_url(current, session, url, word)
[task 2022-07-18T16:12:14.698Z]   File "condprof\..\condprof\scenarii\full.py", line 100, in _visit_url
[task 2022-07-18T16:12:14.698Z]     await asyncio.wait_for(session.get(url), 5)
[task 2022-07-18T16:12:14.698Z]   File "c:\mozilla-build\python3\lib\asyncio\tasks.py", line 358, in wait_for
[task 2022-07-18T16:12:14.698Z]     return fut.result()
[task 2022-07-18T16:12:14.698Z]   File "c:\mozilla-build\python3\lib\site-packages\arsenic\session.py", line 139, in get
[task 2022-07-18T16:12:14.698Z]     await self._request(url="/url", method="POST", data={"url": self.bind + url})
[task 2022-07-18T16:12:14.698Z]   File "c:\mozilla-build\python3\lib\site-packages\arsenic\session.py", line 38, in _request
[task 2022-07-18T16:12:14.698Z]     self._check_response_error(status, data)
[task 2022-07-18T16:12:14.698Z]   File "c:\mozilla-build\python3\lib\site-packages\arsenic\session.py", line 45, in _check_response_error
[task 2022-07-18T16:12:14.698Z]     check_response_error(status, data)
[task 2022-07-18T16:12:14.698Z]   File "c:\mozilla-build\python3\lib\site-packages\arsenic\connection.py", line 39, in check_response_error
[task 2022-07-18T16:12:14.698Z]     errors.raise_exception(data, status)
[task 2022-07-18T16:12:14.698Z]   File "c:\mozilla-build\python3\lib\site-packages\arsenic\errors.py", line 105, in raise_exception
[task 2022-07-18T16:12:14.698Z]     raise exception_class(message, screen, stacktrace)
[task 2022-07-18T16:12:14.698Z] arsenic.errors.UnknownArsenicError: ('Only supported in content context', None, 'RemoteError@chrome://remote/content/shared/RemoteError.jsm:12:1\nWebDriverError@chrome://remote/content/shared/webdriver/Errors.jsm:192:5\nUnsupportedOperationError@chrome://remote/content/shared/webdriver/Errors.jsm:530:5\nassert.that/<@chrome://remote/content/shared/webdriver/Assert.jsm:493:13\nassert.content@chrome://remote/content/shared/webdriver/Assert.jsm:122:4\nGeckoDriver.prototype.navigateTo@chrome://remote/content/marionette/driver.js:818:15\ndespatch@chrome://remote/content/marionette/server.js:304:40\nexecute@chrome://remote/content/marionette/server.js:277:16\nonPacket/<@chrome://remote/content/marionette/server.js:250:20\nonPacket@chrome://remote/content/marionette/server.js:251:9\n_onJSONObjectReady/<@chrome://remote/content/marionette/transport.js:502:20\n')
[taskcluster 2022-07-18T16:12:14.794Z]    Exit Code: 4
[taskcluster 2022-07-18T16:12:14.794Z]    User Time: 0s
[taskcluster 2022-07-18T16:12:14.794Z]  Kernel Time: 15.625ms
[taskcluster 2022-07-18T16:12:14.794Z]    Wall Time: 56.5252923s
[taskcluster 2022-07-18T16:12:14.794Z]       Result: FAILED
[taskcluster 2022-07-18T16:12:14.794Z] === Task Finished ===
[taskcluster 2022-07-18T16:12:14.794Z] Task Duration: 56.5252923s
[taskcluster 2022-07-18T16:12:14.826Z] Uploading artifact public/condprof/geckodriver-full-default.log from file archive\geckodriver-full-default.log with content encoding "gzip", mime type "text/plain" and expiry 2023-07-18T16:03:04.964Z
[taskcluster 2022-07-18T16:12:15.352Z] Uploading link artifact public/logs/live.log to artifact public/logs/live_backing.log with expiry 2023-07-18T16:03:04.964Z
[taskcluster:error] exit status 4

Summary: Intermittent arsenic.errors.UnknownArsenicError: ('Only supported in content context', None, 'RemoteError@chrome://remote/content/shared/RemoteError.jsm:12:1\nWebDriverError@chrome://remote/content/shared/webdriver/Errors.jsm:192 → Intermittent [tier2] arsenic.errors.UnknownArsenicError: ('Only supported in content context', None, 'RemoteError@chrome://remote/content/shared/RemoteError.jsm:12:1\nWebDriverError@chrome://remote/content/shared/webdriver/Errors.jsm:192
Component: General → Condprofile
Product: Release Engineering → Testing
QA Contact: jlorenzo

Hi Joel! Can you please take a look at this?
This seems to start on this merge and the failure line changed here. They seem to have the same root cause.

Flags: needinfo?(jmaher)
Whiteboard: [retriggered]
Assignee: nobody → jmaher
Status: NEW → ASSIGNED

I feel like I am playing whack-a-mole; the errors don't make a lot of sense, so I am trying to catch them all, not raise them unnecessarily. It seems hard to reproduce this on try as the easy wins are already fixed.

Flags: needinfo?(jmaher)
Pushed by jmaher@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/a0dfa93bc399
reduce exceptions coming from condprof generation. r=sparky
Status: ASSIGNED → RESOLVED
Closed: 2 years ago
Resolution: --- → FIXED
Target Milestone: --- → 104 Branch
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: