Closed Bug 1737421 Opened 4 years ago Closed 3 years ago

Intermittent mozilla/tests/webdriver/send_alert_text.py | test_basic_auth_unsupported_operation - assert 404 == 500

Categories

(Testing :: General, defect, P5)

defect

Tracking

(Not tracked)

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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


Observed in today's central-as-early-beta simulation. The fail occurred only on OS X 10.15 WebRender Shippable opt.

<...>
[task 2021-10-23T14:09:06.656Z] 14:09:06     INFO - PID 5715 | 1634998146654	geckodriver::marionette	TRACE	Connection refused (os error 61). Retrying in 100ms
[task 2021-10-23T14:09:06.674Z] 14:09:06     INFO - PID 5715 | [GFX1-]: RenderCompositorSWGL failed mapping default framebuffer, no dt
[task 2021-10-23T14:09:06.690Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker PageActions: purging unregistered actions from cache for phase profile-before-change
[task 2021-10-23T14:09:06.691Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker Places Clients shutdown for phase profile-change-teardown
[task 2021-10-23T14:09:06.692Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker Places Connection shutdown for phase profile-before-change
[task 2021-10-23T14:09:06.697Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker sanitize.js: Sanitize on shutdown for phase Places Clients shutdown
[task 2021-10-23T14:09:06.757Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker ContentParent: id=16a7dce00 for phase xpcom-will-shutdown
[task 2021-10-23T14:09:06.758Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker ContentParent: id=16a7dce00 for phase profile-before-change
[task 2021-10-23T14:09:06.758Z] 14:09:06     INFO - PID 5715 | 1634998146756	geckodriver::marionette	TRACE	Connection refused (os error 61). Retrying in 100ms
[task 2021-10-23T14:09:06.772Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker Search service: shutting down for phase IOUtils: waiting for profileBeforeChange IO to complete
[task 2021-10-23T14:09:06.782Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker DoHController: clear state and remove observers for phase profile-before-change
[task 2021-10-23T14:09:06.787Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker Sqlite.jsm shutdown blocker for phase profile-before-change
[task 2021-10-23T14:09:06.788Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker places.sqlite#1: waiting for shutdown for phase Sqlite.jsm: wait until all connections are closed
[task 2021-10-23T14:09:06.789Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker Places Expiration: shutdown for phase Places Connection shutdown
[task 2021-10-23T14:09:06.790Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker PlacesUtils wrapped connection closing as part of Places shutdown for phase Places Connection shutdown
[task 2021-10-23T14:09:06.791Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker PlacesUtils wrapped connection must be closed before Sqlite.jsm for phase Sqlite.jsm: wait until all clients have completed their task
[task 2021-10-23T14:09:06.792Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker places.sqlite#1: PlacesExpiration.jsm: setup (0) for phase places.sqlite#1: waiting for clients
[task 2021-10-23T14:09:06.793Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker places.sqlite#0: waiting for shutdown for phase Sqlite.jsm: wait until all connections are closed
[task 2021-10-23T14:09:06.794Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker PlacesUtils read-only connection closing as part of Places shutdown for phase Places Connection shutdown
[task 2021-10-23T14:09:06.795Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker PlacesUtils read-only connection must be closed before Sqlite.jsm for phase Sqlite.jsm: wait until all clients have completed their task
[task 2021-10-23T14:09:06.796Z] 14:09:06     INFO - PID 5715 | DEBUG: Completed blocker places.sqlite#1: PlacesExpiration.jsm: setup (0) for phase places.sqlite#1: waiting for clients
[task 2021-10-23T14:09:06.818Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker Remote Settings profile-before-change for phase profile-before-change
[task 2021-10-23T14:09:06.876Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker JSON store: writing data for phase IOUtils: waiting for profileBeforeChange IO to complete
[task 2021-10-23T14:09:06.881Z] 14:09:06     INFO - PID 5715 | DEBUG: Adding blocker JSON store: writing data for phase IOUtils: waiting for profileBeforeChange IO to complete
[task 2021-10-23T14:09:06.974Z] 14:09:06     INFO - PID 5715 | 1634998146972	geckodriver::marionette	TRACE	Connection refused (os error 61). Retrying in 100ms
[task 2021-10-23T14:09:07.076Z] 14:09:07     INFO - PID 5715 | 1634998147075	geckodriver::marionette	TRACE	Connection refused (os error 61). Retrying in 100ms
[task 2021-10-23T14:09:07.292Z] 14:09:07     INFO - PID 5715 | DEBUG: Adding blocker content-prefs.sqlite#0: waiting for shutdown for phase Sqlite.jsm: wait until all connections are closed
[task 2021-10-23T14:09:07.293Z] 14:09:07     INFO - PID 5715 | DEBUG: Adding blocker Closing ContentPrefService2 connection. for phase Sqlite.jsm: wait until all clients have completed their task
[task 2021-10-23T14:09:07.294Z] 14:09:07     INFO - PID 5715 | DEBUG: Adding blocker Transaction (0) for phase content-prefs.sqlite#0: waiting for clients
[task 2021-10-23T14:09:07.296Z] 14:09:07     INFO - PID 5715 | DEBUG: Completed blocker Transaction (0) for phase content-prefs.sqlite#0: waiting for clients
[task 2021-10-23T14:09:07.296Z] 14:09:07     INFO - PID 5715 | 1634998147294	Marionette	TRACE	Received observer notification marionette-startup-requested
[task 2021-10-23T14:09:07.297Z] 14:09:07     INFO - PID 5715 | 1634998147294	Marionette	TRACE	Waiting until startup recorder finished recording startup scripts...
[task 2021-10-23T14:09:07.302Z] 14:09:07     INFO - PID 5715 | console.error: BackgroundUpdate:
[task 2021-10-23T14:09:07.303Z] 14:09:07     INFO - PID 5715 |   _reasonsToNotScheduleUpdates: Failed to check for Maintenance Service Registry Key: [Exception... "Component returned failure code: 0x80004001 (NS_ERROR_NOT_IMPLEMENTED) [nsIUpdateProcessor.getServiceRegKeyExists]"  nsresult: "0x80004001 (NS_ERROR_NOT_IMPLEMENTED)"  location: "JS frame :: resource://gre/modules/BackgroundUpdate.jsm :: _reasonsToNotScheduleUpdates :: line 243"  data: no]
[task 2021-10-23T14:09:07.306Z] 14:09:07     INFO - PID 5715 | 1634998147305	Marionette	TRACE	All scripts recorded.
[task 2021-10-23T14:09:07.307Z] 14:09:07     INFO - PID 5715 | 1634998147305	Marionette	INFO	Listening on port 2828
[task 2021-10-23T14:09:07.307Z] 14:09:07     INFO - PID 5715 | 1634998147306	Marionette	DEBUG	Marionette is listening
[task 2021-10-23T14:09:07.314Z] 14:09:07     INFO - PID 5715 | 1634998147313	Marionette	DEBUG	Accepted connection 0 from 127.0.0.1:61399
<...>
[task 2021-10-23T14:09:07.878Z] 14:09:07     INFO - STDOUT: FAILED
[task 2021-10-23T14:09:07.879Z] 14:09:07     INFO - PID 5715 | 1634998147877	webdriver::server	DEBUG	-> POST /session/00fc6644-a87e-40e7-816c-c78b0e22042c/timeouts {"implicit": 0}
[task 2021-10-23T14:09:07.879Z] 14:09:07     INFO - PID 5715 | 1634998147878	Marionette	DEBUG	0 -> [0,6,"WebDriver:SetTimeouts",{"implicit":0}]
[task 2021-10-23T14:09:07.880Z] 14:09:07     INFO - PID 5715 | 1634998147878	Marionette	DEBUG	0 <- [1,6,null,{"value":null}]
[task 2021-10-23T14:09:07.881Z] 14:09:07     INFO - PID 5715 | 1634998147878	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2021-10-23T14:09:07.882Z] 14:09:07     INFO - PID 5715 | 1634998147879	webdriver::server	DEBUG	-> POST /session/00fc6644-a87e-40e7-816c-c78b0e22042c/timeouts {"pageLoad": 300000}
[task 2021-10-23T14:09:07.883Z] 14:09:07     INFO - PID 5715 | 1634998147879	Marionette	DEBUG	0 -> [0,7,"WebDriver:SetTimeouts",{"pageLoad":300000}]
[task 2021-10-23T14:09:07.883Z] 14:09:07     INFO - PID 5715 | 1634998147880	Marionette	DEBUG	0 <- [1,7,null,{"value":null}]
[task 2021-10-23T14:09:07.884Z] 14:09:07     INFO - PID 5715 | 1634998147880	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2021-10-23T14:09:07.885Z] 14:09:07     INFO - PID 5715 | 1634998147881	webdriver::server	DEBUG	-> POST /session/00fc6644-a87e-40e7-816c-c78b0e22042c/timeouts {"script": 30000}
[task 2021-10-23T14:09:07.886Z] 14:09:07     INFO - PID 5715 | 1634998147881	Marionette	DEBUG	0 -> [0,8,"WebDriver:SetTimeouts",{"script":30000}]
[task 2021-10-23T14:09:07.887Z] 14:09:07     INFO - PID 5715 | 1634998147881	Marionette	DEBUG	0 <- [1,8,null,{"value":null}]
[task 2021-10-23T14:09:07.888Z] 14:09:07     INFO - PID 5715 | 1634998147881	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2021-10-23T14:09:07.888Z] 14:09:07     INFO - PID 5715 | 1634998147882	webdriver::server	DEBUG	-> GET /session/00fc6644-a87e-40e7-816c-c78b0e22042c/window
[task 2021-10-23T14:09:07.889Z] 14:09:07     INFO - PID 5715 | 1634998147882	Marionette	DEBUG	0 -> [0,9,"WebDriver:GetWindowHandle",{}]
[task 2021-10-23T14:09:07.890Z] 14:09:07     INFO - PID 5715 | 1634998147883	Marionette	DEBUG	0 <- [1,9,null,{"value":"0f473bfe-6634-414c-9cd4-1a8c12870e0a"}]
[task 2021-10-23T14:09:07.891Z] 14:09:07     INFO - PID 5715 | 1634998147883	webdriver::server	DEBUG	<- 200 OK {"value":"0f473bfe-6634-414c-9cd4-1a8c12870e0a"}
[task 2021-10-23T14:09:07.892Z] 14:09:07     INFO - PID 5715 | 1634998147883	webdriver::server	DEBUG	-> GET /session/00fc6644-a87e-40e7-816c-c78b0e22042c/window
[task 2021-10-23T14:09:07.893Z] 14:09:07     INFO - PID 5715 | 1634998147884	Marionette	DEBUG	0 -> [0,10,"WebDriver:GetWindowHandle",{}]
[task 2021-10-23T14:09:07.894Z] 14:09:07     INFO - PID 5715 | 1634998147884	Marionette	DEBUG	0 <- [1,10,null,{"value":"0f473bfe-6634-414c-9cd4-1a8c12870e0a"}]
[task 2021-10-23T14:09:07.894Z] 14:09:07     INFO - PID 5715 | 1634998147884	webdriver::server	DEBUG	<- 200 OK {"value":"0f473bfe-6634-414c-9cd4-1a8c12870e0a"}
[task 2021-10-23T14:09:07.895Z] 14:09:07     INFO - PID 5715 | 1634998147885	webdriver::server	DEBUG	-> GET /session/00fc6644-a87e-40e7-816c-c78b0e22042c/window/handles
[task 2021-10-23T14:09:07.896Z] 14:09:07     INFO - PID 5715 | 1634998147885	Marionette	DEBUG	0 -> [0,11,"WebDriver:GetWindowHandles",{}]
[task 2021-10-23T14:09:07.897Z] 14:09:07     INFO - PID 5715 | 1634998147886	Marionette	DEBUG	0 <- [1,11,null,["0f473bfe-6634-414c-9cd4-1a8c12870e0a"]]
[task 2021-10-23T14:09:07.898Z] 14:09:07     INFO - PID 5715 | 1634998147886	webdriver::server	DEBUG	<- 200 OK {"value":["0f473bfe-6634-414c-9cd4-1a8c12870e0a"]}
[task 2021-10-23T14:09:07.899Z] 14:09:07     INFO - PID 5715 | 1634998147887	webdriver::server	DEBUG	-> POST /session/00fc6644-a87e-40e7-816c-c78b0e22042c/window {"handle": "0f473bfe-6634-414c-9cd4-1a8c12870e0a"}
[task 2021-10-23T14:09:07.900Z] 14:09:07     INFO - PID 5715 | 1634998147887	Marionette	DEBUG	0 -> [0,12,"WebDriver:SwitchToWindow",{"handle":"0f473bfe-6634-414c-9cd4-1a8c12870e0a"}]
[task 2021-10-23T14:09:07.900Z] 14:09:07     INFO - PID 5715 | 1634998147887	Marionette	DEBUG	0 <- [1,12,null,{"value":null}]
[task 2021-10-23T14:09:07.901Z] 14:09:07     INFO - PID 5715 | 1634998147887	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2021-10-23T14:09:07.902Z] 14:09:07     INFO - PID 5715 | 1634998147888	webdriver::server	DEBUG	-> POST /session/00fc6644-a87e-40e7-816c-c78b0e22042c/alert/dismiss {}
[task 2021-10-23T14:09:07.903Z] 14:09:07     INFO - PID 5715 | 1634998147889	Marionette	DEBUG	0 -> [0,13,"WebDriver:DismissAlert",{}]
[task 2021-10-23T14:09:07.904Z] 14:09:07     INFO - PID 5715 | 1634998147889	Marionette	DEBUG	0 <- [1,13,{"error":"no such alert","message":"","stacktrace":"WebDriverError@chrome://remote/content/shared/webdriver/Errors.jsm: ... ote/content/marionette/server.js:253:9\n_onJSONObjectReady/<@chrome://remote/content/marionette/transport.js:500:20\n"},null]
[task 2021-10-23T14:09:07.905Z] 14:09:07     INFO - PID 5715 | 1634998147889	webdriver::server	DEBUG	<- 404 Not Found {"value":{"error":"no such alert","message":"","stacktrace":"WebDriverError@chrome://remote/content/shared/webdriver/Errors.jsm:181:5\nNoSuchAlertError@chrome://remote/content/shared/webdriver/Errors.jsm:382:5\nGeckoDriver.prototype._checkIfAlertIsPresent@chrome://remote/content/marionette/driver.js:2496:11\nGeckoDriver.prototype.dismissDialog@chrome://remote/content/marionette/driver.js:2397:8\ndespatch@chrome://remote/content/marionette/server.js:306:40\nexecute@chrome://remote/content/marionette/server.js:279:16\nonPacket/<@chrome://remote/content/marionette/server.js:252:20\nonPacket@chrome://remote/content/marionette/server.js:253:9\n_onJSONObjectReady/<@chrome://remote/content/marionette/transport.js:500:20\n"}}
[task 2021-10-23T14:09:07.906Z] 14:09:07     INFO - PID 5715 | 1634998147890	webdriver::server	DEBUG	-> POST /session/00fc6644-a87e-40e7-816c-c78b0e22042c/window {"handle": "0f473bfe-6634-414c-9cd4-1a8c12870e0a"}
[task 2021-10-23T14:09:07.907Z] 14:09:07     INFO - PID 5715 | 1634998147890	Marionette	DEBUG	0 -> [0,14,"WebDriver:SwitchToWindow",{"handle":"0f473bfe-6634-414c-9cd4-1a8c12870e0a"}]
[task 2021-10-23T14:09:07.908Z] 14:09:07     INFO - PID 5715 | 1634998147890	Marionette	DEBUG	0 <- [1,14,null,{"value":null}]
[task 2021-10-23T14:09:07.908Z] 14:09:07     INFO - PID 5715 | 1634998147890	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2021-10-23T14:09:07.909Z] 14:09:07     INFO - PID 5715 | 1634998147891	webdriver::server	DEBUG	-> GET /session/00fc6644-a87e-40e7-816c-c78b0e22042c/window
[task 2021-10-23T14:09:07.910Z] 14:09:07     INFO - PID 5715 | 1634998147891	Marionette	DEBUG	0 -> [0,15,"WebDriver:GetWindowHandle",{}]
[task 2021-10-23T14:09:07.910Z] 14:09:07     INFO - PID 5715 | 1634998147891	Marionette	DEBUG	0 <- [1,15,null,{"value":"0f473bfe-6634-414c-9cd4-1a8c12870e0a"}]
[task 2021-10-23T14:09:07.911Z] 14:09:07     INFO - PID 5715 | 1634998147892	webdriver::server	DEBUG	<- 200 OK {"value":"0f473bfe-6634-414c-9cd4-1a8c12870e0a"}
[task 2021-10-23T14:09:07.912Z] 14:09:07     INFO - PID 5715 | 1634998147892	webdriver::server	DEBUG	-> GET /session/00fc6644-a87e-40e7-816c-c78b0e22042c/window/handles
[task 2021-10-23T14:09:07.913Z] 14:09:07     INFO - PID 5715 | 1634998147893	Marionette	DEBUG	0 -> [0,16,"WebDriver:GetWindowHandles",{}]
[task 2021-10-23T14:09:07.913Z] 14:09:07     INFO - PID 5715 | 1634998147893	Marionette	DEBUG	0 <- [1,16,null,["0f473bfe-6634-414c-9cd4-1a8c12870e0a"]]
[task 2021-10-23T14:09:07.915Z] 14:09:07     INFO - PID 5715 | 1634998147893	webdriver::server	DEBUG	<- 200 OK {"value":["0f473bfe-6634-414c-9cd4-1a8c12870e0a"]}
[task 2021-10-23T14:09:07.916Z] 14:09:07     INFO - PID 5715 | 1634998147894	webdriver::server	DEBUG	-> POST /session/00fc6644-a87e-40e7-816c-c78b0e22042c/window {"handle": "0f473bfe-6634-414c-9cd4-1a8c12870e0a"}
[task 2021-10-23T14:09:07.917Z] 14:09:07     INFO - PID 5715 | 1634998147894	Marionette	DEBUG	0 -> [0,17,"WebDriver:SwitchToWindow",{"handle":"0f473bfe-6634-414c-9cd4-1a8c12870e0a"}]
[task 2021-10-23T14:09:07.918Z] 14:09:07     INFO - PID 5715 | 1634998147895	Marionette	DEBUG	0 <- [1,17,null,{"value":null}]
[task 2021-10-23T14:09:07.918Z] 14:09:07     INFO - PID 5715 | 1634998147895	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2021-10-23T14:09:07.919Z] 14:09:07     INFO - PID 5715 | 1634998147896	webdriver::server	DEBUG	-> POST /session/00fc6644-a87e-40e7-816c-c78b0e22042c/window/rect {"width": 800, "height": 600}
[task 2021-10-23T14:09:07.920Z] 14:09:07     INFO - PID 5715 | 1634998147896	Marionette	DEBUG	0 -> [0,18,"WebDriver:SetWindowRect",{"height":600,"width":800}]
[task 2021-10-23T14:09:07.921Z] 14:09:07     INFO - PID 5715 | 1634998147896	Marionette	DEBUG	0 <- [1,18,null,{"x":100,"y":100,"width":800,"height":600}]
[task 2021-10-23T14:09:07.922Z] 14:09:07     INFO - PID 5715 | 1634998147896	webdriver::server	DEBUG	<- 200 OK {"value":{"x":100,"y":100,"width":800,"height":600}}
[task 2021-10-23T14:09:07.923Z] 14:09:07     INFO - PID 5715 | 1634998147897	webdriver::server	DEBUG	-> POST /session/00fc6644-a87e-40e7-816c-c78b0e22042c/frame {"id": null}
[task 2021-10-23T14:09:07.923Z] 14:09:07     INFO - PID 5715 | 1634998147898	Marionette	DEBUG	0 -> [0,19,"WebDriver:SwitchToFrame",{"id":null}]
[task 2021-10-23T14:09:07.924Z] 14:09:07     INFO - PID 5715 | 1634998147899	Marionette	TRACE	[33] MarionetteCommands actor created for window id 6442450945
[task 2021-10-23T14:09:07.925Z] 14:09:07     INFO - PID 5715 | 1634998147901	Marionette	DEBUG	0 <- [1,19,null,{"value":null}]
[task 2021-10-23T14:09:07.925Z] 14:09:07     INFO - PID 5715 | 1634998147901	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2021-10-23T14:09:07.926Z] 14:09:07     INFO - STDOUT: =================================== FAILURES ===================================
[task 2021-10-23T14:09:07.927Z] 14:09:07     INFO - STDOUT: ____________________ test_basic_auth_unsupported_operation _____________________
[task 2021-10-23T14:09:07.927Z] 14:09:07     INFO - STDOUT: url = <function url.<locals>.url at 0x7f99f0760950>
[task 2021-10-23T14:09:07.928Z] 14:09:07     INFO - STDOUT: session = <Session 00fc6644-a87e-40e7-816c-c78b0e22042c>
[task 2021-10-23T14:09:07.929Z] 14:09:07     INFO - STDOUT:     def test_basic_auth_unsupported_operation(url, session):
[task 2021-10-23T14:09:07.929Z] 14:09:07     INFO - STDOUT:         """
[task 2021-10-23T14:09:07.930Z] 14:09:07     INFO - STDOUT:         Basic auth dialogues are not included in HTML's definition of
[task 2021-10-23T14:09:07.930Z] 14:09:07     INFO - STDOUT:         'user prompts': those are limited to the 'simple dialogues'
[task 2021-10-23T14:09:07.931Z] 14:09:07     INFO - STDOUT:         such as window.alert(), window.prompt() et al. and the print
[task 2021-10-23T14:09:07.931Z] 14:09:07     INFO - STDOUT:         dialogue.
[task 2021-10-23T14:09:07.931Z] 14:09:07     INFO - STDOUT:         """
[task 2021-10-23T14:09:07.932Z] 14:09:07     INFO - STDOUT:         session.url = basic_authentication(url)
[task 2021-10-23T14:09:07.932Z] 14:09:07     INFO - STDOUT:         response = send_alert_text(session, "Federer")
[task 2021-10-23T14:09:07.932Z] 14:09:07     INFO - STDOUT: >       assert_error(response, "unsupported operation")
[task 2021-10-23T14:09:07.933Z] 14:09:07     INFO - STDOUT: response   = <Response status=404 error=<NoSuchAlertException http_status=404>>
[task 2021-10-23T14:09:07.934Z] 14:09:07     INFO - STDOUT: session    = <Session 00fc6644-a87e-40e7-816c-c78b0e22042c>
[task 2021-10-23T14:09:07.934Z] 14:09:07     INFO - STDOUT: url        = <function url.<locals>.url at 0x7f99f0760950>
[task 2021-10-23T14:09:07.935Z] 14:09:07     INFO - STDOUT: tests/web-platform/mozilla/tests/webdriver/send_alert_text.py
[task 2021-10-23T14:09:07.935Z] 14:09:07     INFO - STDOUT: :22: 
[task 2021-10-23T14:09:07.936Z] 14:09:07     INFO - STDOUT: _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[task 2021-10-23T14:09:07.937Z] 14:09:07     INFO - STDOUT: response = <Response status=404 error=<NoSuchAlertException http_status=404>>
[task 2021-10-23T14:09:07.937Z] 14:09:07     INFO - STDOUT: error_code = 'unsupported operation'
[task 2021-10-23T14:09:07.938Z] 14:09:07     INFO - STDOUT:     def assert_error(response, error_code):
[task 2021-10-23T14:09:07.938Z] 14:09:07     INFO - STDOUT:         """
[task 2021-10-23T14:09:07.939Z] 14:09:07     INFO - STDOUT:         Verify that the provided webdriver.Response instance described
[task 2021-10-23T14:09:07.939Z] 14:09:07     INFO - STDOUT:         a valid error response as defined by `dfn-send-an-error` and
[task 2021-10-23T14:09:07.940Z] 14:09:07     INFO - STDOUT:         the provided error code.
[task 2021-10-23T14:09:07.941Z] 14:09:07     INFO - STDOUT:     
[task 2021-10-23T14:09:07.941Z] 14:09:07     INFO - STDOUT:         :param response: ``webdriver.Response`` instance.
[task 2021-10-23T14:09:07.942Z] 14:09:07     INFO - STDOUT:         :param error_code: String value of the expected error code
[task 2021-10-23T14:09:07.942Z] 14:09:07     INFO - STDOUT:         """
[task 2021-10-23T14:09:07.943Z] 14:09:07     INFO - STDOUT: >       assert response.status == errors[error_code]
[task 2021-10-23T14:09:07.944Z] 14:09:07     INFO - STDOUT: E       assert 404 == 500
[task 2021-10-23T14:09:07.944Z] 14:09:07     INFO - STDOUT: E         +404
[task 2021-10-23T14:09:07.945Z] 14:09:07     INFO - STDOUT: E         -500
[task 2021-10-23T14:09:07.945Z] 14:09:07     INFO - STDOUT: error_code = 'unsupported operation'
[task 2021-10-23T14:09:07.946Z] 14:09:07     INFO - STDOUT: response   = <Response status=404 error=<NoSuchAlertException http_status=404>>
[task 2021-10-23T14:09:07.946Z] 14:09:07     INFO - STDOUT: tests/web-platform/tests/webdriver/tests/support/asserts.py
[task 2021-10-23T14:09:07.947Z] 14:09:07     INFO - STDOUT: :52: AssertionError
[task 2021-10-23T14:09:07.947Z] 14:09:07     INFO - STDOUT: =========================== short test summary info ============================
[task 2021-10-23T14:09:07.948Z] 14:09:07     INFO - STDOUT: FAILED tests/web-platform/mozilla/tests/webdriver/send_alert_text.py::test_basic_auth_unsupported_operation
[task 2021-10-23T14:09:07.949Z] 14:09:07     INFO - STDOUT: ============================== 1 failed in 1.69s ===============================
[task 2021-10-23T14:09:07.951Z] 14:09:07     INFO - 
[task 2021-10-23T14:09:07.951Z] 14:09:07     INFO - TEST-UNEXPECTED-FAIL | /_mozilla/webdriver/send_alert_text.py | test_basic_auth_unsupported_operation - assert 404 == 500
[task 2021-10-23T14:09:07.951Z] 14:09:07     INFO - url = <function url.<locals>.url at 0x7f99f0760950>
[task 2021-10-23T14:09:07.951Z] 14:09:07     INFO - session = <Session 00fc6644-a87e-40e7-816c-c78b0e22042c>
[task 2021-10-23T14:09:07.951Z] 14:09:07     INFO - 
[task 2021-10-23T14:09:07.951Z] 14:09:07     INFO -     def test_basic_auth_unsupported_operation(url, session):
[task 2021-10-23T14:09:07.952Z] 14:09:07     INFO -         """
[task 2021-10-23T14:09:07.952Z] 14:09:07     INFO -         Basic auth dialogues are not included in HTML's definition of
[task 2021-10-23T14:09:07.952Z] 14:09:07     INFO -         'user prompts': those are limited to the 'simple dialogues'
[task 2021-10-23T14:09:07.952Z] 14:09:07     INFO -         such as window.alert(), window.prompt() et al. and the print
[task 2021-10-23T14:09:07.952Z] 14:09:07     INFO -         dialogue.
[task 2021-10-23T14:09:07.952Z] 14:09:07     INFO -         """
[task 2021-10-23T14:09:07.952Z] 14:09:07     INFO -         session.url = basic_authentication(url)
[task 2021-10-23T14:09:07.952Z] 14:09:07     INFO -         response = send_alert_text(session, "Federer")
[task 2021-10-23T14:09:07.952Z] 14:09:07     INFO - >       assert_error(response, "unsupported operation")
[task 2021-10-23T14:09:07.952Z] 14:09:07     INFO - 
[task 2021-10-23T14:09:07.952Z] 14:09:07     INFO - response   = <Response status=404 error=<NoSuchAlertException http_status=404>>
[task 2021-10-23T14:09:07.952Z] 14:09:07     INFO - session    = <Session 00fc6644-a87e-40e7-816c-c78b0e22042c>
[task 2021-10-23T14:09:07.952Z] 14:09:07     INFO - url        = <function url.<locals>.url at 0x7f99f0760950>
[task 2021-10-23T14:09:07.952Z] 14:09:07     INFO - 
[task 2021-10-23T14:09:07.952Z] 14:09:07     INFO - tests/web-platform/mozilla/tests/webdriver/send_alert_text.py:22: 
[task 2021-10-23T14:09:07.952Z] 14:09:07     INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[task 2021-10-23T14:09:07.952Z] 14:09:07     INFO - 
[task 2021-10-23T14:09:07.952Z] 14:09:07     INFO - response = <Response status=404 error=<NoSuchAlertException http_status=404>>
[task 2021-10-23T14:09:07.952Z] 14:09:07     INFO - error_code = 'unsupported operation'
[task 2021-10-23T14:09:07.953Z] 14:09:07     INFO - 
[task 2021-10-23T14:09:07.953Z] 14:09:07     INFO -     def assert_error(response, error_code):
[task 2021-10-23T14:09:07.953Z] 14:09:07     INFO -         """
[task 2021-10-23T14:09:07.953Z] 14:09:07     INFO -         Verify that the provided webdriver.Response instance described
[task 2021-10-23T14:09:07.953Z] 14:09:07     INFO -         a valid error response as defined by `dfn-send-an-error` and
[task 2021-10-23T14:09:07.953Z] 14:09:07     INFO -         the provided error code.
[task 2021-10-23T14:09:07.953Z] 14:09:07     INFO -     
[task 2021-10-23T14:09:07.953Z] 14:09:07     INFO -         :param response: ``webdriver.Response`` instance.
[task 2021-10-23T14:09:07.953Z] 14:09:07     INFO -         :param error_code: String value of the expected error code
[task 2021-10-23T14:09:07.953Z] 14:09:07     INFO -         """
[task 2021-10-23T14:09:07.953Z] 14:09:07     INFO - >       assert response.status == errors[error_code]
[task 2021-10-23T14:09:07.953Z] 14:09:07     INFO - E       assert 404 == 500
[task 2021-10-23T14:09:07.953Z] 14:09:07     INFO - E         +404
[task 2021-10-23T14:09:07.953Z] 14:09:07     INFO - E         -500
[task 2021-10-23T14:09:07.953Z] 14:09:07     INFO - 
[task 2021-10-23T14:09:07.953Z] 14:09:07     INFO - error_code = 'unsupported operation'
[task 2021-10-23T14:09:07.953Z] 14:09:07     INFO - response   = <Response status=404 error=<NoSuchAlertException http_status=404>>
[task 2021-10-23T14:09:07.953Z] 14:09:07     INFO - 
[task 2021-10-23T14:09:07.953Z] 14:09:07     INFO - tests/web-platform/tests/webdriver/tests/support/asserts.py:52: AssertionError
[task 2021-10-23T14:09:07.954Z] 14:09:07     INFO - TEST-OK | /_mozilla/webdriver/send_alert_text.py | took 1920ms
[task 2021-10-23T14:09:07.954Z] 14:09:07     INFO - No more tests
[task 2021-10-23T14:09:08.021Z] 14:09:08     INFO - Closing logging queue
[task 2021-10-23T14:09:08.021Z] 14:09:08     INFO - queue closed
[task 2021-10-23T14:09:08.022Z] 14:09:08     INFO - Got 1 unexpected results, with 0 unexpected passes
[task 2021-10-23T14:09:08.022Z] 14:09:08     INFO - SUITE-END | took 999s
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.