1607537 - Intermittent org.mozilla.geckoview.test.crash.ParentCrashTest#crashParent | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms

Status: RESOLVED FIXED

(GeckoView :: General, defect, P1)

Description

[Treeherder Bug Filer]

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

---

[task 2020-01-07T17:02:59.382Z] 17:02:59 INFO - TEST-START | org.mozilla.geckoview.test.crash.ParentCrashTest.crashParent
[task 2020-01-07T17:03:29.597Z] 17:03:29 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=621
[task 2020-01-07T17:03:29.597Z] 17:03:29 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2020-01-07T17:03:29.597Z] 17:03:29 INFO - org.mozilla.geckoview.test | Process crashed while executing crashParent(org.mozilla.geckoview.test.crash.ParentCrashTest):
[task 2020-01-07T17:03:29.598Z] 17:03:29 INFO - org.mozilla.geckoview.test | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
[task 2020-01-07T17:03:29.598Z] 17:03:29 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:58)
[task 2020-01-07T17:03:29.598Z] 17:03:29 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:751)
[task 2020-01-07T17:03:29.598Z] 17:03:29 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2020-01-07T17:03:29.598Z] 17:03:29 INFO - org.mozilla.geckoview.test | at android.os.Looper.loop(Looper.java:154)
[task 2020-01-07T17:03:29.598Z] 17:03:29 INFO - org.mozilla.geckoview.test | at android.app.ActivityThread.main(ActivityThread.java:6077)
[task 2020-01-07T17:03:29.598Z] 17:03:29 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Native Method)
[task 2020-01-07T17:03:29.598Z] 17:03:29 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:866)
[task 2020-01-07T17:03:29.598Z] 17:03:29 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:756)
[task 2020-01-07T17:03:29.599Z] 17:03:29 INFO - org.mozilla.geckoview.test |
[task 2020-01-07T17:03:29.599Z] 17:03:29 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2020-01-07T17:03:29.599Z] 17:03:29 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=crashParent
[task 2020-01-07T17:03:29.599Z] 17:03:29 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.crash.ParentCrashTest
[task 2020-01-07T17:03:29.599Z] 17:03:29 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stack=org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
[task 2020-01-07T17:03:29.599Z] 17:03:29 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:58)
[task 2020-01-07T17:03:29.600Z] 17:03:29 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:751)
[task 2020-01-07T17:03:29.600Z] 17:03:29 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2020-01-07T17:03:29.600Z] 17:03:29 INFO - org.mozilla.geckoview.test | at android.os.Looper.loop(Looper.java:154)
[task 2020-01-07T17:03:29.600Z] 17:03:29 INFO - org.mozilla.geckoview.test | at android.app.ActivityThread.main(ActivityThread.java:6077)
[task 2020-01-07T17:03:29.600Z] 17:03:29 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Native Method)
[task 2020-01-07T17:03:29.600Z] 17:03:29 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:866)
[task 2020-01-07T17:03:29.600Z] 17:03:29 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:756)
[task 2020-01-07T17:03:29.600Z] 17:03:29 INFO - org.mozilla.geckoview.test |
[task 2020-01-07T17:03:29.600Z] 17:03:29 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=621
[task 2020-01-07T17:03:29.600Z] 17:03:29 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: -2
[task 2020-01-07T17:03:29.601Z] 17:03:29 WARNING - TEST-UNEXPECTED-FAIL | org.mozilla.geckoview.test.crash.ParentCrashTest.crashParent | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
[task 2020-01-07T17:03:29.601Z] 17:03:29 INFO - TEST-INFO took 30218ms

Comment 1

[Intermittent Failures Robot]

17 failures in 819 pushes (0.021 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 17

Platform breakdown:

• android-em-7-0-x86_64: 17

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1607537&startday=2020-01-09&endday=2020-01-09&tree=all

Comment 2

[(No longer employed by Mozilla) Aaron Klotz]

This is giving me some grief re: landing e10s-multi patches, so I'm looking into it.

Comment 3

[Intermittent Failures Robot]

20 failures in 4472 pushes (0.004 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 20

Platform breakdown:

• android-em-7-0-x86_64: 20

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1607537&startday=2020-01-06&endday=2020-01-12&tree=all

Comment 4

[Intermittent Failures Robot]

1 failures in 3773 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• try: 1

Platform breakdown:

• android-em-7-0-x86_64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1607537&startday=2020-01-13&endday=2020-01-19&tree=all

Comment 5

[(No longer employed by Mozilla) Aaron Klotz]

https://treeherder.mozilla.org/#/jobs?repo=try&revision=47a9964622ecae9a756f315cc067bada817c447b

All green with respect to ParentCrashTest!

Comment 6

[(No longer employed by Mozilla) Aaron Klotz]

Attachment: Bug 1607537: Fix timeouts in ParentCrashTest.crashParent and re-enable the test; r=#geckoview-reviewers

The fundamental issue here is that ParentCrashTest starts a second
GeckoRuntime via RemoteGeckoService within the same logical Android
Application.

This patch RuntimeCreator.shutdownRuntime() so that the test can shutdown the
existing GeckoRuntime before starting up its own.

Comment 7

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/489dd8dc1af0
Fix timeouts in ParentCrashTest.crashParent and re-enable the test; r=geckoview-reviewers,esawin

Comment 8

[Andreea Pavel [:apavel]]

https://hg.mozilla.org/mozilla-central/rev/489dd8dc1af0

Comment 9

[[ex-Mozilla] Agi Sferro | :agi]

6c6f5da9-bf33-4082-a19d-7d99e8083d97 Mass rename intermittents due to Bug 1723034.

Comment 10

[[ex-Mozilla] Agi Sferro | :agi]

Attachment: Bug 1696460 - Revert "Bug 1607537: Fix timeouts in ParentCrashTest.crashParent and re-enable the test"

The code in this patch is not needed anymore because now we can handle multiple
in-app runtimes after Bug 1696460.

This reverts commit d49a34c51bc537caffcd559cda07be994105cebb.

Comment 11

[Phabricator Automation]

Comment on attachment 9238566 [details]
Bug 1696460 - Revert "Bug 1607537: Fix timeouts in ParentCrashTest.crashParent and re-enable the test"

Revision D123980 was moved to bug 1696460. Setting attachment 9238566 [details] to obsolete.