1985523 - Intermittent Android Wd | <random> - setup error: webdriver.error.UnknownErrorException: unknown error (500): Could not launch Android org.mozilla.geckoview.test_runner/.App: Resource temporarily unavailable (os error 11)

Reporter

Description

•

5 months ago

treeherder

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

[task 2025-08-27T12:16:02.192+00:00] 12:16:02     INFO - STDOUT: tests/web-platform/tests/webdriver/tests/bidi/storage/get_cookies/filter.py::test_filter_http_only[False-True] 
[task 2025-08-27T12:16:02.738+00:00] 12:16:02     INFO - STDOUT: PASSED
[task 2025-08-27T12:16:02.773+00:00] 12:16:02     INFO - PID 2269 | 1756296962772	webdriver::server	DEBUG	-> POST /session/53d53741-c303-4a2e-8023-ee5e206fabb9/timeouts {"implicit": 0}
[task 2025-08-27T12:16:02.791+00:00] 12:16:02     INFO - PID 2269 | 1756296962788	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2025-08-27T12:16:02.793+00:00] 12:16:02     INFO - PID 2269 | 1756296962788	webdriver::server	DEBUG	-> POST /session/53d53741-c303-4a2e-8023-ee5e206fabb9/timeouts {"pageLoad": 300000}
[task 2025-08-27T12:16:02.796+00:00] 12:16:02     INFO - PID 2269 | 1756296962795	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2025-08-27T12:16:02.797+00:00] 12:16:02     INFO - PID 2269 | 1756296962796	webdriver::server	DEBUG	-> POST /session/53d53741-c303-4a2e-8023-ee5e206fabb9/timeouts {"script": 30000}
[task 2025-08-27T12:16:02.799+00:00] 12:16:02     INFO - PID 2269 | 1756296962798	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2025-08-27T12:16:02.800+00:00] 12:16:02     INFO - PID 2269 | 1756296962799	webdriver::server	DEBUG	-> GET /session/53d53741-c303-4a2e-8023-ee5e206fabb9/window
[task 2025-08-27T12:16:02.802+00:00] 12:16:02     INFO - PID 2269 | 1756296962801	webdriver::server	DEBUG	<- 200 OK {"value":"6bfda4f5-f136-48fc-bbff-8c4fca70e426"}
[task 2025-08-27T12:16:02.803+00:00] 12:16:02     INFO - PID 2269 | 1756296962802	webdriver::server	DEBUG	-> GET /session/53d53741-c303-4a2e-8023-ee5e206fabb9/window
[task 2025-08-27T12:16:02.805+00:00] 12:16:02     INFO - PID 2269 | 1756296962804	webdriver::server	DEBUG	<- 200 OK {"value":"6bfda4f5-f136-48fc-bbff-8c4fca70e426"}
[task 2025-08-27T12:16:02.805+00:00] 12:16:02     INFO - PID 2269 | 1756296962805	webdriver::server	DEBUG	-> GET /session/53d53741-c303-4a2e-8023-ee5e206fabb9/window/handles
[task 2025-08-27T12:16:02.810+00:00] 12:16:02     INFO - PID 2269 | 1756296962807	webdriver::server	DEBUG	<- 200 OK {"value":["6bfda4f5-f136-48fc-bbff-8c4fca70e426"]}
[task 2025-08-27T12:16:02.810+00:00] 12:16:02     INFO - PID 2269 | 1756296962807	webdriver::server	DEBUG	-> POST /session/53d53741-c303-4a2e-8023-ee5e206fabb9/window {"handle": "6bfda4f5-f136-48fc-bbff-8c4fca70e426"}
[task 2025-08-27T12:16:02.817+00:00] 12:16:02     INFO - PID 2269 | 1756296962814	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2025-08-27T12:16:02.818+00:00] 12:16:02     INFO - PID 2269 | 1756296962815	webdriver::server	DEBUG	-> POST /session/53d53741-c303-4a2e-8023-ee5e206fabb9/alert/dismiss {}
[task 2025-08-27T12:16:02.823+00:00] 12:16:02     INFO - PID 2269 | 1756296962821	webdriver::server	DEBUG	<- 404 Not Found {"value":{"error":"no such alert","message":"","stacktrace":"RemoteError@chrome://remote/content/shared/Remo ... ontent/marionette/server.sys.mjs:263:9\n_onJSONObjectReady/<@chrome://remote/content/marionette/transport.sys.mjs:494:20\n"}}
[task 2025-08-27T12:16:02.823+00:00] 12:16:02     INFO - PID 2269 | 1756296962822	webdriver::server	DEBUG	-> POST /session/53d53741-c303-4a2e-8023-ee5e206fabb9/window {"handle": "6bfda4f5-f136-48fc-bbff-8c4fca70e426"}
[task 2025-08-27T12:16:02.827+00:00] 12:16:02     INFO - PID 2269 | 1756296962826	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2025-08-27T12:16:02.827+00:00] 12:16:02     INFO - PID 2269 | 1756296962827	webdriver::server	DEBUG	-> GET /session/53d53741-c303-4a2e-8023-ee5e206fabb9/window
[task 2025-08-27T12:16:02.831+00:00] 12:16:02     INFO - PID 2269 | 1756296962830	webdriver::server	DEBUG	<- 200 OK {"value":"6bfda4f5-f136-48fc-bbff-8c4fca70e426"}
[task 2025-08-27T12:16:02.831+00:00] 12:16:02     INFO - PID 2269 | 1756296962830	webdriver::server	DEBUG	-> GET /session/53d53741-c303-4a2e-8023-ee5e206fabb9/window/handles
[task 2025-08-27T12:16:02.834+00:00] 12:16:02     INFO - PID 2269 | 1756296962834	webdriver::server	DEBUG	<- 200 OK {"value":["6bfda4f5-f136-48fc-bbff-8c4fca70e426"]}
[task 2025-08-27T12:16:02.835+00:00] 12:16:02     INFO - PID 2269 | 1756296962834	webdriver::server	DEBUG	-> POST /session/53d53741-c303-4a2e-8023-ee5e206fabb9/window {"handle": "6bfda4f5-f136-48fc-bbff-8c4fca70e426"}
[task 2025-08-27T12:16:02.837+00:00] 12:16:02     INFO - PID 2269 | 1756296962837	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2025-08-27T12:16:02.838+00:00] 12:16:02     INFO - PID 2269 | 1756296962837	webdriver::server	DEBUG	-> POST /session/53d53741-c303-4a2e-8023-ee5e206fabb9/frame {"id": null}
[task 2025-08-27T12:16:02.841+00:00] 12:16:02     INFO - PID 2269 | 1756296962841	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2025-08-27T12:16:02.843+00:00] 12:16:02     INFO - PID 2269 | 1756296962842	webdriver::server	DEBUG	-> DELETE /session/53d53741-c303-4a2e-8023-ee5e206fabb9
[task 2025-08-27T12:16:03.081+00:00] 12:16:03     INFO - PID 2269 | 1756296963081	webdriver::server	DEBUG	Teardown session
[task 2025-08-27T12:16:03.140+00:00] 12:16:03     INFO - PID 2269 | 1756296963139	geckodriver::android	DEBUG	Force stopping the Android package: org.mozilla.geckoview.test_runner
[task 2025-08-27T12:16:03.140+00:00] 12:16:03     INFO - PID 2269 | 1756296963139	mozdevice	DEBUG	Force stopping Android package: org.mozilla.geckoview.test_runner
[task 2025-08-27T12:16:03.141+00:00] 12:16:03     INFO - PID 2269 | 1756296963139	mozdevice	TRACE	execute_host_command: >> "host:transport:emulator-5554"
[task 2025-08-27T12:16:03.141+00:00] 12:16:03     INFO - PID 2269 | 1756296963139	mozdevice	TRACE	execute_host_command: << []
[task 2025-08-27T12:16:03.141+00:00] 12:16:03     INFO - PID 2269 | 1756296963139	mozdevice	TRACE	execute_host_command: >> "shell:am force-stop org.mozilla.geckoview.test_runner"
[task 2025-08-27T12:16:03.319+00:00] 12:16:03     INFO - PID 2269 | 1756296963317	mozdevice	TRACE	execute_host_command: << ""
[task 2025-08-27T12:16:03.320+00:00] 12:16:03     INFO - PID 2269 | 1756296963318	mozdevice	TRACE	execute_host_command: >> "host:transport:emulator-5554"
[task 2025-08-27T12:16:03.320+00:00] 12:16:03     INFO - PID 2269 | 1756296963318	mozdevice	TRACE	execute_host_command: << []
[task 2025-08-27T12:16:03.320+00:00] 12:16:03     INFO - PID 2269 | 1756296963318	mozdevice	TRACE	execute_host_command: >> "shell:am clear-debug-app org.mozilla.geckoview.test_runner"
[task 2025-08-27T12:16:03.414+00:00] 12:16:03     INFO - PID 2269 | 1756296963413	mozdevice	TRACE	execute_host_command: << ""
[task 2025-08-27T12:16:03.416+00:00] 12:16:03     INFO - PID 2269 | 1756296963413	geckodriver::android	DEBUG	Disabled reading from configuration file
[task 2025-08-27T12:16:03.416+00:00] 12:16:03     INFO - PID 2269 | 1756296963413	mozdevice	DEBUG	Deleting /data/local/tmp/org.mozilla.geckoview.test_runner-geckoview-config.yaml
[task 2025-08-27T12:16:03.416+00:00] 12:16:03     INFO - PID 2269 | 1756296963413	mozdevice	TRACE	execute_host_command: >> "host:transport:emulator-5554"
[task 2025-08-27T12:16:03.417+00:00] 12:16:03     INFO - PID 2269 | 1756296963413	mozdevice	TRACE	execute_host_command: << []
[task 2025-08-27T12:16:03.417+00:00] 12:16:03     INFO - PID 2269 | 1756296963413	mozdevice	TRACE	execute_host_command: >> "shell:rm -rf /data/local/tmp/org.mozilla.geckoview.test_runner-geckoview-config.yaml"
[task 2025-08-27T12:16:03.499+00:00] 12:16:03     INFO - PID 2269 | 1756296963498	mozdevice	TRACE	execute_host_command: << ""
[task 2025-08-27T12:16:03.499+00:00] 12:16:03     INFO - PID 2269 | 1756296963498	geckodriver::android	DEBUG	Deleted GeckoView configuration file
[task 2025-08-27T12:16:03.500+00:00] 12:16:03     INFO - PID 2269 | 1756296963498	mozdevice	DEBUG	Deleting /sdcard/Android/data/org.mozilla.geckoview.test_runner/files/test_root
[task 2025-08-27T12:16:03.500+00:00] 12:16:03     INFO - PID 2269 | 1756296963498	mozdevice	TRACE	execute_host_command: >> "host:transport:emulator-5554"
[task 2025-08-27T12:16:03.501+00:00] 12:16:03     INFO - PID 2269 | 1756296963498	mozdevice	TRACE	execute_host_command: << []
[task 2025-08-27T12:16:03.501+00:00] 12:16:03     INFO - PID 2269 | 1756296963498	mozdevice	TRACE	execute_host_command: >> "shell:rm -rf /sdcard/Android/data/org.mozilla.geckoview.test_runner/files/test_root"
[task 2025-08-27T12:16:03.555+00:00] 12:16:03     INFO - PID 2269 | 1756296963553	mozdevice	TRACE	execute_host_command: << ""
[task 2025-08-27T12:16:03.556+00:00] 12:16:03     INFO - PID 2269 | 1756296963553	geckodriver::android	DEBUG	Deleted test root folder: /sdcard/Android/data/org.mozilla.geckoview.test_runner/files/test_root
[task 2025-08-27T12:16:03.556+00:00] 12:16:03     INFO - PID 2269 | 1756296963553	geckodriver::android	DEBUG	Stop forwarding Marionette port (45687 -> 2829)
[task 2025-08-27T12:16:03.558+00:00] 12:16:03     INFO - PID 2269 | 1756296963553	mozdevice	TRACE	execute_host_command: >> "host:transport:emulator-5554"
[task 2025-08-27T12:16:03.559+00:00] 12:16:03     INFO - PID 2269 | 1756296963553	mozdevice	TRACE	execute_host_command: << []
[task 2025-08-27T12:16:03.560+00:00] 12:16:03     INFO - PID 2269 | 1756296963553	mozdevice	TRACE	execute_host_command: >> "host-serial:emulator-5554:killforward:tcp:45687"
[task 2025-08-27T12:16:03.561+00:00] 12:16:03     INFO - PID 2269 | 1756296963558	mozdevice	TRACE	execute_host_command: << ""
[task 2025-08-27T12:16:03.561+00:00] 12:16:03     INFO - PID 2269 | 1756296963558	geckodriver::android	DEBUG	Stop forwarding WebSocket port (45687 -> 2829)
[task 2025-08-27T12:16:03.561+00:00] 12:16:03     INFO - PID 2269 | 1756296963558	mozdevice	TRACE	execute_host_command: >> "host:transport:emulator-5554"
[task 2025-08-27T12:16:03.561+00:00] 12:16:03     INFO - PID 2269 | 1756296963558	mozdevice	TRACE	execute_host_command: << []
[task 2025-08-27T12:16:03.562+00:00] 12:16:03     INFO - PID 2269 | 1756296963558	mozdevice	TRACE	execute_host_command: >> "host-serial:emulator-5554:killforward:tcp:9222"
[task 2025-08-27T12:16:03.563+00:00] 12:16:03     INFO - PID 2269 | 1756296963559	mozdevice	TRACE	execute_host_command: << ""
[task 2025-08-27T12:16:03.563+00:00] 12:16:03     INFO - PID 2269 | 1756296963559	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2025-08-27T12:16:03.581+00:00] 12:16:03     INFO - 
[task 2025-08-27T12:16:03.581+00:00] 12:16:03     INFO - TEST-UNEXPECTED-ERROR | /webdriver/tests/bidi/storage/get_cookies/filter.py | test_filter[filter0] - setup error: webdriver.error.UnknownErrorException: unknown error (500): Could not launch Android org.mozilla.geckoview.test_runner/.App: Resource temporarily unavailable (os error 11)
[task 2025-08-27T12:16:03.581+00:00] 12:16:03     INFO - event_loop = <_UnixSelectorEventLoop running=False closed=False debug=False>
[task 2025-08-27T12:16:03.581+00:00] 12:16:03     INFO - request = <SubRequest 'bidi_session' for <Function test_filter[filter0]>>
[task 2025-08-27T12:16:03.581+00:00] 12:16:03     INFO - kwargs = {'capabilities': {}, 'configuration': {'browser': {'args': ['--profile', '/tmp/tmpwqbwj0do.mozrunner'], 'binary': None...RASHREPORTER_SHUTDOWN': '1', 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', ...}}}, 'host': '127.0.0.1', 'port': 39837, ...}}
[task 2025-08-27T12:16:03.581+00:00] 12:16:03     INFO - setup = <function _wrap_asyncgen.<locals>._asyncgen_fixture_wrapper.<locals>.setup at 0x7fdc202b5580>
[task 2025-08-27T12:16:03.581+00:00] 12:16:03     INFO - finalizer = <function _wrap_asyncgen.<locals>._asyncgen_fixture_wrapper.<locals>.finalizer at 0x7fdc202b54e0>
[task 2025-08-27T12:16:03.581+00:00] 12:16:03     INFO - 
[task 2025-08-27T12:16:03.581+00:00] 12:16:03     INFO -     @functools.wraps(func)
[task 2025-08-27T12:16:03.582+00:00] 12:16:03     INFO -     def _asyncgen_fixture_wrapper(
[task 2025-08-27T12:16:03.582+00:00] 12:16:03     INFO -         event_loop: asyncio.AbstractEventLoop, request: SubRequest, **kwargs: Any
[task 2025-08-27T12:16:03.582+00:00] 12:16:03     INFO -     ) -> _R:
[task 2025-08-27T12:16:03.582+00:00] 12:16:03     INFO -         gen_obj = func(**_add_kwargs(func, kwargs, event_loop, request))
[task 2025-08-27T12:16:03.582+00:00] 12:16:03     INFO -     
[task 2025-08-27T12:16:03.582+00:00] 12:16:03     INFO -         async def setup() -> _R:
[task 2025-08-27T12:16:03.582+00:00] 12:16:03     INFO -             res = await gen_obj.__anext__()
[task 2025-08-27T12:16:03.582+00:00] 12:16:03     INFO -             return res
[task 2025-08-27T12:16:03.582+00:00] 12:16:03     INFO -     
[task 2025-08-27T12:16:03.582+00:00] 12:16:03     INFO -         def finalizer() -> None:
[task 2025-08-27T12:16:03.582+00:00] 12:16:03     INFO -             """Yield again, to finalize."""
[task 2025-08-27T12:16:03.582+00:00] 12:16:03     INFO -     
[task 2025-08-27T12:16:03.582+00:00] 12:16:03     INFO -             async def async_finalizer() -> None:
[task 2025-08-27T12:16:03.582+00:00] 12:16:03     INFO -                 try:
[task 2025-08-27T12:16:03.582+00:00] 12:16:03     INFO -                     await gen_obj.__anext__()
[task 2025-08-27T12:16:03.582+00:00] 12:16:03     INFO -                 except StopAsyncIteration:
[task 2025-08-27T12:16:03.582+00:00] 12:16:03     INFO -                     pass
[task 2025-08-27T12:16:03.582+00:00] 12:16:03     INFO -                 else:
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO -                     msg = "Async generator fixture didn't stop."
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO -                     msg += "Yield only once."
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO -                     raise ValueError(msg)
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO -     
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO -             event_loop.run_until_complete(async_finalizer())
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO -     
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO - >       result = event_loop.run_until_complete(setup())
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO - 
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO - event_loop = <_UnixSelectorEventLoop running=False closed=False debug=False>
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO - finalizer  = <function _wrap_asyncgen.<locals>._asyncgen_fixture_wrapper.<locals>.finalizer at 0x7fdc202b54e0>
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO - func       = <function bidi_session at 0x7fdc201cc2c0>
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO - gen_obj    = <async_generator object bidi_session at 0x7fdc20265c60>
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO - kwargs     = {'capabilities': {},
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO -  'configuration': {'browser': {'args': ['--profile',
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO -                                         '/tmp/tmpwqbwj0do.mozrunner'],
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO -                                'binary': None,
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO -                                'env': {'MINIDUMP_SAVE_PATH': '/builds/worker/workspace/build/blobber_upload_dir',
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO -                                        'MOZ_CRASHREPORTER': '1',
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO -                                        'MOZ_CRASHREPORTER_SHUTDOWN': '1',
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO -                                        'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1',
[task 2025-08-27T12:16:03.583+00:00] 12:16:03     INFO -                                        'RUST_BACKTRACE': '1'}},
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO -                    'capabilities': {'moz:firefoxOptions': {'androidDeviceSerial': 'emulator-5554',
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO -                                                            'androidPackage': 'org.mozilla.geckoview.test_runner',
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO -                                                            'args': ['--profile',
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO -                                                                     '/tmp/tmpwqbwj0do.mozrunner'],
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO -                                                            'env': {'MINIDUMP_SAVE_PATH': '/builds/worker/workspace/build/blobber_upload_dir',
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO -                                                                    'MOZ_CRASHREPORTER': '1',
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO -                                                                    'MOZ_CRASHREPORTER_SHUTDOWN': '1',
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO -                                                                    'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1',
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO -                                                                    'RUST_BACKTRACE': '1'}}},
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO -                    'host': '127.0.0.1',
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO -                    'port': 39837,
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO -                    'target_platform': 'android',
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO -                    'timeout_multiplier': 4,
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO -                    'webdriver': {'args': ['-vv'],
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO -                                  'binary': '/builds/worker/fetches/geckodriver'}}}
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO - request    = <SubRequest 'bidi_session' for <Function test_filter[filter0]>>
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO - setup      = <function _wrap_asyncgen.<locals>._asyncgen_fixture_wrapper.<locals>.setup at 0x7fdc202b5580>
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO - 
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO - tests/web-platform/tests/tools/third_party/pytest-asyncio/pytest_asyncio/plugin.py:293: 
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO - /usr/lib/python3.12/asyncio/base_events.py:687: in run_until_complete
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO -     return future.result()
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO -         future     = <Task finished name='Task-1' coro=<_wrap_asyncgen.<locals>._asyncgen_fixture_wrapper.<locals>.setup() done, defined at /builds/worker/workspace/build/tests/web-platform/tests/tools/third_party/pytest-asyncio/pytest_asyncio/plugin.py:274> exception=<UnknownErrorException http_status=500>>
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO -         new_task   = True
[task 2025-08-27T12:16:03.584+00:00] 12:16:03     INFO -         self       = <_UnixSelectorEventLoop running=False closed=False debug=False>
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO - tests/web-platform/tests/tools/third_party/pytest-asyncio/pytest_asyncio/plugin.py:275: in setup
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -     res = await gen_obj.__anext__()
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -         gen_obj    = <async_generator object bidi_session at 0x7fdc20265c60>
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO - tests/web-platform/tests/webdriver/tests/support/fixtures.py:229: in bidi_session
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -     _current_session.start()
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -         capabilities = {}
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -         caps       = {'alwaysMatch': {'moz:firefoxOptions': {'androidDeviceSerial': 'emulator-5554',
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -                                         'androidPackage': 'org.mozilla.geckoview.test_runner',
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -                                         'args': ['--profile',
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -                                                  '/tmp/tmpwqbwj0do.mozrunner'],
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -                                         'env': {'MINIDUMP_SAVE_PATH': '/builds/worker/workspace/build/blobber_upload_dir',
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -                                                 'MOZ_CRASHREPORTER': '1',
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -                                                 'MOZ_CRASHREPORTER_SHUTDOWN': '1',
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -                                                 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1',
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -                                                 'RUST_BACKTRACE': '1'}},
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -                  'webSocketUrl': True}}
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -         configuration = {'browser': {'args': ['--profile', '/tmp/tmpwqbwj0do.mozrunner'],
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -              'binary': None,
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -              'env': {'MINIDUMP_SAVE_PATH': '/builds/worker/workspace/build/blobber_upload_dir',
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -                      'MOZ_CRASHREPORTER': '1',
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -                      'MOZ_CRASHREPORTER_SHUTDOWN': '1',
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -                      'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1',
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -                      'RUST_BACKTRACE': '1'}},
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -  'capabilities': {'moz:firefoxOptions': {'androidDeviceSerial': 'emulator-5554',
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -                                          'androidPackage': 'org.mozilla.geckoview.test_runner',
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -                                          'args': ['--profile',
[task 2025-08-27T12:16:03.585+00:00] 12:16:03     INFO -                                                   '/tmp/tmpwqbwj0do.mozrunner'],
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -                                          'env': {'MINIDUMP_SAVE_PATH': '/builds/worker/workspace/build/blobber_upload_dir',
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -                                                  'MOZ_CRASHREPORTER': '1',
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -                                                  'MOZ_CRASHREPORTER_SHUTDOWN': '1',
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -                                                  'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1',
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -                                                  'RUST_BACKTRACE': '1'}}},
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -  'host': '127.0.0.1',
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -  'port': 39837,
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -  'target_platform': 'android',
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -  'timeout_multiplier': 4,
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -  'webdriver': {'args': ['-vv'], 'binary': '/builds/worker/fetches/geckodriver'}}
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:449: in start
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -     value = self.send_command("POST", "session", body=body)
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -         body       = {'capabilities': {'alwaysMatch': {'moz:firefoxOptions': {'androidDeviceSerial': 'emulator-5554',
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -                                                          'androidPackage': 'org.mozilla.geckoview.test_runner',
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -                                                          'args': ['--profile',
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -                                                                   '/tmp/tmpwqbwj0do.mozrunner'],
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -                                                          'env': {'MINIDUMP_SAVE_PATH': '/builds/worker/workspace/build/blobber_upload_dir',
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -                                                                  'MOZ_CRASHREPORTER': '1',
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -                                                                  'MOZ_CRASHREPORTER_SHUTDOWN': '1',
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -                                                                  'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1',
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -                                                                  'RUST_BACKTRACE': '1'}},
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -                                   'webSocketUrl': True}}}
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -         self       = <Session (disconnected)>
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO - 
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO - self = <Session (disconnected)>, method = 'POST', url = 'session'
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO - body = {'capabilities': {'alwaysMatch': {'moz:firefoxOptions': {'androidDeviceSerial': 'emulator-5554', 'androidPackage': 'or...ORTER': '1', 'MOZ_CRASHREPORTER_SHUTDOWN': '1', 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', ...}}, 'webSocketUrl': True}}}
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO - timeout = None
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO - 
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -     def send_command(self, method, url, body=None, timeout=None):
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -         """
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -         Send a command to the remote end and validate its success.
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -     
[task 2025-08-27T12:16:03.586+00:00] 12:16:03     INFO -         :param method: HTTP method to use in request.
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -         :param uri: "Command part" of the HTTP request URL,
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -             e.g. `window/rect`.
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -         :param body: Optional body of the HTTP request.
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -     
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -         :return: `None` if the HTTP response body was empty, otherwise
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -             the `value` field returned after parsing the response
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -             body as JSON.
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -     
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -         :raises error.WebDriverException: If the remote end returns
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -             an error.
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -         :raises ValueError: If the response body does not contain a
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -             `value` key.
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -         """
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -     
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -         response = self.transport.send(
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -             method, url, body,
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -             encoder=protocol.Encoder, decoder=protocol.Decoder,
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -             session=self, timeout=timeout)
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -     
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -         if response.status != 200:
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -             err = error.from_response(response)
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -     
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -             if isinstance(err, error.InvalidSessionIdException):
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -                 # The driver could have already been deleted the session.
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -                 self.session_id = None
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -     
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO - >           raise err
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO - E           webdriver.error.UnknownErrorException: unknown error (500): Could not launch Android org.mozilla.geckoview.test_runner/.App: Resource temporarily unavailable (os error 11)
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO - 
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO - body       = {'capabilities': {'alwaysMatch': {'moz:firefoxOptions': {'androidDeviceSerial': 'emulator-5554',
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -                                                          'androidPackage': 'org.mozilla.geckoview.test_runner',
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -                                                          'args': ['--profile',
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -                                                                   '/tmp/tmpwqbwj0do.mozrunner'],
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -                                                          'env': {'MINIDUMP_SAVE_PATH': '/builds/worker/workspace/build/blobber_upload_dir',
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -                                                                  'MOZ_CRASHREPORTER': '1',
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -                                                                  'MOZ_CRASHREPORTER_SHUTDOWN': '1',
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -                                                                  'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1',
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -                                                                  'RUST_BACKTRACE': '1'}},
[task 2025-08-27T12:16:03.587+00:00] 12:16:03     INFO -                                   'webSocketUrl': True}}}
[task 2025-08-27T12:16:03.588+00:00] 12:16:03     INFO - err        = <UnknownErrorException http_status=500>
[task 2025-08-27T12:16:03.588+00:00] 12:16:03     INFO - method     = 'POST'
[task 2025-08-27T12:16:03.588+00:00] 12:16:03     INFO - response   = <Response status=500 error=<UnknownErrorException http_status=500>>
[task 2025-08-27T12:16:03.588+00:00] 12:16:03     INFO - self       = <Session (disconnected)>
[task 2025-08-27T12:16:03.588+00:00] 12:16:03     INFO - timeout    = None
[task 2025-08-27T12:16:03.588+00:00] 12:16:03     INFO - url        = 'session'
[task 2025-08-27T12:16:03.588+00:00] 12:16:03     INFO - 
[task 2025-08-27T12:16:03.588+00:00] 12:16:03     INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:516: UnknownErrorException
[task 2025-08-27T12:16:03.593+00:00] 12:16:03     INFO - .....................

Henrik Skupin [:whimboo][⌚️UTC+1] (away from Feb 12th - Feb 22nd)

Comment 1

•

5 months ago

So Joel landed a fix for mozdevice via bug 1981210 which was supposed to fix this failure. But as it looks like it's not fully gone yet. Lets see how often it happens on Android 14.

Depends on: 1981210

Henrik Skupin [:whimboo][⌚️UTC+1] (away from Feb 12th - Feb 22nd)

Updated

•

5 months ago

OS: Unspecified → Android

Summary: Intermittent /webdriver/tests/bidi/storage/get_cookies/filter.py | test_filter[filter0] - setup error: webdriver.error.UnknownErrorException: unknown error (500): Could not launch Android org.mozilla.geckoview.test_runner/.App: Resource temporarily → Intermittent Android Wd | <random> - setup error: webdriver.error.UnknownErrorException: unknown error (500): Could not launch Android org.mozilla.geckoview.test_runner/.App: Resource temporarily

Comment hidden (Intermittent Failures Robot)

Henrik Skupin [:whimboo][⌚️UTC+1] (away from Feb 12th - Feb 22nd)

Updated

•

5 months ago

Duplicate of this bug: 1952794

Comment hidden (Intermittent Failures Robot)

Henrik Skupin [:whimboo][⌚️UTC+1] (away from Feb 12th - Feb 22nd)

Updated

•

5 months ago

Duplicate of this bug: 1897516

Henrik Skupin [:whimboo][⌚️UTC+1] (away from Feb 12th - Feb 22nd)

Updated

•

5 months ago

Summary: Intermittent Android Wd | <random> - setup error: webdriver.error.UnknownErrorException: unknown error (500): Could not launch Android org.mozilla.geckoview.test_runner/.App: Resource temporarily → Intermittent Android Wd | <random> - setup error: webdriver.error.UnknownErrorException: unknown error (500): Could not launch Android org.mozilla.geckoview.test_runner/.App: Resource temporarily unavailable (os error 11)

Comment hidden (Intermittent Failures Robot)

Alexandra Borovova [:Sasha]

Assignee

Comment 7

•

5 months ago

Attached file Bug 1985523 - [geckodriver] Try to relaunch Android testrunner when it failed first time. — Details

Phabricator Automation

Updated

•

5 months ago

Assignee: nobody → aborovova

Status: NEW → ASSIGNED

Pulsebot

Comment 8

•

5 months ago

Pushed by aborovova@mozilla.com: https://github.com/mozilla-firefox/firefox/commit/5d9a4f3c9e47 https://hg.mozilla.org/integration/autoland/rev/fcc85646c9ec [geckodriver] Try to relaunch Android testrunner when it failed first time. r=webdriver-reviewers,whimboo

Henrik Skupin [:whimboo][⌚️UTC+1] (away from Feb 12th - Feb 22nd)

Comment 9

•

5 months ago

This is actually a fix for geckodriver, so lets block it bug 1938333. Ideally we should have used a separate bug, but I missed that when doing the review.

When the failure is fixed we should also tag it for M17 and set points.

Blocks: 1938333

Sandor Molnar[:smolnar]

Comment 10

•

5 months ago

bugherder

https://hg.mozilla.org/mozilla-central/rev/fcc85646c9ec

Status: ASSIGNED → RESOLVED

Closed: 5 months ago

status-firefox145: --- → fixed

Resolution: --- → FIXED

Target Milestone: --- → 145 Branch

Comment hidden (Intermittent Failures Robot)

Alexandra Borovova [:Sasha]

Assignee

Updated

•

4 months ago

Points: --- → 2

Whiteboard: [webdriver:m17]

Phabricator Automation

Comment 12

•

4 months ago

firefox-beta Uplift Approval Request

User impact if declined: The android emulator might keep on failing to launch.
Code covered by automated testing: yes
Fix verified in Nightly: yes
Needs manual QE test: no
Steps to reproduce for manual QE testing:
Risk associated with taking this patch: low
Explanation of risk level: Affects only automation
String changes made/needed: None
Is Android affected?: yes

Attachment #9516363 - Flags: approval-mozilla-beta?

Alexandra Borovova [:Sasha]

Assignee

Comment 13

•

4 months ago

Attached file Bug 1985523 - [geckodriver] Try to relaunch Android testrunner when it failed first time. — Details

Original Revision: https://phabricator.services.mozilla.com/D264939

Phabricator Automation

Updated

•

4 months ago

Attachment #9516363 - Flags: approval-mozilla-beta? → approval-mozilla-beta+

Lando Automation

Updated

•

4 months ago

status-firefox144: --- → fixed

Pulsebot

Comment 14

•

4 months ago

uplift

https://github.com/mozilla-firefox/firefox/commit/7e29dbd8beee https://hg.mozilla.org/releases/mozilla-beta/rev/a4cd85b02523

Comment hidden (Intermittent Failures Robot)

Bug 1985523 - [geckodriver] Try to relaunch Android testrunner when it failed first time. 5 months ago Alexandra Borovova [:Sasha] 48 bytes, text/x-phabricator-request		Details \| Review
Bug 1985523 - [geckodriver] Try to relaunch Android testrunner when it failed first time. 4 months ago Alexandra Borovova [:Sasha] 48 bytes, text/x-phabricator-request	phab-bot : approval-mozilla-beta+	Details \| Review

	no_variant	nofis	nofis-noship
android-x86/debug	2	2
android-x86/opt	2	4	1

	headless	no_variant	nofis	nofis-noship	nogpu
android-x86/debug		6	5	2
android-x86/opt		7	3	2	1
windows11-x86_64/opt	1	2

	no_variant	nofis	nofis-noship
android-x86/debug		1	2
android-x86/opt	3	3

	no_variant	nofis	nofis-noship
android-x86/debug	4	1
android-x86/opt	6	3	3

Intermittent Android Wd | <random> - setup error: webdriver.error.UnknownErrorException: unknown error (500): Could not launch Android org.mozilla.geckoview.test_runner/.App: Resource temporarily unavailable (os error 11)

Repository breakdown:

Table

For more details, see:

Repository breakdown:

Table

For more details, see:

Repository breakdown:

Table

For more details, see:

Repository breakdown:

Table

For more details, see:

firefox-beta Uplift Approval Request

Repository breakdown:

Table

For more details, see: