1627523 - Intermittent Android - Return code: 1 | ERROR /tests/dom/tests/mochitest/general/test_selectevents.html logged result after SimpleTest.finish(): The original target of selectionchange should be the document

Status: RESOLVED INCOMPLETE

(Core :: DOM: Core & HTML, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2020-04-05T16:02:19.441Z] 16:02:19     INFO -  1730 INFO TEST-OK | dom/tests/mochitest/general/test_resource_timing_nocors.html | took 309ms
[task 2020-04-05T16:02:19.441Z] 16:02:19     INFO -  1731 INFO TEST-START | dom/tests/mochitest/general/test_selectevents.html
[task 2020-04-05T16:02:19.456Z] 16:02:19     INFO -  1732 INFO TEST-OK | dom/tests/mochitest/general/test_selectevents.html | took 874ms
[task 2020-04-05T16:02:19.458Z] 16:02:19     INFO -  1733 ERROR /tests/dom/tests/mochitest/general/test_selectevents.html logged result after SimpleTest.finish(): The original target of selectionchange should be the document
[task 2020-04-05T16:02:19.458Z] 16:02:19     INFO -  1734 INFO TEST-START | dom/tests/mochitest/general/test_showModalDialog_removed.html
[task 2020-04-05T16:02:19.458Z] 16:02:19     INFO -  1735 INFO TEST-OK | dom/tests/mochitest/general/test_showModalDialog_removed.html | took 80ms
[task 2020-04-05T16:02:19.458Z] 16:02:19     INFO -  1736 INFO TEST-START | dom/tests/mochitest/general/test_storagePermissionsAccept.html
[task 2020-04-05T16:02:19.465Z] 16:02:19     INFO -  1737 INFO TEST-OK | dom/tests/mochitest/general/test_storagePermissionsAccept.html | took 669ms
[task 2020-04-05T16:02:19.466Z] 16:02:19     INFO -  1738 INFO TEST-START | dom/tests/mochitest/general/test_storagePermissionsLimitForeign.html
[task 2020-04-05T16:02:19.472Z] 16:02:19     INFO -  1739 INFO TEST-OK | dom/tests/mochitest/general/test_storagePermissionsLimitForeign.html | took 575ms
[task 2020-04-05T16:02:19.473Z] 16:02:19     INFO -  1740 INFO TEST-START | dom/tests/mochitest/general/test_storagePermissionsReject.html
[task 2020-04-05T16:02:19.481Z] 16:02:19     INFO -  1741 INFO TEST-OK | dom/tests/mochitest/general/test_storagePermissionsReject.html | took 692ms
[task 2020-04-05T16:02:19.481Z] 16:02:19     INFO -  1742 INFO TEST-START | dom/tests/mochitest/general/test_storagePermissionsRejectForeign.html
[task 2020-04-05T16:02:19.488Z] 16:02:19     INFO -  1743 INFO TEST-OK | dom/tests/mochitest/general/test_storagePermissionsRejectForeign.html | took 636ms
[task 2020-04-05T16:02:19.488Z] 16:02:19     INFO -  1744 INFO TEST-START | dom/tests/mochitest/general/test_stylesheetPI.html
[task 2020-04-05T16:02:19.488Z] 16:02:19     INFO -  1745 INFO TEST-OK | dom/tests/mochitest/general/test_stylesheetPI.html | took 66ms
[task 2020-04-05T16:02:19.488Z] 16:02:19     INFO -  1746 INFO TEST-START | dom/tests/mochitest/general/test_vibrator.html
[task 2020-04-05T16:02:29.808Z] 16:02:29     INFO -  1747 INFO TEST-OK | dom/tests/mochitest/general/test_vibrator.html | took 4398ms
[task 2020-04-05T16:02:29.809Z] 16:02:29     INFO -  1748 INFO TEST-START | dom/tests/mochitest/general/test_windowProperties.html
[task 2020-04-05T16:02:29.809Z] 16:02:29     INFO -  1749 INFO TEST-OK | dom/tests/mochitest/general/test_windowProperties.html | took 73ms
[task 2020-04-05T16:02:29.810Z] 16:02:29     INFO -  1750 INFO TEST-START | dom/tests/mochitest/general/test_windowedhistoryframes.html
[task 2020-04-05T16:02:29.811Z] 16:02:29     INFO -  1751 INFO TEST-OK | dom/tests/mochitest/general/test_windowedhistoryframes.html | took 380ms
[task 2020-04-05T16:02:29.811Z] 16:02:29     INFO -  1752 INFO TEST-START | Shutdown
[task 2020-04-05T16:02:29.812Z] 16:02:29     INFO -  1753 INFO Passed:  6377
[task 2020-04-05T16:02:29.812Z] 16:02:29  WARNING -  1754 INFO Failed:  1
[task 2020-04-05T16:02:29.812Z] 16:02:29  WARNING -  One or more unittests failed.
[task 2020-04-05T16:02:29.812Z] 16:02:29     INFO -  1755 INFO Todo:    11
[task 2020-04-05T16:02:29.813Z] 16:02:29     INFO -  1756 INFO Mode:    e10s
[task 2020-04-05T16:02:29.813Z] 16:02:29     INFO -  1757 INFO Slowest: 5287ms - /tests/dom/tests/mochitest/general/test_bug1170911.html
[task 2020-04-05T16:02:29.813Z] 16:02:29     INFO -  1758 INFO SimpleTest FINISHED
[task 2020-04-05T16:02:31.573Z] 16:02:31     INFO -  wait for org.mozilla.geckoview.test complete; top activity=com.android.launcher3
[task 2020-04-05T16:02:31.683Z] 16:02:31     INFO -  remoteautomation.py | Application ran for: 0:00:49.763715
[task 2020-04-05T16:02:32.681Z] 16:02:32     INFO -  runtests.py | Running with scheme: https
[task 2020-04-05T16:02:32.681Z] 16:02:32     INFO -  runtests.py | Running with e10s: True
[task 2020-04-05T16:02:32.682Z] 16:02:32     INFO -  runtests.py | Running with fission: False
[task 2020-04-05T16:02:32.682Z] 16:02:32     INFO -  runtests.py | Running with serviceworker_e10s: True
[task 2020-04-05T16:02:32.683Z] 16:02:32     INFO -  runtests.py | Running with socketprocess_e10s: False
[task 2020-04-05T16:02:32.683Z] 16:02:32     INFO -  runtests.py | Running tests: start.
[task 2020-04-05T16:02:33.329Z] 16:02:33     INFO -  remoteautomation.py | runApp deleted /sdcard/tests/logs/mochitest.log
[task 2020-04-05T16:02:33.544Z] 16:02:33     INFO -  adb Granting important runtime permissions to org.mozilla.geckoview.test
[task 2020-04-05T16:02:34.776Z] 16:02:34     INFO -  adb launch_application: am start -W -n org.mozilla.geckoview.test/org.mozilla.geckoview.test.TestRunnerActivity -a android.intent.action.MAIN --es env9 MOZ_UPLOAD_DIR=/sdcard/tests/mozlog --es env8 R_LOG_DESTINATION=stderr --es args "-no-remote -profile /sdcard/tests/profile//" --es env3 R_LOG_VERBOSE=1 --es env2 XPCOM_DEBUG_BREAK=stack --es env1 MOZ_WEBRENDER=0 --es env0 MOZ_CRASHREPORTER=1 --es env7 MOZ_CRASHREPORTER_SHUTDOWN=1 --es env6 MOZ_IN_AUTOMATION=1 --es env5 MOZ_DISABLE_NONLOCAL_CONNECTIONS=1 --es env4 DISABLE_UNSAFE_CPOW_WARNINGS=1 --ez use_multiprocess True --es env12 MOZ_HIDE_RESULTS_TABLE=1 --es env11 R_LOG_LEVEL=6 --es env10 MOZ_CRASHREPORTER_NO_REPORT=1 -d "https://example.com:443/tests?autorun=1&closeWhenDone=1&logFile=%2Fsdcard%2Ftests%2Flogs%2Fmochitest.log&fileLevel=INFO&consoleLevel=INFO&hideResultsTable=1&manifestFile=tests.json&dumpOutputDirectory=%2Fsdcard%2Ftests"
[task 2020-04-05T16:02:35.486Z] 16:02:35     INFO -  remoteautomation.py | Application pid: 9510
[task 2020-04-05T16:02:38.441Z] 16:02:38     INFO -  1759 INFO SimpleTest START
<...>
[task 2020-04-05T16:10:00.247Z] 16:10:00     INFO -  SUITE-END | took 1334s
[task 2020-04-05T16:10:00.259Z] 16:10:00    ERROR - Return code: 1
[task 2020-04-05T16:10:00.259Z] 16:10:00     INFO - TinderboxPrint: mochitest-plain<br/>95015/<em class="testfail">1</em>/2048
[task 2020-04-05T16:10:00.259Z] 16:10:00     INFO - ##### mochitest-plain log ends
[task 2020-04-05T16:10:00.259Z] 16:10:00  WARNING - # TBPL WARNING #
[task 2020-04-05T16:10:00.259Z] 16:10:00  WARNING - setting return code to 1
[task 2020-04-05T16:10:00.259Z] 16:10:00  WARNING - The mochitest-plain suite: mochitest-plain ran with return status: WARNING
[task 2020-04-05T16:10:00.259Z] 16:10:00     INFO - Running post-action listener: _package_coverage_data
[task 2020-04-05T16:10:00.261Z] 16:10:00     INFO - Running post-action listener: _resource_record_post_action
[task 2020-04-05T16:10:00.261Z] 16:10:00     INFO - Running post-action listener: process_java_coverage_data
[task 2020-04-05T16:10:00.261Z] 16:10:00     INFO - Running post-action listener: stop_device
[task 2020-04-05T16:10:01.897Z] 16:10:01     INFO - Killing logcat pid 1009.
[task 2020-04-05T16:10:01.897Z] 16:10:01     INFO - Killing every process called qemu-system-x86_64
[task 2020-04-05T16:10:01.904Z] 16:10:01     INFO - [mozharness: 2020-04-05 16:10:01.904320Z] Finished run-tests step (success)
[task 2020-04-05T16:10:01.904Z] 16:10:01     INFO - Running post-run listener: _resource_record_post_run
[task 2020-04-05T16:10:02.012Z] 16:10:02     INFO - Total resource usage - Wall time: 1352s; CPU: 33.0%; Read bytes: 855863296; Write bytes: 86555410432; Read time: 12272; Write time: 14412984
[task 2020-04-05T16:10:02.012Z] 16:10:02     INFO - TinderboxPrint: CPU usage<br/>33.4%
[task 2020-04-05T16:10:02.012Z] 16:10:02     INFO - TinderboxPrint: I/O read bytes / time<br/>855,863,296 / 12,272
[task 2020-04-05T16:10:02.012Z] 16:10:02     INFO - TinderboxPrint: I/O write bytes / time<br/>86,555,410,432 / 14,412,984
[task 2020-04-05T16:10:02.012Z] 16:10:02     INFO - TinderboxPrint: CPU guest<br/>1,909.9 (15.1%)
[task 2020-04-05T16:10:02.012Z] 16:10:02     INFO - TinderboxPrint: CPU idle<br/>7,071.8 (56.1%)
[task 2020-04-05T16:10:02.012Z] 16:10:02     INFO - TinderboxPrint: CPU system<br/>783.2 (6.2%)
[task 2020-04-05T16:10:02.012Z] 16:10:02     INFO - TinderboxPrint: CPU user<br/>2,751.4 (21.8%)
[task 2020-04-05T16:10:02.012Z] 16:10:02     INFO - TinderboxPrint: Swap in / out<br/>8,192 / 20,480
[task 2020-04-05T16:10:02.013Z] 16:10:02     INFO - verify-device - Wall time: 4s; CPU: 18.0%; Read bytes: 0; Write bytes: 10237952; Read time: 0; Write time: 64
[task 2020-04-05T16:10:02.013Z] 16:10:02     INFO - install - Wall time: 3s; CPU: 49.0%; Read bytes: 8192; Write bytes: 1047185408; Read time: 0; Write time: 66944
[task 2020-04-05T16:10:02.027Z] 16:10:02     INFO - run-tests - Wall time: 1343s; CPU: 33.0%; Read bytes: 855855104; Write bytes: 84591226880; Read time: 12272; Write time: 14095624
[task 2020-04-05T16:10:02.381Z] 16:10:02  WARNING - returning nonzero exit status 1
[task 2020-04-05T16:10:02.405Z] cleanup
[task 2020-04-05T16:10:02.406Z] + cleanup
[task 2020-04-05T16:10:02.406Z] + local rv=1
[task 2020-04-05T16:10:02.406Z] + [[ -s /builds/worker/.xsession-errors ]]
[task 2020-04-05T16:10:02.406Z] + cp /builds/worker/.xsession-errors /builds/worker/artifacts/public/xsession-errors.log
[task 2020-04-05T16:10:02.407Z] + true
[task 2020-04-05T16:10:02.407Z] + cleanup_xvfb
[task 2020-04-05T16:10:02.407Z] pidof Xvfb
[task 2020-04-05T16:10:02.407Z] ++ pidof Xvfb
[task 2020-04-05T16:10:02.409Z] + local xvfb_pid=30
[task 2020-04-05T16:10:02.409Z] + local vnc=false
[task 2020-04-05T16:10:02.410Z] + local interactive=false
[task 2020-04-05T16:10:02.410Z] + '[' -n 30 ']'
[task 2020-04-05T16:10:02.410Z] + [[ false == false ]]
[task 2020-04-05T16:10:02.410Z] + [[ false == false ]]
[task 2020-04-05T16:10:02.410Z] + kill 30
[task 2020-04-05T16:10:02.410Z] + screen -XS xvfb quit
[task 2020-04-05T16:10:02.411Z] XIO:  fatal IO error 11 (Resource temporarily unavailable) on X server ":0"
[task 2020-04-05T16:10:02.411Z]       after 1409 requests (1409 known processed) with 1 events remaining.
[task 2020-04-05T16:10:02.411Z] compizconfig - Info: Backend     : ini
[task 2020-04-05T16:10:02.411Z] compizconfig - Info: Integration : true
[task 2020-04-05T16:10:02.411Z] compizconfig - Info: Profile     : default
[task 2020-04-05T16:10:02.413Z] + exit 1
[fetches 2020-04-05T16:10:02.413Z] removing /builds/worker/fetches
[fetches 2020-04-05T16:10:02.414Z] finished
[taskcluster 2020-04-05 16:10:04.023Z] === Task Finished ===
[taskcluster 2020-04-05 16:10:08.685Z] Unsuccessful task run with exit code: 1 completed in 1446.823 seconds

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1
• mozilla-central: 1

Platform breakdown:

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

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1627523&startday=2020-03-30&endday=2020-04-05&tree=all

Comment 3

[Intermittent Failures Robot]

11 failures in 4823 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 11

Platform breakdown:

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

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

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 14
• try: 2
• mozilla-central: 3
• mozilla-beta: 1

Platform breakdown:

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

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

Comment 5

[Intermittent Failures Robot]

14 failures in 5582 pushes (0.003 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 13
• mozilla-esr68: 1

Platform breakdown:

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

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1627523&startday=2020-04-20&endday=2020-04-26&tree=all

Comment 6

[Intermittent Failures Robot]

4 failures in 5423 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 3
• mozilla-central: 1

Platform breakdown:

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

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1627523&startday=2020-04-27&endday=2020-05-03&tree=all

Comment 7

[Intermittent Failures Robot]

6 failures in 5276 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 2
• mozilla-esr68: 1
• mozilla-central: 1
• mozilla-beta: 2

Platform breakdown:

• android-em-7-0-x86_64: 5
• windows7-32-mingwclang: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1627523&startday=2020-05-04&endday=2020-05-10&tree=all

Comment 8

[Intermittent Failures Robot]

5 failures in 5488 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-beta: 2
• autoland: 2
• try: 1

Platform breakdown:

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

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1627523&startday=2020-05-11&endday=2020-05-17&tree=all

Comment 9

[Intermittent Failures Robot]

6 failures in 4727 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-beta: 4
• try: 2

Platform breakdown:

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

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1627523&startday=2020-05-18&endday=2020-05-24&tree=all

Comment 10

[Intermittent Failures Robot]

7 failures in 5458 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 7

Platform breakdown:

• android-em-7-0-x86_64: 3
• android-em-7-0-x86_64-qr: 4

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1627523&startday=2020-05-25&endday=2020-05-31&tree=all

Comment 11

[Intermittent Failures Robot]

7 failures in 4949 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 3
• mozilla-beta: 2
• mozilla-central: 2

Platform breakdown:

• android-em-7-0-x86_64-qr: 5
• android-em-7-0-x86_64: 2

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

Comment 15

[Geoff Brown [:gbrown]]

This test was skipped on android for a long time with the comment:

skip-if = toolkit == 'android' # bug 1230232 - Mouse doesn't select in the same way

I removed that skip-if in bug 1585119, because I thought it was running reliably. It looks like I was wrong.

Comment 16

[Geoff Brown [:gbrown]]

Attachment: Bug 1627523 - Disable test_selectevents.html on android for intermittent failures; r=

In addition to the failures tracked by this bug and its dups for many months, there are likely
many other Android test_selectevents.html failures going unnoticed or reported to random bugs
because the failure message generated here is not picked up by treeherder bug suggestions (separate
issue tracked by bug 1407293). Note that this test has traditionally been skipped on Android;
I enabled it in bug 1585119, thinking that it was running reliably.

Comment 17

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/bd1e6309d1fc
Disable test_selectevents.html on android for intermittent failures; r=snorp

Comment 18

[Bogdan Tara[:bogdan_tara | bogdant]]

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

Comment 19

[Intermittent Failures Robot]

7 failures in 5211 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 6
• mozilla-beta: 1

Platform breakdown:

• android-em-7-0-x86_64-qr: 4
• android-em-7-0-x86_64: 3

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

Comment 20

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-release: 1

Platform breakdown:

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

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

Comment 21

[BugBot [:suhaib / :marco/ :calixte]]

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

Comment 22

[Razvan Maries]

New occurrence: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=310551887&repo=autoland&lineNumber=19546

Comment 23

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

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

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1627523&startday=2020-07-20&endday=2020-07-26&tree=all

Comment 24

[BugBot [:suhaib / :marco/ :calixte]]

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