1616096 - Intermittent TEST-UNEXPECTED-TIMEOUT | browser/base/content/test/popupNotifications/browser_popupNotification_keyboard.js | application timed out after 370 seconds with no output

Status: RESOLVED FIXED

(Toolkit Graveyard :: Notifications and Alerts, defect, P5)

Description

[Treeherder Bug Filer]

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

---

task 2020-02-17T12:46:41.019Z] 12:46:41 INFO - TEST-PASS | browser/base/content/test/popupNotifications/browser_popupNotification_keyboard.js | PopupNotifications panel exists -
[task 2020-02-17T12:46:41.019Z] 12:46:41 INFO - [Test#1] added listeners; panel is open: false
[task 2020-02-17T12:46:41.020Z] 12:46:41 INFO - [Test#1] running test
[task 2020-02-17T12:46:41.020Z] 12:46:41 INFO - Showing notification test-notification-Test#1
[task 2020-02-17T12:46:41.020Z] 12:46:41 INFO - [Test#1] popup showing
[task 2020-02-17T12:46:41.020Z] 12:46:41 INFO - Buffered messages finished
[task 2020-02-17T12:46:41.020Z] 12:46:41 ERROR - TEST-UNEXPECTED-TIMEOUT | browser/base/content/test/popupNotifications/browser_popupNotification_keyboard.js | application timed out after 370 seconds with no output
[task 2020-02-17T12:46:41.020Z] 12:46:41 ERROR - Force-terminating active process(es).
[task 2020-02-17T12:46:41.020Z] 12:46:41 INFO - Determining child pids from psutil...
[task 2020-02-17T12:46:41.025Z] 12:46:41 INFO - [4860]
[task 2020-02-17T12:46:41.025Z] 12:46:41 INFO - ==> process 4860 launched child process 4528 ("Z:\task_1581942334\build\application\firefox\firefox.exe" -contentproc --channel="4860.0.1936732238\33520860" -parentBuildID 20200217102903 -prefsHandle 2244 -prefMapHandle 2232 -prefsLen 1 -prefMapSize 226605 -greomni "Z:\task_1581942334\build\application\firefox\omni.ja" -appomni "Z:\task_1581942334\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1581942334\build\application\firefox\browser" - 4860 "\.\pipe\gecko-crash-server-pipe.4860" 2316 gpu)
[task 2020-02-17T12:46:41.026Z] 12:46:41 INFO - ==> process 4860 launched child process 7892 ("Z:\task_1581942334\build\application\firefox\firefox.exe" -contentproc --channel="4860.6.1566322364\1721073983" -childID 1 -isForBrowser -prefsHandle 2884 -prefMapHandle 2420 -prefsLen 1387 -prefMapSize 226605 -parentBuildID 20200217102903 -greomni "Z:\task_1581942334\build\application\firefox\omni.ja" -appomni "Z:\task_1581942334\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1581942334\build\application\firefox\browser" - 4860 "\.\pipe\gecko-crash-server-pipe.4860" 2864 tab)
[task 2020-02-17T12:46:41.026Z] 12:46:41 INFO - ==> process 4860 launched child process 8612 ("Z:\task_1581942334\build\application\firefox\firefox.exe" -contentproc --channel="4860.13.812958509\2026195884" -childID 2 -isForBrowser -prefsHandle 3108 -prefMapHandle 3100 -prefsLen 1853 -prefMapSize 226605 -parentBuildID 20200217102903 -greomni "Z:\task_1581942334\build\application\firefox\omni.ja" -appomni "Z:\task_1581942334\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1581942334\build\application\firefox\browser" - 4860 "\.\pipe\gecko-crash-server-pipe.4860" 3116 tab)
[task 2020-02-17T12:46:41.027Z] 12:46:41 INFO - ==> process 4860 launched child process 1808 ("Z:\task_1581942334\build\application\firefox\firefox.exe" -contentproc --channel="4860.20.668480703\148008816" -childID 3 -isForBrowser -prefsHandle 3252 -prefMapHandle 3260 -prefsLen 1853 -prefMapSize 226605 -parentBuildID 20200217102903 -greomni "Z:\task_1581942334\build\application\firefox\omni.ja" -appomni "Z:\task_1581942334\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1581942334\build\application\firefox\browser" - 4860 "\.\pipe\gecko-crash-server-pipe.4860" 3312 tab)
[task 2020-02-17T12:46:41.027Z] 12:46:41 INFO - ==> process 4860 launched child process 7884 ("Z:\task_1581942334\build\application\firefox\firefox.exe" -contentproc --channel="4860.27.536253712\421346558" -childID 4 -isForBrowser -prefsHandle 4440 -prefMapHandle 4280 -prefsLen 11713 -prefMapSize 226605 -parentBuildID 20200217102903 -greomni "Z:\task_1581942334\build\application\firefox\omni.ja" -appomni "Z:\task_1581942334\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1581942334\build\application\firefox\browser" - 4860 "\.\pipe\gecko-crash-server-pipe.4860" 2020 tab)
[task 2020-02-17T12:46:41.028Z] 12:46:41 INFO - ==> process 4860 launched child process 8064 ("Z:\task_1581942334\build\application\firefox\firefox.exe" -contentproc --channel="4860.34.1044675337\674523721" -childID 5 -isForBrowser -prefsHandle 4756 -prefMapHandle 4364 -prefsLen 11713 -prefMapSize 226605 -parentBuildID 20200217102903 -greomni "Z:\task_1581942334\build\application\firefox\omni.ja" -appomni "Z:\task_1581942334\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1581942334\build\application\firefox\browser" - 4860 "\.\pipe\gecko-crash-server-pipe.4860" 4760 tab)
[task 2020-02-17T12:46:41.028Z] 12:46:41 INFO - ==> process 4860 launched child process 3724 ("Z:\task_1581942334\build\application\firefox\firefox.exe" -contentproc --channel="4860.41.1395966619\1140654113" -childID 6 -isForBrowser -prefsHandle 4984 -prefMapHandle 4432 -prefsLen 11713 -prefMapSize 226605 -parentBuildID 20200217102903 -greomni "Z:\task_1581942334\build\application\firefox\omni.ja" -appomni "Z:\task_1581942334\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1581942334\build\application\firefox\browser" - 4860 "\.\pipe\gecko-crash-server-pipe.4860" 5024 tab)
[task 2020-02-17T12:46:41.028Z] 12:46:41 INFO - ==> process 4860 launched child process 9960 ("Z:\task_1581942334\build\application\firefox\firefox.exe" -contentproc --channel="4860.48.1094182064\1614148609" -childID 7 -isForBrowser -prefsHandle 5008 -prefMapHandle 4696 -prefsLen 11793 -prefMapSize 226605 -parentBuildID 20200217102903 -greomni "Z:\task_1581942334\build\application\firefox\omni.ja" -appomni "Z:\task_1581942334\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1581942334\build\application\firefox\browser" - 4860 "\.\pipe\gecko-crash-server-pipe.4860" 4772 tab)
[task 2020-02-17T12:46:41.029Z] 12:46:41 INFO - ==> process 4860 launched child process 10008 ("Z:\task_1581942334\build\application\firefox\firefox.exe" -contentproc --channel="4860.55.1875124281\1626998523" -parentBuildID 20200217102903 -prefsHandle 4868 -prefMapHandle 4696 -prefsLen 11793 -prefMapSize 226605 -greomni "Z:\task_1581942334\build\application\firefox\omni.ja" -appomni "Z:\task_1581942334\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1581942334\build\application\firefox\browser" - 4860 "\.\pipe\gecko-crash-server-pipe.4860" 4932 vr)
[task 2020-02-17T12:46:41.029Z] 12:46:41 INFO - ==> process 4860 launched child process 6004 ("Z:\task_1581942334\build\application\firefox\firefox.exe" -contentproc --channel="4860.57.326975600\1312724635" -childID 8 -isForBrowser -prefsHandle 5204 -prefMapHandle 4976 -prefsLen 11793 -prefMapSize 226605 -parentBuildID 20200217102903 -greomni "Z:\task_1581942334\build\application\firefox\omni.ja" -appomni "Z:\task_1581942334\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1581942334\build\application\firefox\browser" - 4860 "\.\pipe\gecko-crash-server-pipe.4860" 5292 tab)
[task 2020-02-17T12:46:41.029Z] 12:46:41 INFO - ==> process 4860 launched child process 9660 ("Z:\task_1581942334\build\application\firefox\firefox.exe" -contentproc --channel="4860.64.2114631116\503972720" -childID 9 -isForBrowser -prefsHandle 4932 -prefMapHandle 5404 -prefsLen 11873 -prefMapSize 226605 -parentBuildID 20200217102903 -greomni "Z:\task_1581942334\build\application\firefox\omni.ja" -appomni "Z:\task_1581942334\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1581942334\build\application\firefox\browser" - 4860 "\.\pipe\gecko-crash-server-pipe.4860" 5424 tab)
[task 2020-02-17T12:46:41.030Z] 12:46:41 INFO - ==> process 4860 launched child process 8944 ("Z:\task_1581942334\build\application\firefox\firefox.exe" -contentproc --channel="4860.71.1584581373\939999166" -childID 10 -isForBrowser -prefsHandle 5800 -prefMapHandle 5468 -prefsLen 11873 -prefMapSize 226605 -parentBuildID 20200217102903 -greomni "Z:\task_1581942334\build\application\firefox\omni.ja" -appomni "Z:\task_1581942334\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1581942334\build\application\firefox\browser" - 4860 "\.\pipe\gecko-crash-server-pipe.4860" 5648 tab)
[task 2020-02-17T12:46:41.030Z] 12:46:41 INFO - ==> process 4860 launched child process 8952 ("Z:\task_1581942334\build\application\firefox\firefox.exe" -contentproc --channel="4860.78.1889737916\935990426" -childID 11 -isForBrowser -prefsHandle 5700 -prefMapHandle 5772 -prefsLen 11953 -prefMapSize 226605 -parentBuildID 20200217102903 -greomni "Z:\task_1581942334\build\application\firefox\omni.ja" -appomni "Z:\task_1581942334\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1581942334\build\application\firefox\browser" - 4860 "\.\pipe\gecko-crash-server-pipe.4860" 5392 tab)
[task 2020-02-17T12:46:41.031Z] 12:46:41 INFO - ==> process 4860 launched child process 8420 ("Z:\task_1581942334\build\application\firefox\firefox.exe" -contentproc --channel="4860.85.180846702\1137623174" -childID 12 -isForBrowser -prefsHandle 5864 -prefMapHandle 5676 -prefsLen 11953 -prefMapSize 226605 -parentBuildID 20200217102903 -greomni "Z:\task_1581942334\build\application\firefox\omni.ja" -appomni "Z:\task_1581942334\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1581942334\build\application\firefox\browser" - 4860 "\.\pipe\gecko-crash-server-pipe.4860" 5568 tab)
[task 2020-02-17T12:46:41.032Z] 12:46:41 INFO - ==> process 4860 launched child process 4908 ("Z:\task_1581942334\build\application\firefox\firefox.exe" -contentproc --channel="4860.92.2059364444\196298380" -childID 13 -isForBrowser -prefsHandle 5560 -prefMapHandle 5708 -prefsLen 11953 -prefMapSize 226605 -parentBuildID 20200217102903 -greomni "Z:\task_1581942334\build\application\firefox\omni.ja" -appomni "Z:\task_1581942334\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1581942334\build\application\firefox\browser" - 4860 "\.\pipe\gecko-crash-server-pipe.4860" 5480 tab)
[task 2020-02-17T12:46:41.032Z] 12:46:41 INFO - ==> process 4860 launched child process 5688 ("Z:\task_1581942334\build\application\firefox\firefox.exe" -contentproc --channel="4860.99.1355597863\526168350" -childID 14 -isForBrowser -prefsHandle 5708 -prefMapHandle 5916 -prefsLen 11953 -prefMapSize 226605 -parentBuildID 20200217102903 -greomni "Z:\task_1581942334\build\application\firefox\omni.ja" -appomni "Z:\task_1581942334\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1581942334\build\application\firefox\browser" - 4860 "\.\pipe\gecko-crash-server-pipe.4860" 5920 tab)
[task 2020-02-17T12:46:41.032Z] 12:46:41 INFO - ==> process 4860 launched child process 8272 ("Z:\task_1581942334\build\application\firefox\firefox.exe" -contentproc --channel="4860.106.1280130385\22682150" -childID 15 -isForBrowser -prefsHandle 5908 -prefMapHandle 5828 -prefsLen 11953 -prefMapSize 226605 -parentBuildID 20200217102903 -greomni "Z:\task_1581942334\build\application\firefox\omni.ja" -appomni "Z:\task_1581942334\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1581942334\build\application\firefox\browser" - 4860 "\.\pipe\gecko-crash-server-pipe.4860" 5480 tab)
[task 2020-02-17T12:46:41.032Z] 12:46:41 INFO - Found child pids: set([8064, 1808, 8612, 8420, 4908, 9960, 3724, 7884, 5688, 4528, 8952, 7892, 8272, 10008, 6004, 9660, 4860, 8944])
[task 2020-02-17T12:46:41.032Z] 12:46:41 INFO - Failed to get child procs
[task 2020-02-17T12:46:41.033Z] 12:46:41 INFO - Killing process: 8064
[task 2020-02-17T12:46:41.033Z] 12:46:41 INFO - TEST-INFO | started process screenshot
[task 2020-02-17T12:46:41.103Z] 12:46:41 INFO - TEST-INFO | screenshot: exit 0

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 1
• autoland: 2

Platform breakdown:

• windows10-64-shippable: 3

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

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 3

Platform breakdown:

• windows10-64-shippable: 2
• windows10-64-shippable-qr: 1

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

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 6
• try: 2

Platform breakdown:

• windows10-64-shippable: 3
• windows10-64: 2
• windows10-64-shippable-qr: 3

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

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 3

Platform breakdown:

• windows10-64: 1
• windows10-64-shippable-qr: 2

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

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 4
• try: 2
• mozilla-central: 1

Platform breakdown:

• windows10-64-shippable-qr: 6
• windows10-64-shippable: 1

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

Comment 6

[Intermittent Failures Robot]

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

Repository breakdown:

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

Platform breakdown:

• windows10-64-shippable-qr: 5
• windows10-64-shippable: 1

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

Comment 7

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform breakdown:

• windows10-64: 1

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

Comment 8

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2
• mozilla-central: 1

Platform breakdown:

• windows10-64: 1
• windows10-64-shippable-qr: 2

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

Comment 9

[Intermittent Failures Robot]

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

Repository breakdown:

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

Platform breakdown:

• windows10-64-shippable-qr: 1
• windows10-64-shippable: 3

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

Comment 10

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 1
• autoland: 1

Platform breakdown:

• windows10-64-shippable: 1
• windows10-64-shippable-qr: 1

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

Comment 11

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2

Platform breakdown:

• windows10-64-shippable: 1
• windows10-64-shippable-qr: 1

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

Comment 12

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

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

Comment 13

[Dorel Luca [:dluca]]

Recent log:
https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=311791648&repo=autoland&lineNumber=1329

Comment 14

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• windows10-64-qr: 1

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

Comment 15

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

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

Comment 16

[Alexandru Michis [:malexandru]]

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=326374817&repo=autoland&lineNumber=2428

Comment 17

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• windows10-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1616096&startday=2021-01-11&endday=2021-01-17&tree=all

Comment 18

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

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

Comment 19

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 1
• autoland: 1

Platform and build breakdown:

• windows10-64: 1
  • asan: 1
• windows10-64-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1616096&startday=2021-02-08&endday=2021-02-14&tree=all

Comment 20

[Florian Quèze [:florian]]

Attachment: Bug 1616096 - PopupNotifications code should prevent the default action on the escape keypress event to avoid dismissing two notifications with a single key press, r=johannh.

Depends on D108021

Comment 21

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/eaff5714cd22
PopupNotifications code should prevent the default action on the escape keypress event to avoid dismissing two notifications with a single key press, r=johannh,pbz.

Comment 22

[Bogdan Tara[:bogdan_tara | bogdant]]

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

Comment 23

[Alexandru Michis [:malexandru]]

Florian, there has been a recent appeareance of this failure, should this bug be reopened or a new one be made?

Comment 24

[Florian Quèze [:florian]]

(In reply to Alexandru Michis [:malexandru] from comment #23)

Florian, there has been a recent appeareance of this failure, should this bug be reopened or a new one be made?

I think a new one will be preferable. Thanks for asking!