Intermittent Android Wd TEST-UNEXPECTED-TIMEOUT | expected OK (TEST-INFO took 80003ms)
Categories
(Remote Protocol :: Marionette, defect, P5)
Tracking
(firefox106 fixed, firefox107 fixed)
People
(Reporter: intermittent-bug-filer, Assigned: whimboo)
References
(Blocks 1 open bug, Regression)
Details
(Keywords: intermittent-failure, regression)
Filed by: nfay [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=390623365&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/MuOTw7euT_WBK-QCbX_32A/runs/0/artifacts/public/logs/live_backing.log
[task 2022-09-15T22:24:08.630Z] 22:24:08 INFO - PID 4352 | 1663280648629 webdriver::server DEBUG -> POST /session/b0ffaa3c-b3e3-4465-abe8-9a74df924395/frame {"id": null}
[task 2022-09-15T22:24:08.666Z] 22:24:08 INFO - PID 4352 | 1663280648665 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2022-09-15T22:24:08.670Z] 22:24:08 INFO - PID 4352 | 1663280648669 webdriver::server DEBUG -> DELETE /session/b0ffaa3c-b3e3-4465-abe8-9a74df924395
[task 2022-09-15T22:24:08.735Z] 22:24:08 INFO - PID 4352 | 1663280648734 webdriver::server DEBUG Teardown session
[task 2022-09-15T22:24:08.735Z] 22:24:08 INFO - PID 4352 | 1663280648734 geckodriver::android DEBUG Force stopping the Android package: org.mozilla.geckoview.test_runner
[task 2022-09-15T22:24:08.736Z] 22:24:08 INFO - PID 4352 | 1663280648734 mozdevice DEBUG Force stopping Android package: org.mozilla.geckoview.test_runner
[task 2022-09-15T22:24:08.736Z] 22:24:08 INFO - PID 4352 | 1663280648734 mozdevice TRACE execute_host_command: >> "host:transport:emulator-5554"
[task 2022-09-15T22:24:08.737Z] 22:24:08 INFO - PID 4352 | 1663280648734 mozdevice TRACE execute_host_command: << []
[task 2022-09-15T22:24:08.737Z] 22:24:08 INFO - PID 4352 | 1663280648734 mozdevice TRACE execute_host_command: >> "shell:am force-stop org.mozilla.geckoview.test_runner"
[task 2022-09-15T22:24:08.957Z] 22:24:08 INFO - PID 4352 | 1663280648956 mozdevice TRACE execute_host_command: << ""
[task 2022-09-15T22:24:08.957Z] 22:24:08 INFO - PID 4352 | 1663280648956 mozdevice TRACE execute_host_command: >> "host:transport:emulator-5554"
[task 2022-09-15T22:24:08.957Z] 22:24:08 INFO - PID 4352 | 1663280648956 mozdevice TRACE execute_host_command: << []
[task 2022-09-15T22:24:08.958Z] 22:24:08 INFO - PID 4352 | 1663280648956 mozdevice TRACE execute_host_command: >> "shell:am clear-debug-app org.mozilla.geckoview.test_runner"
[task 2022-09-15T22:24:09.149Z] 22:24:09 INFO - TEST-UNEXPECTED-TIMEOUT | /webdriver/tests/permissions/set.py | expected OK
[task 2022-09-15T22:24:09.149Z] 22:24:09 INFO - TEST-INFO took 80004ms
[task 2022-09-15T22:24:09.150Z] 22:24:09 INFO - Restarting browser for new test group
[task 2022-09-15T22:24:09.218Z] 22:24:09 INFO - Closing logging queue
[task 2022-09-15T22:24:09.219Z] 22:24:09 INFO - queue closed
[task 2022-09-15T22:24:09.308Z] 22:24:09 INFO - PID 4449 | 1663280649306 geckodriver INFO Listening on 127.0.0.1:34731
[task 2022-09-15T22:24:09.308Z] 22:24:09 INFO - Starting runner
[task 2022-09-15T22:24:09.539Z] 22:24:09 INFO - TEST-START | /webdriver/tests/release_actions/release.py
Comment 1•2 years ago
|
||
Hey Henrik, could this also be a different Wd issue or is it just part of one the bugs in "See Also"? Could you take a look please? Thank you!
P.S: There's also this failure, if you could take a look at it, seems to start the same but it looks different after the Force stopping the Android package: org.mozilla.geckoview.test_runner
line
Comment hidden (Intermittent Failures Robot) |
Assignee | ||
Comment 3•2 years ago
|
||
This seems to be a regression from bug 1780219 which mainly affects debug builds on Android. As it looks like the devices or the network are slower then AWS. We should fix both bug 1791373 and bug 1757721.
Comment 4•2 years ago
|
||
:masterwayz, since you are the author of the regressor, bug 1780219, could you take a look?
For more information, please visit auto_nag documentation.
Assignee | ||
Updated•2 years ago
|
Comment 6•2 years ago
|
||
Hi :whimboo, I assume this depends on another bug? Or what's the plan?
Assignee | ||
Comment 8•2 years ago
|
||
Michelle, please see the marked dependencies which track further work to improve some misbehavior or inefficient code.
But basically there was a regression when moving to GCP. Do you know if we have a different worker configuration for the Android jobs in terms of SDD speed etc? I feel that disk throughput has been decrated.
Comment 9•2 years ago
|
||
There's a difference I would bet due to the major difference in the overall instance size. However I'm not sure what the disk size and type is that AWS runs on.
Comment 10•2 years ago
|
||
:ahal, do you know how we could best figure that out?
Comment hidden (Intermittent Failures Robot) |
Assignee | ||
Updated•2 years ago
|
Assignee | ||
Comment 12•2 years ago
|
||
Not a single failure for the most recent merge from autoland to mozilla-central:
https://treeherder.mozilla.org/jobs?repo=mozilla-central&searchStr=wd%2Candroid
I'm going to mark this bug as fixed for both central and beta because the patch from bug 1757721 got already uplifted.
Note that any other timeout failure that might come up for Wdspec on Android will be related to bug 1790325 or bug 1790329.
Updated•2 years ago
|
Updated•2 years ago
|
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment 16•2 years ago
|
||
Reporter | ||
Updated•2 years ago
|
Description
•