1723899 - Intermittent browser/base/content/test/siteIdentity/browser_identityPopup_focus.js | learn more option for custom roots is focused - Got null, expected [object XULTextElement]

Status: NEW

(Firefox :: Site Identity, defect, P3)

Description

[Treeherder Bug Filer]

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

---

[task 2021-08-04T04:37:02.107Z] 04:37:02     INFO - TEST-START | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js
[task 2021-08-04T04:37:03.391Z] 04:37:03     INFO - GECKO(3987) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-08-04T04:37:04.328Z] 04:37:04     INFO - GECKO(3987) | -----------------------------------------------------
[task 2021-08-04T04:37:04.328Z] 04:37:04     INFO - GECKO(3987) | Suppressions used:
[task 2021-08-04T04:37:04.328Z] 04:37:04     INFO - GECKO(3987) |   count      bytes template
[task 2021-08-04T04:37:04.328Z] 04:37:04     INFO - GECKO(3987) |      13        416 nsComponentManagerImpl
[task 2021-08-04T04:37:04.328Z] 04:37:04     INFO - GECKO(3987) |       2        288 libfontconfig.so
[task 2021-08-04T04:37:04.328Z] 04:37:04     INFO - GECKO(3987) | -----------------------------------------------------
[task 2021-08-04T04:37:04.767Z] 04:37:04     INFO - GECKO(3987) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-08-04T04:37:04.768Z] 04:37:04     INFO - GECKO(3987) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-08-04T04:37:06.178Z] 04:37:06     INFO - GECKO(3987) | -----------------------------------------------------
[task 2021-08-04T04:37:06.179Z] 04:37:06     INFO - GECKO(3987) | Suppressions used:
[task 2021-08-04T04:37:06.179Z] 04:37:06     INFO - GECKO(3987) |   count      bytes template
[task 2021-08-04T04:37:06.180Z] 04:37:06     INFO - GECKO(3987) |      13        416 nsComponentManagerImpl
[task 2021-08-04T04:37:06.181Z] 04:37:06     INFO - GECKO(3987) |       2        288 libfontconfig.so
[task 2021-08-04T04:37:06.182Z] 04:37:06     INFO - GECKO(3987) | -----------------------------------------------------
[task 2021-08-04T04:37:06.239Z] 04:37:06     INFO - TEST-INFO | started process screentopng
[task 2021-08-04T04:37:06.913Z] 04:37:06     INFO - TEST-INFO | screentopng: exit 0
[task 2021-08-04T04:37:06.913Z] 04:37:06     INFO - Buffered messages logged at 04:37:02
[task 2021-08-04T04:37:06.914Z] 04:37:06     INFO - Entering test bound testIdentityPopupFocusClick
[task 2021-08-04T04:37:06.915Z] 04:37:06     INFO - Buffered messages logged at 04:37:03
[task 2021-08-04T04:37:06.916Z] 04:37:06     INFO - TEST-PASS | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js | undefined assertion name - 
[task 2021-08-04T04:37:06.917Z] 04:37:06     INFO - Leaving test bound testIdentityPopupFocusClick
[task 2021-08-04T04:37:06.917Z] 04:37:06     INFO - Entering test bound testIdentityPopupFocusKeyboard
[task 2021-08-04T04:37:06.918Z] 04:37:06     INFO - Buffered messages logged at 04:37:04
[task 2021-08-04T04:37:06.922Z] 04:37:06     INFO - TEST-PASS | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js | urlbar should be focused - 
[task 2021-08-04T04:37:06.922Z] 04:37:06     INFO - TEST-PASS | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js | undefined assertion name - 
[task 2021-08-04T04:37:06.923Z] 04:37:06     INFO - Leaving test bound testIdentityPopupFocusKeyboard
[task 2021-08-04T04:37:06.933Z] 04:37:06     INFO - Entering test bound testSiteSecurityTabOrder
[task 2021-08-04T04:37:06.933Z] 04:37:06     INFO - Buffered messages logged at 04:37:05
[task 2021-08-04T04:37:06.933Z] 04:37:06     INFO - TEST-PASS | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js | urlbar should be focused - 
[task 2021-08-04T04:37:06.933Z] 04:37:06     INFO - TEST-PASS | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js | undefined assertion name - 
[task 2021-08-04T04:37:06.934Z] 04:37:06     INFO - Buffered messages finished
[task 2021-08-04T04:37:06.934Z] 04:37:06     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js | learn more option for custom roots is focused - Got null, expected [object XULTextElement]
[task 2021-08-04T04:37:06.934Z] 04:37:06     INFO - Stack trace:
[task 2021-08-04T04:37:06.935Z] 04:37:06     INFO - chrome://mochikit/content/browser-test.js:test_is:1371
[task 2021-08-04T04:37:06.935Z] 04:37:06     INFO - chrome://mochitests/content/browser/browser/base/content/test/siteIdentity/browser_identityPopup_focus.js:testSiteSecurityTabOrder/<:87
[task 2021-08-04T04:37:06.953Z] 04:37:06     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-08-04T04:37:06.953Z] 04:37:06     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js | more info button is focused - Got [object XULElement], expected [object XULElement]
[task 2021-08-04T04:37:06.953Z] 04:37:06     INFO - Stack trace:
[task 2021-08-04T04:37:06.953Z] 04:37:06     INFO - chrome://mochikit/content/browser-test.js:test_is:1371
[task 2021-08-04T04:37:06.953Z] 04:37:06     INFO - chrome://mochitests/content/browser/browser/base/content/test/siteIdentity/browser_identityPopup_focus.js:testSiteSecurityTabOrder/<:101
[task 2021-08-04T04:37:06.954Z] 04:37:06     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-08-04T04:37:06.956Z] 04:37:06     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js | back button is focused - Got [object XULTextElement], expected [object XULElement]
[task 2021-08-04T04:37:06.957Z] 04:37:06     INFO - Stack trace:
[task 2021-08-04T04:37:06.958Z] 04:37:06     INFO - chrome://mochikit/content/browser-test.js:test_is:1371
[task 2021-08-04T04:37:06.958Z] 04:37:06     INFO - chrome://mochitests/content/browser/browser/base/content/test/siteIdentity/browser_identityPopup_focus.js:testSiteSecurityTabOrder/<:118
[task 2021-08-04T04:37:06.959Z] 04:37:06     INFO - Leaving test bound testSiteSecurityTabOrder
[task 2021-08-04T04:37:06.959Z] 04:37:06     INFO - GECKO(3987) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-08-04T04:37:06.960Z] 04:37:06     INFO - GECKO(3987) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-08-04T04:37:06.974Z] 04:37:06     INFO - GECKO(3987) | MEMORY STAT | vsize 20975824MB | residentFast 1513MB
[task 2021-08-04T04:37:06.975Z] 04:37:06     INFO - TEST-OK | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js | took 4356ms
[task 2021-08-04T04:37:06.975Z] 04:37:06     INFO - checking window state
[task 2021-08-04T04:37:06.976Z] 04:37:06     INFO - TEST-START | browser/base/content/test/siteIdentity/browser_identity_UI.js

Comment 1

[Sebastian Hengst [:aryx] (needinfo me if it's about an intermittent or backout)]

Frequent failure, maybe a regression from bug 1613705?

Comment 2

[Marian-Vasile Laza]

Aryx is right, this looks to have appeared after bug 1613705 landed: Link
Paul, could you please take a look?

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 7
• autoland: 13

Platform and build breakdown:

• linux1804-64-asan-qr: 20
  • opt: 20

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

Comment 4

[Paul Zühlcke [:pbz]]

:zbraniecki, could this be a regression of Bug 1613705? Do you think this test could suffer from the same type of race conditions you fixed in https://phabricator.services.mozilla.com/D116792?

Given that it only fails for a very specific flavor, we could also consider disabling it.

Comment 5

[Zibi Braniecki [:zbraniecki][:gandalf]]

yeah, it may be a race condition in result of the l10n microtask fix!

Comment 6

[Iulian Moraru]

Update:
There have been 29 failures within the last 7 days:
• 26 failures on Linux 18.04 x64 WebRender asan opt
• 3 failures on linux1804-64-tsan-qr opt
Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=348457220&repo=autoland&lineNumber=2743

[task 2021-08-15T00:07:55.158Z] 00:07:55     INFO - TEST-START | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js
[task 2021-08-15T00:07:59.213Z] 00:07:59     INFO - TEST-INFO | started process screentopng
[task 2021-08-15T00:07:59.538Z] 00:07:59     INFO - TEST-INFO | screentopng: exit 0
[task 2021-08-15T00:07:59.538Z] 00:07:59     INFO - Buffered messages logged at 00:07:55
[task 2021-08-15T00:07:59.538Z] 00:07:59     INFO - Entering test bound testIdentityPopupFocusClick
[task 2021-08-15T00:07:59.539Z] 00:07:59     INFO - Buffered messages logged at 00:07:56
[task 2021-08-15T00:07:59.543Z] 00:07:59     INFO - TEST-PASS | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js | undefined assertion name - 
[task 2021-08-15T00:07:59.543Z] 00:07:59     INFO - Leaving test bound testIdentityPopupFocusClick
[task 2021-08-15T00:07:59.544Z] 00:07:59     INFO - Entering test bound testIdentityPopupFocusKeyboard
[task 2021-08-15T00:07:59.544Z] 00:07:59     INFO - Buffered messages logged at 00:07:57
[task 2021-08-15T00:07:59.544Z] 00:07:59     INFO - TEST-PASS | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js | urlbar should be focused - 
[task 2021-08-15T00:07:59.544Z] 00:07:59     INFO - TEST-PASS | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js | undefined assertion name - 
[task 2021-08-15T00:07:59.544Z] 00:07:59     INFO - Leaving test bound testIdentityPopupFocusKeyboard
[task 2021-08-15T00:07:59.544Z] 00:07:59     INFO - Entering test bound testSiteSecurityTabOrder
[task 2021-08-15T00:07:59.545Z] 00:07:59     INFO - Buffered messages logged at 00:07:58
[task 2021-08-15T00:07:59.545Z] 00:07:59     INFO - TEST-PASS | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js | urlbar should be focused - 
[task 2021-08-15T00:07:59.545Z] 00:07:59     INFO - TEST-PASS | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js | undefined assertion name - 
[task 2021-08-15T00:07:59.545Z] 00:07:59     INFO - Buffered messages finished
[task 2021-08-15T00:07:59.545Z] 00:07:59     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js | learn more option for custom roots is focused - Got null, expected [object XULTextElement]
[task 2021-08-15T00:07:59.546Z] 00:07:59     INFO - Stack trace:
[task 2021-08-15T00:07:59.546Z] 00:07:59     INFO - chrome://mochikit/content/browser-test.js:test_is:1364
[task 2021-08-15T00:07:59.546Z] 00:07:59     INFO - chrome://mochitests/content/browser/browser/base/content/test/siteIdentity/browser_identityPopup_focus.js:testSiteSecurityTabOrder/<:87
[task 2021-08-15T00:07:59.546Z] 00:07:59     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-08-15T00:07:59.546Z] 00:07:59     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js | more info button is focused - Got [object XULElement], expected [object XULElement]
[task 2021-08-15T00:07:59.546Z] 00:07:59     INFO - Stack trace:
[task 2021-08-15T00:07:59.546Z] 00:07:59     INFO - chrome://mochikit/content/browser-test.js:test_is:1364
[task 2021-08-15T00:07:59.546Z] 00:07:59     INFO - chrome://mochitests/content/browser/browser/base/content/test/siteIdentity/browser_identityPopup_focus.js:testSiteSecurityTabOrder/<:101
[task 2021-08-15T00:07:59.546Z] 00:07:59     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-08-15T00:07:59.547Z] 00:07:59     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js | back button is focused - Got [object XULTextElement], expected [object XULElement]
[task 2021-08-15T00:07:59.547Z] 00:07:59     INFO - Stack trace:
[task 2021-08-15T00:07:59.547Z] 00:07:59     INFO - chrome://mochikit/content/browser-test.js:test_is:1364
[task 2021-08-15T00:07:59.547Z] 00:07:59     INFO - chrome://mochitests/content/browser/browser/base/content/test/siteIdentity/browser_identityPopup_focus.js:testSiteSecurityTabOrder/<:118
[task 2021-08-15T00:07:59.547Z] 00:07:59     INFO - Leaving test bound testSiteSecurityTabOrder
[task 2021-08-15T00:07:59.547Z] 00:07:59     INFO - GECKO(2254) | MEMORY STAT | vsize 130551903MB | residentFast 2192MB
[task 2021-08-15T00:07:59.548Z] 00:07:59     INFO - TEST-OK | browser/base/content/test/siteIdentity/browser_identityPopup_focus.js | took 4362ms
[task 2021-08-15T00:07:59.624Z] 00:07:59     INFO - checking window state
[task 2021-08-15T00:07:59.732Z] 00:07:59     INFO - TEST-START | browser/base/content/test/siteIdentity/browser_identity_UI.js

Comment 7

[Intermittent Failures Robot]

28 failures in 3025 pushes (0.009 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 7
• autoland: 21

Platform and build breakdown:

• linux1804-64-tsan-qr: 3
  • opt: 3
• linux1804-64-asan-qr: 25
  • opt: 25

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

Comment 8

[Paul Zühlcke [:pbz]]

Adding polling to the test, to wait for the element to gain focus, doesn't fix the intermittent failure. It seems that we actually don't focus the "learn more" link sometimes. Currently investigating if this could be a bug in the PanelMultiView implementation. I'm also wondering if the focus call could fail because l10n isn't complete and there isn't any label content to focus.

Comment 9

[Paul Zühlcke [:pbz]]

Attachment: Bug 1723899 - Disable browser_identityPopup_focus on linux asan, tsan and verify. r=johannh,prathiksha

Comment 10

[Intermittent Failures Robot]

18 failures in 2899 pushes (0.006 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 16
• mozilla-central: 2

Platform and build breakdown:

• linux1804-64-asan-qr: 16
  • opt: 16
• linux1804-64-tsan-qr: 1
  • opt: 1
• linux1804-64-qr: 1
  • debug: 1

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

Comment 11

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/9b90288e5659
Disable browser_identityPopup_focus on linux asan, tsan and verify. r=prathiksha

Comment 12

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/2095668d4c9b
disable fix. a=fix CLOSED TREE

Comment 13

[Natalia Csoregi [:nataliaCs]]

https://hg.mozilla.org/mozilla-central/rev/9b90288e5659
https://hg.mozilla.org/mozilla-central/rev/2095668d4c9b

Comment 14

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 3
• mozilla-central: 2

Platform and build breakdown:

• linux1804-64-asan-qr: 2
  • opt: 2
• linux1804-64-qr: 3
  • debug: 3

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

Comment 15

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1723899&startday=2021-09-13&endday=2021-09-19&tree=all

Comment 16

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 3

Platform and build breakdown:

• linux1804-64-qr: 3
  • debug: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1723899&startday=2021-09-20&endday=2021-09-26&tree=all

Comment 17

[Paul Zühlcke [:pbz]]

Failure rate is rather low now. I'm unassigning for now.

Comment 18

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 3
• mozilla-central: 1

Platform and build breakdown:

• linux1804-64-qr: 4
  • debug: 4

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1723899&startday=2021-09-27&endday=2021-10-03&tree=all

Comment 19

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 3

Platform and build breakdown:

• linux1804-64-qr: 2
  • debug: 2
• linux1804-64-ccov-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1723899&startday=2021-10-04&endday=2021-10-10&tree=all

Comment 20

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 5

Platform and build breakdown:

• linux1804-64-qr: 5
  • debug: 5

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

Comment 21

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1723899&startday=2021-10-18&endday=2021-10-24&tree=all

Comment 22

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 2
• autoland: 3

Platform and build breakdown:

• linux1804-64-qr: 5
  • debug: 5

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1723899&startday=2021-10-25&endday=2021-10-31&tree=all

Comment 23

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 3
• mozilla-central: 1

Platform and build breakdown:

• linux1804-64-qr: 4
  • debug: 4

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

Comment 24

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 3

Platform and build breakdown:

• linux1804-64-qr: 3
  • debug: 3

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

Comment 25

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 6
• mozilla-central: 1

Platform and build breakdown:

• linux1804-64-qr: 7
  • debug: 7

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

Comment 26

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 4
• mozilla-central: 2

Platform and build breakdown:

• linux1804-64-qr: 6
  • debug: 6

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

Comment 27

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 1

Platform and build breakdown:

• linux1804-64-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1723899&startday=2021-11-29&endday=2021-12-05&tree=all

Comment 28

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 1

Platform and build breakdown:

• linux1804-64-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1723899&startday=2021-12-06&endday=2021-12-12&tree=all