Closed Bug 1796691 Opened 3 years ago Closed 3 years ago

Intermittent Android/webdriver/tests/switch_to_window/alerts.py | test_retain_tab_modal_status - webdriver.error.NoSuchAlertException: no such alert (404):

Categories

(Remote Protocol :: Marionette, defect, P5)

defect

Tracking

(Not tracked)

RESOLVED DUPLICATE of bug 1802572

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure)

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


[task 2022-10-20T18:55:42.902Z] 18:55:42     INFO - TEST-START | /webdriver/tests/switch_to_window/alerts.py
[task 2022-10-20T18:55:43.223Z] 18:55:43     INFO - STDOUT: ============================= test session starts ==============================
[task 2022-10-20T18:55:43.223Z] 18:55:43     INFO - STDOUT: platform linux -- Python 3.6.9, pytest-7.0.1, pluggy-unknown -- /builds/worker/workspace/build/venv/bin/python
[task 2022-10-20T18:55:43.225Z] 18:55:43     INFO - STDOUT: rootdir: /builds/worker/workspace/build
[task 2022-10-20T18:55:43.225Z] 18:55:43     INFO - STDOUT: plugins: asyncio-0.14.0
[task 2022-10-20T18:55:43.226Z] 18:55:43     INFO - STDOUT: collecting ... 
[task 2022-10-20T18:55:43.241Z] 18:55:43     INFO - STDOUT: collected 1 item
[task 2022-10-20T18:55:43.241Z] 18:55:43     INFO - STDOUT: tests/web-platform/tests/webdriver/tests/switch_to_window/alerts.py::test_retain_tab_modal_status 
[task 2022-10-20T18:55:43.242Z] 18:55:43     INFO - PID 2075 | 1666292143240	webdriver::server	DEBUG	-> POST /session {"capabilities": {"alwaysMatch": {"moz:firefoxOptions": {"args": ["--profile", "/tmp/tmpqjz9dpcp.mozrunner"], "androidPackage": "org.mozilla.geckoview.test_runner", "androidDeviceSerial": "emulator-5554", "env": {"MOZ_CRASHREPORTER": "1", "MOZ_CRASHREPORTER_SHUTDOWN": "1", "STYLO_THREADS": "1", "RUST_BACKTRACE": "1"}}}}}
[task 2022-10-20T18:55:43.242Z] 18:55:43     INFO - PID 2075 | 1666292143241	mozdevice	TRACE	adb server response was "emulator-5554          device product:sdk_phone_x86_64 model:Android_SDK_built_for_x86_64 device:generic_x86_64 transport_id:2\n"
[task 2022-10-20T18:55:43.243Z] 18:55:43     INFO - PID 2075 | 1666292143241	mozdevice	TRACE	execute_host_command: >> "host:transport:emulator-5554"
[task 2022-10-20T18:55:43.243Z] 18:55:43     INFO - PID 2075 | 1666292143241	mozdevice	TRACE	execute_host_command: << []
[task 2022-10-20T18:55:43.243Z] 18:55:43     INFO - PID 2075 | 1666292143241	mozdevice	TRACE	execute_host_command: >> "shell:id"
[task 2022-10-20T18:55:43.250Z] 18:55:43     INFO - PID 2075 | 1666292143249	mozdevice	TRACE	execute_host_command: << "uid=0(root) gid=0(root) groups=0(root),1004(input),1007(log),1011(adb),1015(sdcard_rw),1028(sdcard_r),3001(net_bt_admin),3002(net_bt),3003(inet),3006(net_bw_stats),3009(readproc) context=u:r:su:s0\n"
[task 2022-10-20T18:55:43.250Z] 18:55:43     INFO - PID 2075 | 1666292143249	mozdevice	TRACE	execute_host_command: >> "host:transport:emulator-5554"
[task 2022-10-20T18:55:43.250Z] 18:55:43     INFO - PID 2075 | 1666292143249	mozdevice	TRACE	execute_host_command: << []
[task 2022-10-20T18:55:43.251Z] 18:55:43     INFO - PID 2075 | 1666292143249	mozdevice	TRACE	execute_host_command: >> "shell:su 0 id"
[task 2022-10-20T18:55:43.259Z] 18:55:43     INFO - PID 2075 | 1666292143258	mozdevice	TRACE	execute_host_command: << "uid=0(root) gid=0(root) groups=0(root),1004(input),1007(log),1011(adb),1015(sdcard_rw),1028(sdcard_r),3001(net_bt_admin),3002(net_bt),3003(inet),3006(net_bw_stats),3009(readproc) context=u:r:su:s0\n"
[task 2022-10-20T18:55:43.260Z] 18:55:43     INFO - PID 2075 | 1666292143259	mozdevice	TRACE	execute_host_command: >> "host:transport:emulator-5554"
[task 2022-10-20T18:55:43.260Z] 18:55:43     INFO - PID 2075 | 1666292143259	mozdevice	TRACE	execute_host_command: << []
[task 2022-10-20T18:55:43.260Z] 18:55:43     INFO - PID 2075 | 1666292143259	mozdevice	TRACE	execute_host_command: >> "shell:su -c id"
[task 2022-10-20T18:55:43.266Z] 18:55:43     INFO - PID 2075 | 1666292143265	mozdevice	TRACE	execute_host_command: << "su: invalid uid/gid '-c'\n"
[task 2022-10-20T18:55:43.266Z] 18:55:43     INFO - PID 2075 | 1666292143265	mozdevice	INFO	Device is rooted
[task 2022-10-20T18:55:43.267Z] 18:55:43     INFO - PID 2075 | 1666292143265	mozdevice	TRACE	execute_host_command: >> "host:transport:emulator-5554"
[task 2022-10-20T18:55:43.267Z] 18:55:43     INFO - PID 2075 | 1666292143265	mozdevice	TRACE	execute_host_command: << []
[task 2022-10-20T18:55:43.267Z] 18:55:43     INFO - PID 2075 | 1666292143265	mozdevice	TRACE	execute_host_command: >> "shell:setenforce permissive"
[task 2022-10-20T18:55:43.272Z] 18:55:43     INFO - PID 2075 | 1666292143272	mozdevice	TRACE	execute_host_command: << ""
[task 2022-10-20T18:55:43.272Z] 18:55:43     INFO - PID 2075 | 1666292143272	geckodriver::android	DEBUG	Marionette port forward (41774 -> 2829) started
<...>
[task 2022-10-20T18:55:47.349Z] 18:55:47     INFO - PID 2075 | 1666292147347	webdriver::server	DEBUG	<- 404 Not Found {"value":{"error":"no such alert","message":"","stacktrace":"RemoteError@chrome://remote/content/shared/RemoteError.sys.mjs:8:8\nWebDriverError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:182:5\nNoSuchAlertError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:383:5\nGeckoDriver.prototype._checkIfAlertIsPresent@chrome://remote/content/marionette/driver.sys.mjs:2666:11\nGeckoDriver.prototype.getTextFromDialog@chrome://remote/content/marionette/driver.sys.mjs:2615:8\ndespatch@chrome://remote/content/marionette/server.sys.mjs:303:40\nexecute@chrome://remote/content/marionette/server.sys.mjs:276:16\nonPacket/<@chrome://remote/content/marionette/server.sys.mjs:249:20\nonPacket@chrome://remote/content/marionette/server.sys.mjs:250:9\n_onJSONObjectReady/<@chrome://remote/content/marionette/transport.sys.mjs:496:20\n"}}
[task 2022-10-20T18:55:47.403Z] 18:55:47     INFO - STDOUT: FAILED
[task 2022-10-20T18:55:47.403Z] 18:55:47     INFO - PID 2075 | 1666292147402	webdriver::server	DEBUG	-> POST /session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/timeouts {"implicit": 0}
[task 2022-10-20T18:55:47.412Z] 18:55:47     INFO - PID 2075 | 1666292147411	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2022-10-20T18:55:47.412Z] 18:55:47     INFO - PID 2075 | 1666292147412	webdriver::server	DEBUG	-> POST /session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/timeouts {"pageLoad": 300000}
[task 2022-10-20T18:55:47.418Z] 18:55:47     INFO - PID 2075 | 1666292147417	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2022-10-20T18:55:47.418Z] 18:55:47     INFO - PID 2075 | 1666292147418	webdriver::server	DEBUG	-> POST /session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/timeouts {"script": 30000}
[task 2022-10-20T18:55:47.423Z] 18:55:47     INFO - PID 2075 | 1666292147423	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2022-10-20T18:55:47.424Z] 18:55:47     INFO - PID 2075 | 1666292147423	webdriver::server	DEBUG	-> GET /session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/window
[task 2022-10-20T18:55:47.430Z] 18:55:47     INFO - PID 2075 | 1666292147430	webdriver::server	DEBUG	<- 200 OK {"value":"da48d70f-f70b-467c-9a3e-ba676c96d60d"}
[task 2022-10-20T18:55:47.430Z] 18:55:47     INFO - PID 2075 | 1666292147430	webdriver::server	DEBUG	-> GET /session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/window
[task 2022-10-20T18:55:47.436Z] 18:55:47     INFO - PID 2075 | 1666292147435	webdriver::server	DEBUG	<- 200 OK {"value":"da48d70f-f70b-467c-9a3e-ba676c96d60d"}
[task 2022-10-20T18:55:47.436Z] 18:55:47     INFO - PID 2075 | 1666292147436	webdriver::server	DEBUG	-> GET /session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/window/handles
[task 2022-10-20T18:55:47.444Z] 18:55:47     INFO - PID 2075 | 1666292147443	webdriver::server	DEBUG	<- 200 OK {"value":["0ca436bd-3ec0-42f3-87c8-c3a644b31668","da48d70f-f70b-467c-9a3e-ba676c96d60d"]}
[task 2022-10-20T18:55:47.444Z] 18:55:47     INFO - PID 2075 | 1666292147443	webdriver::server	DEBUG	-> POST /session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/window {"handle": "da48d70f-f70b-467c-9a3e-ba676c96d60d"}
[task 2022-10-20T18:55:47.451Z] 18:55:47     INFO - PID 2075 | 1666292147450	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2022-10-20T18:55:47.451Z] 18:55:47     INFO - PID 2075 | 1666292147451	webdriver::server	DEBUG	-> POST /session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/alert/dismiss {}
[task 2022-10-20T18:55:47.460Z] 18:55:47     INFO - PID 2075 | 1666292147458	webdriver::server	DEBUG	<- 404 Not Found {"value":{"error":"no such alert","message":"","stacktrace":"RemoteError@chrome://remote/content/shared/RemoteError.sys.mjs:8:8\nWebDriverError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:182:5\nNoSuchAlertError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:383:5\nGeckoDriver.prototype._checkIfAlertIsPresent@chrome://remote/content/marionette/driver.sys.mjs:2666:11\nGeckoDriver.prototype.dismissDialog@chrome://remote/content/marionette/driver.sys.mjs:2573:8\ndespatch@chrome://remote/content/marionette/server.sys.mjs:303:40\nexecute@chrome://remote/content/marionette/server.sys.mjs:276:16\nonPacket/<@chrome://remote/content/marionette/server.sys.mjs:249:20\nonPacket@chrome://remote/content/marionette/server.sys.mjs:250:9\n_onJSONObjectReady/<@chrome://remote/content/marionette/transport.sys.mjs:496:20\n"}}
[task 2022-10-20T18:55:47.461Z] 18:55:47     INFO - PID 2075 | 1666292147459	webdriver::server	DEBUG	-> POST /session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/window {"handle": "0ca436bd-3ec0-42f3-87c8-c3a644b31668"}
[task 2022-10-20T18:55:47.487Z] 18:55:47     INFO - PID 2075 | 1666292147486	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2022-10-20T18:55:47.488Z] 18:55:47     INFO - PID 2075 | 1666292147487	webdriver::server	DEBUG	-> POST /session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/alert/dismiss {}
[task 2022-10-20T18:55:47.498Z] 18:55:47     INFO - PID 2075 | 1666292147496	webdriver::server	DEBUG	<- 404 Not Found {"value":{"error":"no such alert","message":"","stacktrace":"RemoteError@chrome://remote/content/shared/RemoteError.sys.mjs:8:8\nWebDriverError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:182:5\nNoSuchAlertError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:383:5\nGeckoDriver.prototype._checkIfAlertIsPresent@chrome://remote/content/marionette/driver.sys.mjs:2666:11\nGeckoDriver.prototype.dismissDialog@chrome://remote/content/marionette/driver.sys.mjs:2573:8\ndespatch@chrome://remote/content/marionette/server.sys.mjs:303:40\nexecute@chrome://remote/content/marionette/server.sys.mjs:276:16\nonPacket/<@chrome://remote/content/marionette/server.sys.mjs:249:20\nonPacket@chrome://remote/content/marionette/server.sys.mjs:250:9\n_onJSONObjectReady/<@chrome://remote/content/marionette/transport.sys.mjs:496:20\n"}}
[task 2022-10-20T18:55:47.498Z] 18:55:47     INFO - PID 2075 | 1666292147496	webdriver::server	DEBUG	-> POST /session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/window {"handle": "da48d70f-f70b-467c-9a3e-ba676c96d60d"}
[task 2022-10-20T18:55:47.523Z] 18:55:47     INFO - PID 2075 | 1666292147522	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2022-10-20T18:55:47.524Z] 18:55:47     INFO - PID 2075 | 1666292147523	webdriver::server	DEBUG	-> GET /session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/window
[task 2022-10-20T18:55:47.534Z] 18:55:47     INFO - PID 2075 | 1666292147533	webdriver::server	DEBUG	<- 200 OK {"value":"da48d70f-f70b-467c-9a3e-ba676c96d60d"}
[task 2022-10-20T18:55:47.534Z] 18:55:47     INFO - PID 2075 | 1666292147534	webdriver::server	DEBUG	-> GET /session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/window/handles
[task 2022-10-20T18:55:47.543Z] 18:55:47     INFO - PID 2075 | 1666292147542	webdriver::server	DEBUG	<- 200 OK {"value":["0ca436bd-3ec0-42f3-87c8-c3a644b31668","da48d70f-f70b-467c-9a3e-ba676c96d60d"]}
[task 2022-10-20T18:55:47.543Z] 18:55:47     INFO - PID 2075 | 1666292147543	webdriver::server	DEBUG	-> POST /session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/window {"handle": "0ca436bd-3ec0-42f3-87c8-c3a644b31668"}
[task 2022-10-20T18:55:47.577Z] 18:55:47     INFO - PID 2075 | 1666292147576	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2022-10-20T18:55:47.577Z] 18:55:47     INFO - PID 2075 | 1666292147577	webdriver::server	DEBUG	-> GET /session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/window/handles
[task 2022-10-20T18:55:47.586Z] 18:55:47     INFO - PID 2075 | 1666292147585	webdriver::server	DEBUG	<- 200 OK {"value":["0ca436bd-3ec0-42f3-87c8-c3a644b31668","da48d70f-f70b-467c-9a3e-ba676c96d60d"]}
[task 2022-10-20T18:55:47.586Z] 18:55:47     INFO - PID 2075 | 1666292147586	webdriver::server	DEBUG	-> DELETE /session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/window
[task 2022-10-20T18:55:47.635Z] 18:55:47     INFO - PID 2075 | 1666292147634	webdriver::server	DEBUG	<- 200 OK {"value":["da48d70f-f70b-467c-9a3e-ba676c96d60d"]}
[task 2022-10-20T18:55:47.635Z] 18:55:47     INFO - PID 2075 | 1666292147635	webdriver::server	DEBUG	-> POST /session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/window {"handle": "da48d70f-f70b-467c-9a3e-ba676c96d60d"}
[task 2022-10-20T18:55:47.659Z] 18:55:47     INFO - PID 2075 | 1666292147659	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2022-10-20T18:55:47.660Z] 18:55:47     INFO - PID 2075 | 1666292147659	webdriver::server	DEBUG	-> POST /session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/frame {"id": null}
[task 2022-10-20T18:55:47.681Z] 18:55:47     INFO - PID 2075 | 1666292147681	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2022-10-20T18:55:47.683Z] 18:55:47     INFO - PID 2075 | 1666292147682	webdriver::server	DEBUG	-> DELETE /session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2
[task 2022-10-20T18:55:47.724Z] 18:55:47     INFO - PID 2075 | 1666292147723	webdriver::server	DEBUG	Teardown session
[task 2022-10-20T18:55:47.724Z] 18:55:47     INFO - PID 2075 | 1666292147723	geckodriver::android	DEBUG	Force stopping the Android package: org.mozilla.geckoview.test_runner
[task 2022-10-20T18:55:47.725Z] 18:55:47     INFO - PID 2075 | 1666292147723	mozdevice	DEBUG	Force stopping Android package: org.mozilla.geckoview.test_runner
[task 2022-10-20T18:55:47.725Z] 18:55:47     INFO - PID 2075 | 1666292147723	mozdevice	TRACE	execute_host_command: >> "host:transport:emulator-5554"
[task 2022-10-20T18:55:47.725Z] 18:55:47     INFO - PID 2075 | 1666292147723	mozdevice	TRACE	execute_host_command: << []
[task 2022-10-20T18:55:47.726Z] 18:55:47     INFO - PID 2075 | 1666292147723	mozdevice	TRACE	execute_host_command: >> "shell:am force-stop org.mozilla.geckoview.test_runner"
[task 2022-10-20T18:55:47.934Z] 18:55:47     INFO - PID 2075 | 1666292147933	mozdevice	TRACE	execute_host_command: << ""
[task 2022-10-20T18:55:47.935Z] 18:55:47     INFO - PID 2075 | 1666292147934	mozdevice	TRACE	execute_host_command: >> "host:transport:emulator-5554"
[task 2022-10-20T18:55:47.935Z] 18:55:47     INFO - PID 2075 | 1666292147934	mozdevice	TRACE	execute_host_command: << []
[task 2022-10-20T18:55:47.935Z] 18:55:47     INFO - PID 2075 | 1666292147934	mozdevice	TRACE	execute_host_command: >> "shell:am clear-debug-app org.mozilla.geckoview.test_runner"
[task 2022-10-20T18:55:48.127Z] 18:55:48     INFO - PID 2075 | 1666292148125	mozdevice	TRACE	execute_host_command: << ""
[task 2022-10-20T18:55:48.127Z] 18:55:48     INFO - PID 2075 | 1666292148125	geckodriver::android	DEBUG	Disabled reading from configuration file
[task 2022-10-20T18:55:48.128Z] 18:55:48     INFO - PID 2075 | 1666292148125	mozdevice	DEBUG	Deleting /data/local/tmp/org.mozilla.geckoview.test_runner-geckoview-config.yaml
[task 2022-10-20T18:55:48.128Z] 18:55:48     INFO - PID 2075 | 1666292148126	mozdevice	TRACE	execute_host_command: >> "host:transport:emulator-5554"
[task 2022-10-20T18:55:48.129Z] 18:55:48     INFO - PID 2075 | 1666292148126	mozdevice	TRACE	execute_host_command: << []
[task 2022-10-20T18:55:48.129Z] 18:55:48     INFO - PID 2075 | 1666292148126	mozdevice	TRACE	execute_host_command: >> "shell:rm -rf /data/local/tmp/org.mozilla.geckoview.test_runner-geckoview-config.yaml"
[task 2022-10-20T18:55:48.134Z] 18:55:48     INFO - PID 2075 | 1666292148134	mozdevice	TRACE	execute_host_command: << ""
[task 2022-10-20T18:55:48.135Z] 18:55:48     INFO - PID 2075 | 1666292148134	geckodriver::android	DEBUG	Deleted GeckoView configuration file
[task 2022-10-20T18:55:48.135Z] 18:55:48     INFO - PID 2075 | 1666292148134	mozdevice	DEBUG	Deleting /sdcard/Android/data/org.mozilla.geckoview.test_runner/files/test_root
[task 2022-10-20T18:55:48.135Z] 18:55:48     INFO - PID 2075 | 1666292148134	mozdevice	TRACE	execute_host_command: >> "host:transport:emulator-5554"
[task 2022-10-20T18:55:48.136Z] 18:55:48     INFO - PID 2075 | 1666292148134	mozdevice	TRACE	execute_host_command: << []
[task 2022-10-20T18:55:48.136Z] 18:55:48     INFO - PID 2075 | 1666292148134	mozdevice	TRACE	execute_host_command: >> "shell:rm -rf /sdcard/Android/data/org.mozilla.geckoview.test_runner/files/test_root"
[task 2022-10-20T18:55:48.219Z] 18:55:48     INFO - PID 2075 | 1666292148218	mozdevice	TRACE	execute_host_command: << ""
[task 2022-10-20T18:55:48.220Z] 18:55:48     INFO - PID 2075 | 1666292148218	geckodriver::android	DEBUG	Deleted test root folder: /sdcard/Android/data/org.mozilla.geckoview.test_runner/files/test_root
[task 2022-10-20T18:55:48.220Z] 18:55:48     INFO - PID 2075 | 1666292148219	mozdevice	TRACE	execute_host_command: >> "host:transport:emulator-5554"
[task 2022-10-20T18:55:48.220Z] 18:55:48     INFO - PID 2075 | 1666292148219	mozdevice	TRACE	execute_host_command: << []
[task 2022-10-20T18:55:48.221Z] 18:55:48     INFO - PID 2075 | 1666292148219	mozdevice	TRACE	execute_host_command: >> "host-serial:emulator-5554:killforward:tcp:41774"
[task 2022-10-20T18:55:48.221Z] 18:55:48     INFO - PID 2075 | 1666292148219	mozdevice	TRACE	execute_host_command: << ""
[task 2022-10-20T18:55:48.221Z] 18:55:48     INFO - PID 2075 | 1666292148219	geckodriver::android	DEBUG	Marionette port forward (41774 -> 2829) stopped
[task 2022-10-20T18:55:48.222Z] 18:55:48     INFO - PID 2075 | 1666292148219	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2022-10-20T18:55:48.223Z] 18:55:48     INFO - STDOUT: =================================== FAILURES ===================================
[task 2022-10-20T18:55:48.223Z] 18:55:48     INFO - STDOUT: _________________________ test_retain_tab_modal_status _________________________
[task 2022-10-20T18:55:48.224Z] 18:55:48     INFO - STDOUT: session = <Session f961f523-99c7-4fd2-b5c7-03d3de34c2d2>
[task 2022-10-20T18:55:48.224Z] 18:55:48     INFO - STDOUT:     def test_retain_tab_modal_status(session):
[task 2022-10-20T18:55:48.225Z] 18:55:48     INFO - STDOUT:         handle = session.window_handle
[task 2022-10-20T18:55:48.225Z] 18:55:48     INFO - STDOUT:     
[task 2022-10-20T18:55:48.226Z] 18:55:48     INFO - STDOUT:         new_handle = session.new_window()
[task 2022-10-20T18:55:48.226Z] 18:55:48     INFO - STDOUT:         response = switch_to_window(session, new_handle)
[task 2022-10-20T18:55:48.227Z] 18:55:48     INFO - STDOUT:         assert_success(response)
[task 2022-10-20T18:55:48.228Z] 18:55:48     INFO - STDOUT:     
[task 2022-10-20T18:55:48.228Z] 18:55:48     INFO - STDOUT:         session.execute_script("window.alert('Hello');")
[task 2022-10-20T18:55:48.228Z] 18:55:48     INFO - STDOUT:         assert session.alert.text == "Hello"
[task 2022-10-20T18:55:48.228Z] 18:55:48     INFO - STDOUT:     
[task 2022-10-20T18:55:48.233Z] 18:55:48     INFO - 
[task 2022-10-20T18:55:48.233Z] 18:55:48     INFO - TEST-UNEXPECTED-FAIL | /webdriver/tests/switch_to_window/alerts.py | test_retain_tab_modal_status - webdriver.error.NoSuchAlertException: no such alert (404):
[task 2022-10-20T18:55:48.233Z] 18:55:48     INFO - session = <Session f961f523-99c7-4fd2-b5c7-03d3de34c2d2>
[task 2022-10-20T18:55:48.233Z] 18:55:48     INFO - 
[task 2022-10-20T18:55:48.233Z] 18:55:48     INFO -     def test_retain_tab_modal_status(session):
[task 2022-10-20T18:55:48.233Z] 18:55:48     INFO -         handle = session.window_handle
[task 2022-10-20T18:55:48.234Z] 18:55:48     INFO -     
[task 2022-10-20T18:55:48.234Z] 18:55:48     INFO -         new_handle = session.new_window()
[task 2022-10-20T18:55:48.234Z] 18:55:48     INFO -         response = switch_to_window(session, new_handle)
[task 2022-10-20T18:55:48.234Z] 18:55:48     INFO -         assert_success(response)
[task 2022-10-20T18:55:48.234Z] 18:55:48     INFO -     
[task 2022-10-20T18:55:48.234Z] 18:55:48     INFO -         session.execute_script("window.alert('Hello');")
[task 2022-10-20T18:55:48.234Z] 18:55:48     INFO -         assert session.alert.text == "Hello"
[task 2022-10-20T18:55:48.234Z] 18:55:48     INFO -     
[task 2022-10-20T18:55:48.234Z] 18:55:48     INFO -         response = switch_to_window(session, handle)
[task 2022-10-20T18:55:48.234Z] 18:55:48     INFO -         assert_success(response)
[task 2022-10-20T18:55:48.234Z] 18:55:48     INFO -     
[task 2022-10-20T18:55:48.234Z] 18:55:48     INFO -         with pytest.raises(error.NoSuchAlertException):
[task 2022-10-20T18:55:48.234Z] 18:55:48     INFO -             session.alert.text == "Hello"
[task 2022-10-20T18:55:48.234Z] 18:55:48     INFO -     
[task 2022-10-20T18:55:48.234Z] 18:55:48     INFO -         response = switch_to_window(session, new_handle)
[task 2022-10-20T18:55:48.234Z] 18:55:48     INFO -         assert_success(response)
[task 2022-10-20T18:55:48.235Z] 18:55:48     INFO -     
[task 2022-10-20T18:55:48.235Z] 18:55:48     INFO - >       assert session.alert.text == "Hello"
[task 2022-10-20T18:55:48.235Z] 18:55:48     INFO - 
[task 2022-10-20T18:55:48.235Z] 18:55:48     INFO - handle     = '0ca436bd-3ec0-42f3-87c8-c3a644b31668'
[task 2022-10-20T18:55:48.235Z] 18:55:48     INFO - new_handle = 'da48d70f-f70b-467c-9a3e-ba676c96d60d'
[task 2022-10-20T18:55:48.235Z] 18:55:48     INFO - response   = <[ValueError('Sign not allowed in string format specifier',) raised in repr()] Response object at 0x7f74be3bbeb8>
[task 2022-10-20T18:55:48.235Z] 18:55:48     INFO - session    = <Session f961f523-99c7-4fd2-b5c7-03d3de34c2d2>
[task 2022-10-20T18:55:48.235Z] 18:55:48     INFO - 
[task 2022-10-20T18:55:48.235Z] 18:55:48     INFO - tests/web-platform/tests/webdriver/tests/switch_to_window/alerts.py:33: 
[task 2022-10-20T18:55:48.235Z] 18:55:48     INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[task 2022-10-20T18:55:48.235Z] 18:55:48     INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:22: in inner
[task 2022-10-20T18:55:48.235Z] 18:55:48     INFO -     return func(self, *args, **kwargs)
[task 2022-10-20T18:55:48.235Z] 18:55:48     INFO -         args       = ()
[task 2022-10-20T18:55:48.235Z] 18:55:48     INFO -         func       = <function UserPrompt.text at 0x7f74bec2be18>
[task 2022-10-20T18:55:48.235Z] 18:55:48     INFO -         kwargs     = {}
[task 2022-10-20T18:55:48.236Z] 18:55:48     INFO -         self       = <webdriver.client.UserPrompt object at 0x7f74be3bb668>
[task 2022-10-20T18:55:48.236Z] 18:55:48     INFO -         session    = <Session f961f523-99c7-4fd2-b5c7-03d3de34c2d2>
[task 2022-10-20T18:55:48.236Z] 18:55:48     INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:481: in text
[task 2022-10-20T18:55:48.236Z] 18:55:48     INFO -     return self.session.send_session_command("GET", "alert/text")
[task 2022-10-20T18:55:48.236Z] 18:55:48     INFO -         self       = <webdriver.client.UserPrompt object at 0x7f74be3bb668>
[task 2022-10-20T18:55:48.236Z] 18:55:48     INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:661: in send_session_command
[task 2022-10-20T18:55:48.236Z] 18:55:48     INFO -     return self.send_command(method, url, body, timeout)
[task 2022-10-20T18:55:48.236Z] 18:55:48     INFO -         body       = None
[task 2022-10-20T18:55:48.236Z] 18:55:48     INFO -         method     = 'GET'
[task 2022-10-20T18:55:48.236Z] 18:55:48     INFO -         self       = <Session f961f523-99c7-4fd2-b5c7-03d3de34c2d2>
[task 2022-10-20T18:55:48.236Z] 18:55:48     INFO -         timeout    = None
[task 2022-10-20T18:55:48.236Z] 18:55:48     INFO -         uri        = 'alert/text'
[task 2022-10-20T18:55:48.236Z] 18:55:48     INFO -         url        = 'session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/alert/text'
[task 2022-10-20T18:55:48.236Z] 18:55:48     INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[task 2022-10-20T18:55:48.236Z] 18:55:48     INFO - 
[task 2022-10-20T18:55:48.236Z] 18:55:48     INFO - self = <Session f961f523-99c7-4fd2-b5c7-03d3de34c2d2>, method = 'GET'
[task 2022-10-20T18:55:48.237Z] 18:55:48     INFO - url = 'session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/alert/text', body = None
[task 2022-10-20T18:55:48.237Z] 18:55:48     INFO - timeout = None
[task 2022-10-20T18:55:48.237Z] 18:55:48     INFO - 
[task 2022-10-20T18:55:48.237Z] 18:55:48     INFO -     def send_command(self, method, url, body=None, timeout=None):
[task 2022-10-20T18:55:48.237Z] 18:55:48     INFO -         """
[task 2022-10-20T18:55:48.237Z] 18:55:48     INFO -         Send a command to the remote end and validate its success.
[task 2022-10-20T18:55:48.237Z] 18:55:48     INFO -     
[task 2022-10-20T18:55:48.237Z] 18:55:48     INFO -         :param method: HTTP method to use in request.
[task 2022-10-20T18:55:48.237Z] 18:55:48     INFO -         :param uri: "Command part" of the HTTP request URL,
[task 2022-10-20T18:55:48.237Z] 18:55:48     INFO -             e.g. `window/rect`.
[task 2022-10-20T18:55:48.237Z] 18:55:48     INFO -         :param body: Optional body of the HTTP request.
[task 2022-10-20T18:55:48.237Z] 18:55:48     INFO -     
[task 2022-10-20T18:55:48.237Z] 18:55:48     INFO -         :return: `None` if the HTTP response body was empty, otherwise
[task 2022-10-20T18:55:48.237Z] 18:55:48     INFO -             the `value` field returned after parsing the response
[task 2022-10-20T18:55:48.237Z] 18:55:48     INFO -             body as JSON.
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO -     
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO -         :raises error.WebDriverException: If the remote end returns
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO -             an error.
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO -         :raises ValueError: If the response body does not contain a
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO -             `value` key.
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO -         """
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO -     
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO -         response = self.transport.send(
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO -             method, url, body,
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO -             encoder=protocol.Encoder, decoder=protocol.Decoder,
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO -             session=self, timeout=timeout)
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO -     
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO -         if response.status != 200:
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO -             err = error.from_response(response)
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO -     
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO -             if isinstance(err, error.InvalidSessionIdException):
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO -                 # The driver could have already been deleted the session.
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO -                 self.session_id = None
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO -     
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO - >           raise err
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO - E           webdriver.error.NoSuchAlertException: no such alert (404): 
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO - E           
[task 2022-10-20T18:55:48.238Z] 18:55:48     INFO - E           Remote-end stacktrace:
[task 2022-10-20T18:55:48.239Z] 18:55:48     INFO - E           
[task 2022-10-20T18:55:48.239Z] 18:55:48     INFO - E           RemoteError@chrome://remote/content/shared/RemoteError.sys.mjs:8:8
[task 2022-10-20T18:55:48.239Z] 18:55:48     INFO - E           WebDriverError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:182:5
[task 2022-10-20T18:55:48.239Z] 18:55:48     INFO - E           NoSuchAlertError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:383:5
[task 2022-10-20T18:55:48.239Z] 18:55:48     INFO - E           GeckoDriver.prototype._checkIfAlertIsPresent@chrome://remote/content/marionette/driver.sys.mjs:2666:11
[task 2022-10-20T18:55:48.239Z] 18:55:48     INFO - E           GeckoDriver.prototype.getTextFromDialog@chrome://remote/content/marionette/driver.sys.mjs:2615:8
[task 2022-10-20T18:55:48.239Z] 18:55:48     INFO - E           despatch@chrome://remote/content/marionette/server.sys.mjs:303:40
[task 2022-10-20T18:55:48.239Z] 18:55:48     INFO - E           execute@chrome://remote/content/marionette/server.sys.mjs:276:16
[task 2022-10-20T18:55:48.239Z] 18:55:48     INFO - E           onPacket/<@chrome://remote/content/marionette/server.sys.mjs:249:20
[task 2022-10-20T18:55:48.239Z] 18:55:48     INFO - E           onPacket@chrome://remote/content/marionette/server.sys.mjs:250:9
[task 2022-10-20T18:55:48.239Z] 18:55:48     INFO - E           _onJSONObjectReady/<@chrome://remote/content/marionette/transport.sys.mjs:496:20
[task 2022-10-20T18:55:48.239Z] 18:55:48     INFO - 
[task 2022-10-20T18:55:48.239Z] 18:55:48     INFO - body       = None
[task 2022-10-20T18:55:48.239Z] 18:55:48     INFO - err        = <NoSuchAlertException http_status=404>
[task 2022-10-20T18:55:48.240Z] 18:55:48     INFO - method     = 'GET'
[task 2022-10-20T18:55:48.240Z] 18:55:48     INFO - response   = <Response status=404 error=<NoSuchAlertException http_status=404>>
[task 2022-10-20T18:55:48.240Z] 18:55:48     INFO - self       = <Session f961f523-99c7-4fd2-b5c7-03d3de34c2d2>
[task 2022-10-20T18:55:48.240Z] 18:55:48     INFO - timeout    = None
[task 2022-10-20T18:55:48.240Z] 18:55:48     INFO - url        = 'session/f961f523-99c7-4fd2-b5c7-03d3de34c2d2/alert/text'
[task 2022-10-20T18:55:48.240Z] 18:55:48     INFO - 
[task 2022-10-20T18:55:48.240Z] 18:55:48     INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:625: NoSuchAlertException
[task 2022-10-20T18:55:48.240Z] 18:55:48     INFO - TEST-OK | /webdriver/tests/switch_to_window/alerts.py | took 5325ms

This does not repro anymore and looks it was something until the push that this bug was filled on TH. Hasn't failed since then.

Summary: Perma /webdriver/tests/switch_to_window/alerts.py | test_retain_tab_modal_status - webdriver.error.NoSuchAlertException: no such alert (404): → Intermittent /webdriver/tests/switch_to_window/alerts.py | test_retain_tab_modal_status - webdriver.error.NoSuchAlertException: no such alert (404):

It was all Android specific tests that were failing. As far as I remember some devices got restarted so maybe this fixed the issue given that there is no clear landing which would explain it.

Given that there were no other failures since October 20th I'm going to close this bug.

Status: NEW → RESOLVED
Closed: 3 years ago
Flags: needinfo?(hskupin)
Resolution: --- → WORKSFORME
Summary: Intermittent /webdriver/tests/switch_to_window/alerts.py | test_retain_tab_modal_status - webdriver.error.NoSuchAlertException: no such alert (404): → Intermittent Android/webdriver/tests/switch_to_window/alerts.py | test_retain_tab_modal_status - webdriver.error.NoSuchAlertException: no such alert (404):

New instance here, they were failing also on passed green jobs. Points more towards a infra issue.

(In reply to Cosmin Sabou [:CosminS] from comment #5)

New instance here, they were failing also on passed green jobs. Points more towards a infra issue.

It might be that this requires a very specific order of tests to be run. Given that these failures are on autoland where the number of tests in a chunk varies this could be the explanation. Lets reopen the bug so it can be classified correctly, and I'm sure there is no need to run backfill tasks again.

Status: RESOLVED → REOPENED
Resolution: WORKSFORME → ---
See Also: → 1802572
Status: REOPENED → RESOLVED
Closed: 3 years ago3 years ago
Duplicate of bug: 1802572
Resolution: --- → DUPLICATE
Moving bug to Remote Protocol::Marionette component per bug 1815831.
Component: geckodriver → Marionette
Product: Testing → Remote Protocol
You need to log in before you can comment on or make changes to this bug.