Closed
Bug 1812526
Opened 2 years ago
Closed 2 years ago
Intermittent Android /webdriver/tests/get_current_url/get.py | test_no_top_browsing_context - setup error: webdriver.error.NoSuchElementException: no such element (404): Unable to locate element: input
Categories
(Remote Protocol :: Marionette, defect, P5)
Remote Protocol
Marionette
Tracking
(Not tracked)
RESOLVED
INCOMPLETE
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=403587130&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/UjqlZpQsSOiKmiX1bJp6lg/runs/0/artifacts/public/logs/live_backing.log
[task 2023-01-26T07:06:12.639Z] 07:06:12 INFO - TEST-START | /webdriver/tests/get_current_url/get.py
[task 2023-01-26T07:06:12.879Z] 07:06:12 INFO - STDOUT: ============================= test session starts ==============================
[task 2023-01-26T07:06:12.880Z] 07:06:12 INFO - STDOUT: platform linux -- Python 3.6.9, pytest-7.0.1, pluggy-unknown -- /builds/worker/workspace/build/venv/bin/python
[task 2023-01-26T07:06:12.883Z] 07:06:12 INFO - STDOUT: rootdir: /builds/worker/workspace/build
[task 2023-01-26T07:06:12.884Z] 07:06:12 INFO - STDOUT: plugins: asyncio-0.14.0
[task 2023-01-26T07:06:12.884Z] 07:06:12 INFO - STDOUT: collecting ...
[task 2023-01-26T07:06:12.893Z] 07:06:12 INFO - STDOUT: collected 7 items
[task 2023-01-26T07:06:12.894Z] 07:06:12 INFO - STDOUT: tests/web-platform/tests/webdriver/tests/get_current_url/get.py::test_no_top_browsing_context
[task 2023-01-26T07:06:12.894Z] 07:06:12 INFO - PID 2947 | 1674716772892 webdriver::server DEBUG -> POST /session {"capabilities": {"alwaysMatch": {"moz:firefoxOptions": {"args": ["--profile", "/tmp/tmpjjc7qzly.mozrunner"] ... -5554", "env": {"MOZ_CRASHREPORTER": "1", "MOZ_CRASHREPORTER_SHUTDOWN": "1", "STYLO_THREADS": "1", "RUST_BACKTRACE": "1"}}}}}
[task 2023-01-26T07:06:12.895Z] 07:06:12 INFO - PID 2947 | 1674716772893 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 2023-01-26T07:06:12.895Z] 07:06:12 INFO - PID 2947 | 1674716772893 mozdevice TRACE execute_host_command: >> "host:transport:emulator-5554"
<...>
[task 2023-01-26T07:06:14.234Z] 07:06:14 INFO - PID 2947 | ## Auto-generated by geckodriver.
[task 2023-01-26T07:06:14.235Z] 07:06:14 INFO - PID 2947 | ## See https ... _runner/files/test_root/org.mozilla.geckoview.test_runner-geckodriver-profile
[task 2023-01-26T07:06:14.235Z] 07:06:14 INFO - PID 2947 | - "--profile"
[task 2023-01-26T07:06:14.236Z] 07:06:14 INFO - PID 2947 | - /tmp/tmpjjc7qzly.mozrunner
[task 2023-01-26T07:06:14.236Z] 07:06:14 INFO - PID 2947 | 1674716774232 geckodriver::android DEBUG Pushing GeckoView configuration file to /data/local/tmp/org.mozilla.geckoview.test_runner-geckoview-config.yaml
[task 2023-01-26T07:06:14.237Z] 07:06:14 INFO - PID 2947 | 1674716774232 mozdevice TRACE execute_host_command: >> "host:transport:emulator-5554"
[task 2023-01-26T07:06:14.237Z] 07:06:14 INFO - PID 2947 | 1674716774233 mozdevice TRACE execute_host_command: << []
[task 2023-01-26T07:06:14.238Z] 07:06:14 INFO - PID 2947 | 1674716774233 mozdevice TRACE execute_host_command: >> "shell:ls /data/local/tmp"
[task 2023-01-26T07:06:14.243Z] 07:06:14 INFO - PID 2947 | 1674716774242 mozdevice TRACE execute_host_command: << "test_root\n"
[task 2023-01-26T07:06:14.285Z] 07:06:14 INFO - PID 2947 | 1674716774284 mozdevice TRACE execute_host_command: >> "host:transport:emulator-5554"
[task 2023-01-26T07:06:14.285Z] 07:06:14 INFO - PID 2947 | 1674716774284 mozdevice TRACE execute_host_command: << []
[task 2023-01-26T07:06:14.286Z] 07:06:14 INFO - PID 2947 | 1674716774284 mozdevice TRACE execute_host_command: >> "shell:am set-debug-app --persistent org.mozilla.geckoview.test_runner"
[task 2023-01-26T07:06:14.502Z] 07:06:14 INFO - PID 2947 | 1674716774501 mozdevice TRACE execute_host_command: << ""
[task 2023-01-26T07:06:14.503Z] 07:06:14 INFO - PID 2947 | 1674716774501 geckodriver::android DEBUG Launching org.mozilla.geckoview.test_runner/.App
[task 2023-01-26T07:06:14.503Z] 07:06:14 INFO - PID 2947 | 1674716774501 mozdevice TRACE execute_host_command: >> "host:transport:emulator-5554"
[task 2023-01-26T07:06:14.504Z] 07:06:14 INFO - PID 2947 | 1674716774501 mozdevice TRACE execute_host_command: << []
[task 2023-01-26T07:06:14.504Z] 07:06:14 INFO - PID 2947 | 1674716774501 mozdevice TRACE execute_host_command: >> "shell:am start -W -n org.mozilla.geckoview.test_runner/.App -a android.intent.action.VIEW -d about: ... dcard/Android/data/org.mozilla.geckoview.test_runner/files/test_root/org.mozilla.geckoview.test_runner-geckodriver-profile\""
[task 2023-01-26T07:06:15.608Z] 07:06:15 INFO - PID 2947 | 1674716775607 mozdevice TRACE execute_host_command: << "Starting: Intent { act=android.intent.action.VIEW dat=about:blank cmp=org.mozilla.geckoview.test_ru ... s) }\nStatus: ok\nActivity: org.mozilla.geckoview.test_runner/.App\nThisTime: 879\nTotalTime: 879\nWaitTime: 890\nComplete\n"
[task 2023-01-26T07:06:15.609Z] 07:06:15 INFO - PID 2947 | 1674716775607 geckodriver::marionette DEBUG Waiting 60s to connect to browser on 127.0.0.1
[task 2023-01-26T07:06:15.776Z] 07:06:15 INFO - PID 2947 | 1674716775775 geckodriver::marionette DEBUG Connection to Marionette established on 127.0.0.1:44968.
[task 2023-01-26T07:06:16.651Z] 07:06:16 INFO - PID 2947 | 1674716776650 webdriver::server DEBUG <- 200 OK {"value":{"sessionId":"f23f6684-a4e0-414c-807e-2df430f04493","capabilities":{"acceptInsecureCerts":false,"browserNa ... ctability":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"unhandledPromptBehavior":"dismiss and notify"}}}
[task 2023-01-26T07:06:16.653Z] 07:06:16 INFO - PID 2947 | 1674716776651 webdriver::server DEBUG -> GET /session/f23f6684-a4e0-414c-807e-2df430f04493/window
[task 2023-01-26T07:06:16.680Z] 07:06:16 INFO - PID 2947 | 1674716776679 webdriver::server DEBUG <- 200 OK {"value":"7f805941-3d69-462a-b993-37f2a9ae7e4d"}
[task 2023-01-26T07:06:16.681Z] 07:06:16 INFO - PID 2947 | 1674716776680 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/window/new {"type": "tab"}
[task 2023-01-26T07:06:17.063Z] 07:06:17 INFO - PID 2947 | 1674716777062 webdriver::server DEBUG <- 200 OK {"value":{"handle":"8101fac5-0d31-4daa-88b3-7ccd45bdfda2","type":"tab"}}
[task 2023-01-26T07:06:17.064Z] 07:06:17 INFO - PID 2947 | 1674716777063 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/window {"handle": "8101fac5-0d31-4daa-88b3-7ccd45bdfda2"}
[task 2023-01-26T07:06:17.083Z] 07:06:17 INFO - PID 2947 | 1674716777082 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:17.084Z] 07:06:17 INFO - PID 2947 | 1674716777083 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/url {"url": "http://web-platform.test:8000/webdriver/tests/support/inli ... 3C%21doctype+html%3E%0A%3Cmeta+charset%3DUTF-8%3E%0A%3Cinput+id%3D%27a%27+value%3D%27b%27%3E&mime=text%2Fhtml&charset=UTF-8"}
[task 2023-01-26T07:06:17.187Z] 07:06:17 INFO - PID 2947 | 1674716777186 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:17.188Z] 07:06:17 INFO - PID 2947 | 1674716777187 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/element {"using": "css selector", "value": "input"}
[task 2023-01-26T07:06:17.259Z] 07:06:17 INFO - PID 2947 | 1674716777257 webdriver::server DEBUG <- 404 Not Found {"value":{"error":"no such element","message":"Unable to locate element: input","stacktrace":"RemoteError@ch ... ontent/shared/webdriver/Errors.sys.mjs:392:5\nelement.find/</<@chrome://remote/content/marionette/element.sys.mjs:133:16\n"}}
[task 2023-01-26T07:06:17.338Z] 07:06:17 INFO - STDOUT: ERROR
[task 2023-01-26T07:06:17.338Z] 07:06:17 INFO - PID 2947 | 1674716777337 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/timeouts {"implicit": 0}
[task 2023-01-26T07:06:17.348Z] 07:06:17 INFO - PID 2947 | 1674716777347 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:17.349Z] 07:06:17 INFO - PID 2947 | 1674716777348 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/timeouts {"pageLoad": 300000}
[task 2023-01-26T07:06:17.362Z] 07:06:17 INFO - PID 2947 | 1674716777361 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:17.363Z] 07:06:17 INFO - PID 2947 | 1674716777362 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/timeouts {"script": 30000}
[task 2023-01-26T07:06:17.373Z] 07:06:17 INFO - PID 2947 | 1674716777372 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:17.374Z] 07:06:17 INFO - PID 2947 | 1674716777373 webdriver::server DEBUG -> GET /session/f23f6684-a4e0-414c-807e-2df430f04493/window
[task 2023-01-26T07:06:17.385Z] 07:06:17 INFO - PID 2947 | 1674716777384 webdriver::server DEBUG <- 200 OK {"value":"8101fac5-0d31-4daa-88b3-7ccd45bdfda2"}
[task 2023-01-26T07:06:17.386Z] 07:06:17 INFO - PID 2947 | 1674716777385 webdriver::server DEBUG -> GET /session/f23f6684-a4e0-414c-807e-2df430f04493/window
[task 2023-01-26T07:06:17.395Z] 07:06:17 INFO - PID 2947 | 1674716777394 webdriver::server DEBUG <- 200 OK {"value":"8101fac5-0d31-4daa-88b3-7ccd45bdfda2"}
[task 2023-01-26T07:06:17.396Z] 07:06:17 INFO - PID 2947 | 1674716777395 webdriver::server DEBUG -> GET /session/f23f6684-a4e0-414c-807e-2df430f04493/window/handles
[task 2023-01-26T07:06:17.406Z] 07:06:17 INFO - PID 2947 | 1674716777405 webdriver::server DEBUG <- 200 OK {"value":["7f805941-3d69-462a-b993-37f2a9ae7e4d","8101fac5-0d31-4daa-88b3-7ccd45bdfda2"]}
[task 2023-01-26T07:06:17.407Z] 07:06:17 INFO - PID 2947 | 1674716777406 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/window {"handle": "7f805941-3d69-462a-b993-37f2a9ae7e4d"}
[task 2023-01-26T07:06:17.446Z] 07:06:17 INFO - PID 2947 | 1674716777445 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:17.447Z] 07:06:17 INFO - PID 2947 | 1674716777446 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/alert/dismiss {}
[task 2023-01-26T07:06:17.458Z] 07:06:17 INFO - PID 2947 | 1674716777456 webdriver::server DEBUG <- 404 Not Found {"value":{"error":"no such alert","message":"","stacktrace":"RemoteError@chrome://remote/content/shared/Remo ... ontent/marionette/server.sys.mjs:250:9\n_onJSONObjectReady/<@chrome://remote/content/marionette/transport.sys.mjs:496:20\n"}}
[task 2023-01-26T07:06:17.458Z] 07:06:17 INFO - PID 2947 | 1674716777457 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/window {"handle": "8101fac5-0d31-4daa-88b3-7ccd45bdfda2"}
[task 2023-01-26T07:06:17.489Z] 07:06:17 INFO - PID 2947 | 1674716777488 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:17.490Z] 07:06:17 INFO - PID 2947 | 1674716777489 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/alert/dismiss {}
[task 2023-01-26T07:06:17.500Z] 07:06:17 INFO - PID 2947 | 1674716777498 webdriver::server DEBUG <- 404 Not Found {"value":{"error":"no such alert","message":"","stacktrace":"RemoteError@chrome://remote/content/shared/Remo ... ontent/marionette/server.sys.mjs:250:9\n_onJSONObjectReady/<@chrome://remote/content/marionette/transport.sys.mjs:496:20\n"}}
[task 2023-01-26T07:06:17.501Z] 07:06:17 INFO - PID 2947 | 1674716777499 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/window {"handle": "8101fac5-0d31-4daa-88b3-7ccd45bdfda2"}
[task 2023-01-26T07:06:17.510Z] 07:06:17 INFO - PID 2947 | 1674716777509 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:17.511Z] 07:06:17 INFO - PID 2947 | 1674716777510 webdriver::server DEBUG -> GET /session/f23f6684-a4e0-414c-807e-2df430f04493/window
[task 2023-01-26T07:06:17.520Z] 07:06:17 INFO - PID 2947 | 1674716777518 webdriver::server DEBUG <- 200 OK {"value":"8101fac5-0d31-4daa-88b3-7ccd45bdfda2"}
[task 2023-01-26T07:06:17.520Z] 07:06:17 INFO - PID 2947 | 1674716777519 webdriver::server DEBUG -> GET /session/f23f6684-a4e0-414c-807e-2df430f04493/window/handles
[task 2023-01-26T07:06:17.530Z] 07:06:17 INFO - PID 2947 | 1674716777529 webdriver::server DEBUG <- 200 OK {"value":["7f805941-3d69-462a-b993-37f2a9ae7e4d","8101fac5-0d31-4daa-88b3-7ccd45bdfda2"]}
[task 2023-01-26T07:06:17.531Z] 07:06:17 INFO - PID 2947 | 1674716777530 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/window {"handle": "7f805941-3d69-462a-b993-37f2a9ae7e4d"}
[task 2023-01-26T07:06:17.562Z] 07:06:17 INFO - PID 2947 | 1674716777561 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:17.562Z] 07:06:17 INFO - PID 2947 | 1674716777561 webdriver::server DEBUG -> GET /session/f23f6684-a4e0-414c-807e-2df430f04493/window/handles
[task 2023-01-26T07:06:17.572Z] 07:06:17 INFO - PID 2947 | 1674716777570 webdriver::server DEBUG <- 200 OK {"value":["7f805941-3d69-462a-b993-37f2a9ae7e4d","8101fac5-0d31-4daa-88b3-7ccd45bdfda2"]}
[task 2023-01-26T07:06:17.572Z] 07:06:17 INFO - PID 2947 | 1674716777571 webdriver::server DEBUG -> DELETE /session/f23f6684-a4e0-414c-807e-2df430f04493/window
[task 2023-01-26T07:06:17.859Z] 07:06:17 INFO - PID 2947 | 1674716777857 webdriver::server DEBUG <- 200 OK {"value":["8101fac5-0d31-4daa-88b3-7ccd45bdfda2"]}
[task 2023-01-26T07:06:17.860Z] 07:06:17 INFO - PID 2947 | 1674716777859 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/window {"handle": "8101fac5-0d31-4daa-88b3-7ccd45bdfda2"}
[task 2023-01-26T07:06:17.889Z] 07:06:17 INFO - PID 2947 | 1674716777888 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:17.890Z] 07:06:17 INFO - PID 2947 | 1674716777889 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/frame {"id": null}
[task 2023-01-26T07:06:17.905Z] 07:06:17 INFO - PID 2947 | 1674716777904 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:17.907Z] 07:06:17 INFO - PID 2947 | 1674716777907 webdriver::server DEBUG -> GET /session/f23f6684-a4e0-414c-807e-2df430f04493/window
[task 2023-01-26T07:06:17.908Z] 07:06:17 INFO - STDOUT: tests/web-platform/tests/webdriver/tests/get_current_url/get.py::test_no_browsing_context
[task 2023-01-26T07:06:17.915Z] 07:06:17 INFO - PID 2947 | 1674716777914 webdriver::server DEBUG <- 200 OK {"value":"8101fac5-0d31-4daa-88b3-7ccd45bdfda2"}
<...>
[task 2023-01-26T07:06:20.060Z] 07:06:20 INFO - STDOUT: tests/web-platform/tests/webdriver/tests/get_current_url/get.py::test_get_current_url_after_modified_location
[task 2023-01-26T07:06:20.060Z] 07:06:20 INFO - PID 2947 | 1674716780059 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/url {"url": "http://web-platform.test:8000/webdriver/tests/support/inline.py?doc=%3C%21doctype+html%3E%0A%3Cmeta+charset%3DUTF-8%3E%0A%3Cp%3Eframe&mime=text%2Fhtml&charset=UTF-8"}
[task 2023-01-26T07:06:20.187Z] 07:06:20 INFO - PID 2947 | 1674716780186 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:20.187Z] 07:06:20 INFO - PID 2947 | 1674716780187 webdriver::server DEBUG -> GET /session/f23f6684-a4e0-414c-807e-2df430f04493/url
[task 2023-01-26T07:06:20.203Z] 07:06:20 INFO - PID 2947 | 1674716780202 webdriver::server DEBUG <- 200 OK {"value":"http://web-platform.test:8000/webdriver/tests/support/inline.py?doc=%3C%21doctype+html%3E%0A%3Cmeta+charset%3DUTF-8%3E%0A%3Cp%3Eframe&mime=text%2Fhtml&charset=UTF-8"}
[task 2023-01-26T07:06:20.204Z] 07:06:20 INFO - PID 2947 | 1674716780203 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/url {"url": "http://web-platform.test:8000/webdriver/tests/support/inline.py?doc=%3C%21doctype+html%3E%0A%3Cmeta+charset%3DUTF-8%3E%0A%3Cp%3Eframe&mime=text%2Fhtml&charset=UTF-8#foo"}
[task 2023-01-26T07:06:20.230Z] 07:06:20 INFO - PID 2947 | 1674716780229 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:20.231Z] 07:06:20 INFO - PID 2947 | 1674716780230 webdriver::server DEBUG -> GET /session/f23f6684-a4e0-414c-807e-2df430f04493/url
[task 2023-01-26T07:06:20.240Z] 07:06:20 INFO - PID 2947 | 1674716780239 webdriver::server DEBUG <- 200 OK {"value":"http://web-platform.test:8000/webdriver/tests/support/inline.py?doc=%3C%21doctype+html%3E%0A%3Cmeta+charset%3DUTF-8%3E%0A%3Cp%3Eframe&mime=text%2Fhtml&charset=UTF-8#foo"}
[task 2023-01-26T07:06:20.241Z] 07:06:20 INFO - STDOUT: PASSED
[task 2023-01-26T07:06:20.242Z] 07:06:20 INFO - PID 2947 | 1674716780241 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/timeouts {"implicit": 0}
[task 2023-01-26T07:06:20.250Z] 07:06:20 INFO - PID 2947 | 1674716780249 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:20.251Z] 07:06:20 INFO - PID 2947 | 1674716780250 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/timeouts {"pageLoad": 300000}
[task 2023-01-26T07:06:20.259Z] 07:06:20 INFO - PID 2947 | 1674716780258 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:20.260Z] 07:06:20 INFO - PID 2947 | 1674716780259 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/timeouts {"script": 30000}
[task 2023-01-26T07:06:20.267Z] 07:06:20 INFO - PID 2947 | 1674716780266 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:20.268Z] 07:06:20 INFO - PID 2947 | 1674716780267 webdriver::server DEBUG -> GET /session/f23f6684-a4e0-414c-807e-2df430f04493/window
[task 2023-01-26T07:06:20.275Z] 07:06:20 INFO - PID 2947 | 1674716780274 webdriver::server DEBUG <- 200 OK {"value":"8101fac5-0d31-4daa-88b3-7ccd45bdfda2"}
[task 2023-01-26T07:06:20.276Z] 07:06:20 INFO - PID 2947 | 1674716780275 webdriver::server DEBUG -> GET /session/f23f6684-a4e0-414c-807e-2df430f04493/window
[task 2023-01-26T07:06:20.283Z] 07:06:20 INFO - PID 2947 | 1674716780282 webdriver::server DEBUG <- 200 OK {"value":"8101fac5-0d31-4daa-88b3-7ccd45bdfda2"}
[task 2023-01-26T07:06:20.284Z] 07:06:20 INFO - PID 2947 | 1674716780283 webdriver::server DEBUG -> GET /session/f23f6684-a4e0-414c-807e-2df430f04493/window/handles
[task 2023-01-26T07:06:20.291Z] 07:06:20 INFO - PID 2947 | 1674716780290 webdriver::server DEBUG <- 200 OK {"value":["8101fac5-0d31-4daa-88b3-7ccd45bdfda2"]}
[task 2023-01-26T07:06:20.292Z] 07:06:20 INFO - PID 2947 | 1674716780291 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/window {"handle": "8101fac5-0d31-4daa-88b3-7ccd45bdfda2"}
[task 2023-01-26T07:06:20.301Z] 07:06:20 INFO - PID 2947 | 1674716780300 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:20.301Z] 07:06:20 INFO - PID 2947 | 1674716780301 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/alert/dismiss {}
[task 2023-01-26T07:06:20.311Z] 07:06:20 INFO - PID 2947 | 1674716780310 webdriver::server DEBUG <- 404 Not Found {"value":{"error":"no such alert","message":"","stacktrace":"RemoteError@chrome://remote/content/shared/Remo ... ontent/marionette/server.sys.mjs:250:9\n_onJSONObjectReady/<@chrome://remote/content/marionette/transport.sys.mjs:496:20\n"}}
[task 2023-01-26T07:06:20.312Z] 07:06:20 INFO - PID 2947 | 1674716780311 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/window {"handle": "8101fac5-0d31-4daa-88b3-7ccd45bdfda2"}
[task 2023-01-26T07:06:20.321Z] 07:06:20 INFO - PID 2947 | 1674716780320 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:20.322Z] 07:06:20 INFO - PID 2947 | 1674716780321 webdriver::server DEBUG -> GET /session/f23f6684-a4e0-414c-807e-2df430f04493/window
[task 2023-01-26T07:06:20.330Z] 07:06:20 INFO - PID 2947 | 1674716780329 webdriver::server DEBUG <- 200 OK {"value":"8101fac5-0d31-4daa-88b3-7ccd45bdfda2"}
[task 2023-01-26T07:06:20.331Z] 07:06:20 INFO - PID 2947 | 1674716780330 webdriver::server DEBUG -> GET /session/f23f6684-a4e0-414c-807e-2df430f04493/window/handles
[task 2023-01-26T07:06:20.339Z] 07:06:20 INFO - PID 2947 | 1674716780338 webdriver::server DEBUG <- 200 OK {"value":["8101fac5-0d31-4daa-88b3-7ccd45bdfda2"]}
[task 2023-01-26T07:06:20.340Z] 07:06:20 INFO - PID 2947 | 1674716780339 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/window {"handle": "8101fac5-0d31-4daa-88b3-7ccd45bdfda2"}
[task 2023-01-26T07:06:20.348Z] 07:06:20 INFO - PID 2947 | 1674716780347 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:20.348Z] 07:06:20 INFO - PID 2947 | 1674716780348 webdriver::server DEBUG -> POST /session/f23f6684-a4e0-414c-807e-2df430f04493/frame {"id": null}
[task 2023-01-26T07:06:20.363Z] 07:06:20 INFO - PID 2947 | 1674716780362 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:20.365Z] 07:06:20 INFO - PID 2947 | 1674716780364 webdriver::server DEBUG -> DELETE /session/f23f6684-a4e0-414c-807e-2df430f04493
[task 2023-01-26T07:06:20.416Z] 07:06:20 INFO - PID 2947 | 1674716780415 webdriver::server DEBUG Teardown session
[task 2023-01-26T07:06:20.416Z] 07:06:20 INFO - PID 2947 | 1674716780415 geckodriver::android DEBUG Force stopping the Android package: org.mozilla.geckoview.test_runner
[task 2023-01-26T07:06:20.417Z] 07:06:20 INFO - PID 2947 | 1674716780415 mozdevice DEBUG Force stopping Android package: org.mozilla.geckoview.test_runner
[task 2023-01-26T07:06:20.417Z] 07:06:20 INFO - PID 2947 | 1674716780415 mozdevice TRACE execute_host_command: >> "host:transport:emulator-5554"
[task 2023-01-26T07:06:20.418Z] 07:06:20 INFO - PID 2947 | 1674716780415 mozdevice TRACE execute_host_command: << []
[task 2023-01-26T07:06:20.418Z] 07:06:20 INFO - PID 2947 | 1674716780415 mozdevice TRACE execute_host_command: >> "shell:am force-stop org.mozilla.geckoview.test_runner"
[task 2023-01-26T07:06:20.657Z] 07:06:20 INFO - PID 2947 | 1674716780656 mozdevice TRACE execute_host_command: << ""
[task 2023-01-26T07:06:20.659Z] 07:06:20 INFO - PID 2947 | 1674716780657 mozdevice TRACE execute_host_command: >> "host:transport:emulator-5554"
[task 2023-01-26T07:06:20.659Z] 07:06:20 INFO - PID 2947 | 1674716780657 mozdevice TRACE execute_host_command: << []
[task 2023-01-26T07:06:20.659Z] 07:06:20 INFO - PID 2947 | 1674716780657 mozdevice TRACE execute_host_command: >> "shell:am clear-debug-app org.mozilla.geckoview.test_runner"
[task 2023-01-26T07:06:20.880Z] 07:06:20 INFO - PID 2947 | 1674716780878 mozdevice TRACE execute_host_command: << ""
[task 2023-01-26T07:06:20.880Z] 07:06:20 INFO - PID 2947 | 1674716780879 geckodriver::android DEBUG Disabled reading from configuration file
[task 2023-01-26T07:06:20.881Z] 07:06:20 INFO - PID 2947 | 1674716780879 mozdevice DEBUG Deleting /data/local/tmp/org.mozilla.geckoview.test_runner-geckoview-config.yaml
[task 2023-01-26T07:06:20.881Z] 07:06:20 INFO - PID 2947 | 1674716780879 mozdevice TRACE execute_host_command: >> "host:transport:emulator-5554"
[task 2023-01-26T07:06:20.881Z] 07:06:20 INFO - PID 2947 | 1674716780879 mozdevice TRACE execute_host_command: << []
[task 2023-01-26T07:06:20.882Z] 07:06:20 INFO - PID 2947 | 1674716780879 mozdevice TRACE execute_host_command: >> "shell:rm -rf /data/local/tmp/org.mozilla.geckoview.test_runner-geckoview-config.yaml"
[task 2023-01-26T07:06:20.890Z] 07:06:20 INFO - PID 2947 | 1674716780888 mozdevice TRACE execute_host_command: << ""
[task 2023-01-26T07:06:20.891Z] 07:06:20 INFO - PID 2947 | 1674716780888 geckodriver::android DEBUG Deleted GeckoView configuration file
[task 2023-01-26T07:06:20.891Z] 07:06:20 INFO - PID 2947 | 1674716780888 mozdevice DEBUG Deleting /sdcard/Android/data/org.mozilla.geckoview.test_runner/files/test_root
[task 2023-01-26T07:06:20.892Z] 07:06:20 INFO - PID 2947 | 1674716780888 mozdevice TRACE execute_host_command: >> "host:transport:emulator-5554"
[task 2023-01-26T07:06:20.892Z] 07:06:20 INFO - PID 2947 | 1674716780888 mozdevice TRACE execute_host_command: << []
[task 2023-01-26T07:06:20.893Z] 07:06:20 INFO - PID 2947 | 1674716780888 mozdevice TRACE execute_host_command: >> "shell:rm -rf /sdcard/Android/data/org.mozilla.geckoview.test_runner/files/test_root"
[task 2023-01-26T07:06:20.990Z] 07:06:20 INFO - PID 2947 | 1674716780988 mozdevice TRACE execute_host_command: << ""
[task 2023-01-26T07:06:20.990Z] 07:06:20 INFO - PID 2947 | 1674716780988 geckodriver::android DEBUG Deleted test root folder: /sdcard/Android/data/org.mozilla.geckoview.test_runner/files/test_root
[task 2023-01-26T07:06:20.991Z] 07:06:20 INFO - PID 2947 | 1674716780990 mozdevice TRACE execute_host_command: >> "host:transport:emulator-5554"
[task 2023-01-26T07:06:20.992Z] 07:06:20 INFO - PID 2947 | 1674716780990 mozdevice TRACE execute_host_command: << []
[task 2023-01-26T07:06:20.992Z] 07:06:20 INFO - PID 2947 | 1674716780990 mozdevice TRACE execute_host_command: >> "host-serial:emulator-5554:killforward:tcp:44968"
[task 2023-01-26T07:06:20.993Z] 07:06:20 INFO - PID 2947 | 1674716780990 mozdevice TRACE execute_host_command: << ""
[task 2023-01-26T07:06:20.993Z] 07:06:20 INFO - PID 2947 | 1674716780990 geckodriver::android DEBUG Marionette port forward (44968 -> 2829) stopped
[task 2023-01-26T07:06:20.994Z] 07:06:20 INFO - PID 2947 | 1674716780990 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2023-01-26T07:06:20.995Z] 07:06:20 INFO - STDOUT: ==================================== ERRORS ====================================
[task 2023-01-26T07:06:20.996Z] 07:06:20 INFO - STDOUT: ________________ ERROR at setup of test_no_top_browsing_context ________________
[task 2023-01-26T07:06:20.996Z] 07:06:20 INFO - STDOUT: session = <Session f23f6684-a4e0-414c-807e-2df430f04493>
[task 2023-01-26T07:06:20.997Z] 07:06:20 INFO - STDOUT: inline = <function inline.<locals>.inline at 0x7fb2a20b0f28>
[task 2023-01-26T07:06:20.997Z] 07:06:20 INFO - STDOUT: @pytest.fixture
[task 2023-01-26T07:06:20.998Z] 07:06:20 INFO - STDOUT: def closed_window(session, inline):
[task 2023-01-26T07:06:20.999Z] 07:06:20 INFO - STDOUT: """Create a window and close it immediately.
[task 2023-01-26T07:06:20.999Z] 07:06:20 INFO - STDOUT:
[task 2023-01-26T07:06:21.000Z] 07:06:21 INFO - STDOUT: The window handle will be kept selected, which allows to test for invalid
[task 2023-01-26T07:06:21.004Z] 07:06:21 INFO -
[task 2023-01-26T07:06:21.004Z] 07:06:21 INFO - TEST-UNEXPECTED-ERROR | /webdriver/tests/get_current_url/get.py | test_no_top_browsing_context - setup error: webdriver.error.NoSuchElementException: no such element (404): Unable to locate element: input
[task 2023-01-26T07:06:21.004Z] 07:06:21 INFO - session = <Session f23f6684-a4e0-414c-807e-2df430f04493>
[task 2023-01-26T07:06:21.004Z] 07:06:21 INFO - inline = <function inline.<locals>.inline at 0x7fb2a20b0f28>
[task 2023-01-26T07:06:21.004Z] 07:06:21 INFO -
[task 2023-01-26T07:06:21.004Z] 07:06:21 INFO - @pytest.fixture
[task 2023-01-26T07:06:21.004Z] 07:06:21 INFO - def closed_window(session, inline):
[task 2023-01-26T07:06:21.004Z] 07:06:21 INFO - """Create a window and close it immediately.
[task 2023-01-26T07:06:21.004Z] 07:06:21 INFO -
[task 2023-01-26T07:06:21.004Z] 07:06:21 INFO - The window handle will be kept selected, which allows to test for invalid
[task 2023-01-26T07:06:21.004Z] 07:06:21 INFO - top-level browsing context references.
[task 2023-01-26T07:06:21.004Z] 07:06:21 INFO - """
[task 2023-01-26T07:06:21.004Z] 07:06:21 INFO - original_handle = session.window_handle
[task 2023-01-26T07:06:21.004Z] 07:06:21 INFO - new_handle = session.new_window()
[task 2023-01-26T07:06:21.004Z] 07:06:21 INFO -
[task 2023-01-26T07:06:21.004Z] 07:06:21 INFO - session.window_handle = new_handle
[task 2023-01-26T07:06:21.004Z] 07:06:21 INFO - session.url = inline("<input id='a' value='b'>")
[task 2023-01-26T07:06:21.004Z] 07:06:21 INFO - > element = session.find.css("input", all=False)
[task 2023-01-26T07:06:21.004Z] 07:06:21 INFO -
[task 2023-01-26T07:06:21.005Z] 07:06:21 INFO - inline = <function inline.<locals>.inline at 0x7fb2a20b0f28>
[task 2023-01-26T07:06:21.005Z] 07:06:21 INFO - new_handle = '8101fac5-0d31-4daa-88b3-7ccd45bdfda2'
[task 2023-01-26T07:06:21.005Z] 07:06:21 INFO - original_handle = '7f805941-3d69-462a-b993-37f2a9ae7e4d'
[task 2023-01-26T07:06:21.005Z] 07:06:21 INFO - session = <Session f23f6684-a4e0-414c-807e-2df430f04493>
[task 2023-01-26T07:06:21.005Z] 07:06:21 INFO -
[task 2023-01-26T07:06:21.005Z] 07:06:21 INFO - tests/web-platform/tests/webdriver/tests/support/fixtures_http.py:71:
|
||
Comment 1•2 years ago
|
||
The underlying problem here is that the navigate command returned because we got a pageshow event, but sadly not the for the requested page from wptserve but about:blank:
01-26 07:06:16.126 21171 21186 I Gecko : 1674716776126 Marionette DEBUG 0 -> [0,5,"WebDriver:Navigate",{"url":"http://web-platform.test:8000/webdriver/tests/support/inline.py?doc=%3C%21doctype+html%3E%0A%3Cmeta+charset%3DUTF-8%3E%0A%3Cinput+id%3D%27a%27+value%3D%27b%27%3E&mime=text%2Fhtml&charset=UTF-8"}]
01-26 07:06:16.132 21171 21186 D GeckoViewClipboardPermissionParent: receiveMessage: DispatcherMessage
01-26 07:06:16.132 21171 21186 W GeckoEventDispatcher: No listener for GeckoView:DismissClipboardPermissionRequest
01-26 07:06:16.134 21171 21186 I Gecko : 1674716776134 Marionette TRACE [4] Received event pagehide for about:blank
01-26 07:06:16.135 21171 21186 D GeckoViewAutoFill: receiveMessage Clear
01-26 07:06:16.139 21171 21186 W GeckoEventDispatcher: No listener for GeckoView:StateUpdated
01-26 07:06:16.143 21306 21321 D GeckoViewContentDelegateChild[C]: handleEvent: DOMContentLoaded
01-26 07:06:16.149 21171 21186 D GeckoViewNavigation: onLocationChange
01-26 07:06:16.152 21306 21321 D GeckoViewContent[C]: handleEvent: pageshow
01-26 07:06:16.154 21306 21321 D GeckoViewAutoFill[C]: handleEvent: pageshow
01-26 07:06:16.154 21306 21321 W Web Content: [JavaScript Warning: "Unknown category for SetEventRecordingEnabled: page_load"]
01-26 07:06:16.154 21171 21186 D GeckoViewContent: handleEvent: pagetitlechanged
01-26 07:06:16.160 21171 21186 I Gecko : 1674716776160 Marionette TRACE [4] Received event DOMContentLoaded for about:blank
01-26 07:06:16.170 21236 21261 E eglCodecCommon: glUtilsParamSize: unknow param 0x00008caa
01-26 07:06:16.173 21171 21186 I Gecko : 1674716776173 Marionette TRACE [4] Received event pageshow for about:blank
01-26 07:06:16.175 21171 21186 I Gecko : 1674716776175 Marionette DEBUG 0 <- [1,5,null,{"value":null}]
It's basically similar to what I noticed on bug 1804027 comment 16. So this should be an Android only failure.
See Also: → 1804027
Summary: Intermittent /webdriver/tests/get_current_url/get.py | test_no_top_browsing_context - setup error: webdriver.error.NoSuchElementException: no such element (404): Unable to locate element: input → Intermittent Android /webdriver/tests/get_current_url/get.py | test_no_top_browsing_context - setup error: webdriver.error.NoSuchElementException: no such element (404): Unable to locate element: input
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 3•2 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → INCOMPLETE
|
||
Comment 4•2 years ago
|
||
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.
Description
•