Closed Bug 1882855 Opened 1 year ago Closed 1 year ago

Intermittent org.mozilla.geckoview.test.crash.ParentCrashTest#crashParent | single tracking bug

Categories

(GeckoView :: General, defect, P5)

Product:
GeckoView
Component:
General
Platform:
All
Android
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, intermittent-testcase)

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

[task 2024-02-29T18:43:32.429Z] 18:43:32     INFO -  TEST-START | org.mozilla.geckoview.test.crash.ParentCrashTest#crashParent
[task 2024-02-29T18:44:02.460Z] 18:44:02     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=1126
[task 2024-02-29T18:44:02.460Z] 18:44:02     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2024-02-29T18:44:02.460Z] 18:44:02     INFO -  org.mozilla.geckoview.test | Error in crashParent(org.mozilla.geckoview.test.crash.ParentCrashTest):
[task 2024-02-29T18:44:02.460Z] 18:44:02     INFO -  org.mozilla.geckoview.test | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
[task 2024-02-29T18:44:02.460Z] 18:44:02     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:49)
[task 2024-02-29T18:44:02.460Z] 18:44:02     INFO -  org.mozilla.geckoview.test | 	at android.os.Handler.handleCallback(Handler.java:751)
[task 2024-02-29T18:44:02.460Z] 18:44:02     INFO -  org.mozilla.geckoview.test | 	at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2024-02-29T18:44:02.460Z] 18:44:02     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.util.UiThreadUtils.waitForCondition(UiThreadUtils.java:158)
[task 2024-02-29T18:44:02.460Z] 18:44:02     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.TestCrashHandler$Client.getEvalResult(TestCrashHandler.java:175)
[task 2024-02-29T18:44:02.461Z] 18:44:02     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.crash.ParentCrashTest.crashParent(ParentCrashTest.kt:39)
[task 2024-02-29T18:44:02.461Z] 18:44:02     INFO -  org.mozilla.geckoview.test |
[task 2024-02-29T18:44:02.461Z] 18:44:02     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2024-02-29T18:44:02.461Z] 18:44:02     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=crashParent
[task 2024-02-29T18:44:02.461Z] 18:44:02     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.crash.ParentCrashTest
[task 2024-02-29T18:44:02.461Z] 18:44:02     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stack=org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
[task 2024-02-29T18:44:02.461Z] 18:44:02     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:49)
[task 2024-02-29T18:44:02.462Z] 18:44:02     INFO -  org.mozilla.geckoview.test | 	at android.os.Handler.handleCallback(Handler.java:751)
[task 2024-02-29T18:44:02.462Z] 18:44:02     INFO -  org.mozilla.geckoview.test | 	at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2024-02-29T18:44:02.462Z] 18:44:02     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.util.UiThreadUtils.waitForCondition(UiThreadUtils.java:158)
[task 2024-02-29T18:44:02.462Z] 18:44:02     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.TestCrashHandler$Client.getEvalResult(TestCrashHandler.java:175)
[task 2024-02-29T18:44:02.462Z] 18:44:02     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.crash.ParentCrashTest.crashParent(ParentCrashTest.kt:39)
[task 2024-02-29T18:44:02.462Z] 18:44:02     INFO -  org.mozilla.geckoview.test |
[task 2024-02-29T18:44:02.462Z] 18:44:02     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=1126
[task 2024-02-29T18:44:02.462Z] 18:44:02     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: -2
[task 2024-02-29T18:44:02.462Z] 18:44:02     INFO -  Printing logcat for test:
[task 2024-02-29T18:44:02.918Z] 18:44:02     INFO -  None
[task 2024-02-29T18:44:02.918Z] 18:44:02  WARNING -  TEST-UNEXPECTED-FAIL | org.mozilla.geckoview.test.crash.ParentCrashTest#crashParent | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
[task 2024-02-29T18:44:02.918Z] 18:44:02     INFO -  TEST-INFO took 30489ms
[task 2024-02-29T18:44:02.918Z] 18:44:02     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_RESULT: stream=
[task 2024-02-29T18:44:02.918Z] 18:44:02     INFO -  org.mozilla.geckoview.test |
[task 2024-02-29T18:44:02.919Z] 18:44:02     INFO -  org.mozilla.geckoview.test | Time: 1,267.446
[task 2024-02-29T18:44:02.919Z] 18:44:02     INFO -  org.mozilla.geckoview.test | There was 1 failure:
[task 2024-02-29T18:44:02.919Z] 18:44:02     INFO -  org.mozilla.geckoview.test | 1) crashParent(org.mozilla.geckoview.test.crash.ParentCrashTest)
[task 2024-02-29T18:44:02.919Z] 18:44:02     INFO -  org.mozilla.geckoview.test | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
[task 2024-02-29T18:44:02.919Z] 18:44:02     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:49)
[task 2024-02-29T18:44:02.919Z] 18:44:02     INFO -  org.mozilla.geckoview.test | 	at android.os.Handler.handleCallback(Handler.java:751)
[task 2024-02-29T18:44:02.919Z] 18:44:02     INFO -  org.mozilla.geckoview.test | 	at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2024-02-29T18:44:02.919Z] 18:44:02     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.util.UiThreadUtils.waitForCondition(UiThreadUtils.java:158)
[task 2024-02-29T18:44:02.920Z] 18:44:02     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.TestCrashHandler$Client.getEvalResult(TestCrashHandler.java:175)
[task 2024-02-29T18:44:02.920Z] 18:44:02     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.crash.ParentCrashTest.crashParent(ParentCrashTest.kt:39)
[task 2024-02-29T18:44:02.920Z] 18:44:02     INFO -  org.mozilla.geckoview.test |
[task 2024-02-29T18:44:02.920Z] 18:44:02     INFO -  org.mozilla.geckoview.test | FAILURES!!!
[task 2024-02-29T18:44:02.920Z] 18:44:02     INFO -  org.mozilla.geckoview.test | Tests run: 1106,  Failures: 1
[task 2024-02-29T18:44:02.920Z] 18:44:02     INFO -  org.mozilla.geckoview.test |
[task 2024-02-29T18:44:02.920Z] 18:44:02     INFO -  org.mozilla.geckoview.test |
[task 2024-02-29T18:44:02.920Z] 18:44:02     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_CODE: -1
[task 2024-02-29T18:44:02.920Z] 18:44:02     INFO -  Passed: 999
[task 2024-02-29T18:44:02.920Z] 18:44:02  WARNING -  Failed: 1
[task 2024-02-29T18:44:02.920Z] 18:44:02  WARNING -  One or more unittests failed.
[task 2024-02-29T18:44:02.920Z] 18:44:02     INFO -  Todo: 126
[task 2024-02-29T18:44:02.920Z] 18:44:02     INFO -  SUITE-END | took 1270s
[task 2024-02-29T18:44:02.983Z] 18:44:02     INFO -  Stopping web server
[task 2024-02-29T18:44:02.987Z] 18:44:02     INFO -  Server shut down.
[task 2024-02-29T18:44:02.987Z] 18:44:02     INFO -  Web server killed.
[task 2024-02-29T18:44:02.987Z] 18:44:02     INFO -  Stopping web socket server
[task 2024-02-29T18:44:02.987Z] 18:44:02     INFO -  Stopping ssltunnel
[task 2024-02-29T18:44:03.307Z] 18:44:03     INFO - Return code: 1
[task 2024-02-29T18:44:03.307Z] 18:44:03     INFO - TinderboxPrint: geckoview-junit<br/>999/<em class="testfail">1</em>
[task 2024-02-29T18:44:03.307Z] 18:44:03     INFO - ##### geckoview-junit log ends
[task 2024-02-29T18:44:03.307Z] 18:44:03  WARNING - setting return code to 1
[task 2024-02-29T18:44:03.307Z] 18:44:03     INFO - The geckoview-junit suite: geckoview-junit ran with return status: WARNING
[task 2024-02-29T18:44:03.307Z] 18:44:03     INFO - Running post-action listener: _package_coverage_data
[task 2024-02-29T18:44:03.307Z] 18:44:03     INFO - Running post-action listener: _resource_record_post_action
[task 2024-02-29T18:44:03.307Z] 18:44:03     INFO - Running post-action listener: process_java_coverage_data
[task 2024-02-29T18:44:03.307Z] 18:44:03     INFO - Running post-action listener: stop_device
[task 2024-02-29T18:44:03.571Z] 18:44:03     INFO - Killing logcat pid 1645.
[task 2024-02-29T18:44:03.571Z] 18:44:03     INFO - Killing every process called qemu-system-x86_64
[task 2024-02-29T18:44:03.576Z] 18:44:03     INFO - [mozharness: 2024-02-29 18:44:03.576593Z] Finished run-tests step (success)
[task 2024-02-29T18:44:03.576Z] 18:44:03     INFO - Running post-run listener: _resource_record_post_run
[task 2024-02-29T18:44:04.525Z] 18:44:04     INFO - Total resource usage - Wall time: 1314s; CPU: 19%; Read bytes: 0; Write bytes: 1087737856; Read time: 0; Write time: 343328
[task 2024-02-29T18:44:04.525Z] 18:44:04     INFO - TinderboxPrint: CPU usage<br/>18.6%
[task 2024-02-29T18:44:04.525Z] 18:44:04     INFO - TinderboxPrint: I/O read bytes / time<br/>0 / 0
[task 2024-02-29T18:44:04.525Z] 18:44:04     INFO - TinderboxPrint: I/O write bytes / time<br/>1,087,737,856 / 343,328
[task 2024-02-29T18:44:04.525Z] 18:44:04     INFO - TinderboxPrint: CPU guest<br/>1,944.2 (8.5%)
[task 2024-02-29T18:44:04.525Z] 18:44:04     INFO - TinderboxPrint: CPU idle<br/>16,957.5 (74.4%)
[task 2024-02-29T18:44:04.525Z] 18:44:04     INFO - TinderboxPrint: CPU system<br/>849.3 (3.7%)
[task 2024-02-29T18:44:04.525Z] 18:44:04     INFO - TinderboxPrint: CPU user<br/>3,042.9 (13.3%)
[task 2024-02-29T18:44:04.525Z] 18:44:04     INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2024-02-29T18:44:04.527Z] 18:44:04     INFO - start-emulator - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-02-29T18:44:04.534Z] 18:44:04     INFO - verify-device - Wall time: 31s; CPU: 13%; Read bytes: 0; Write bytes: 85422080; Read time: 0; Write time: 14168
[task 2024-02-29T18:44:04.538Z] 18:44:04     INFO - install - Wall time: 9s; CPU: 18%; Read bytes: 0; Write bytes: 503808; Read time: 0; Write time: 104
[task 2024-02-29T18:44:04.780Z] 18:44:04     INFO - run-tests - Wall time: 1273s; CPU: 19%; Read bytes: 0; Write bytes: 1001598976; Read time: 0; Write time: 329056
[task 2024-02-29T18:44:10.212Z] 18:44:10  WARNING - returning nonzero exit status 1
[task 2024-02-29T18:44:10.573Z] cleanup
[task 2024-02-29T18:44:10.573Z] + cleanup

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.

Status: NEW → RESOLVED
Closed: 1 year ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.