1575246 - Intermittent [TV] browser/base/content/test/siteProtections/browser_protections_UI.js | recorded telemetry for opening the popup - Got 12, expected 1

Status: RESOLVED FIXED

(Firefox :: Protections UI, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: nbeleuzu [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=262485759&repo=autoland
Full log: https://queue.taskcluster.net/v1/task/WX0a3DzxSDeOi3qNdRpe7w/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://queue.taskcluster.net/v1/task/WX0a3DzxSDeOi3qNdRpe7w/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

---

[task 2019-08-20T14:58:57.869Z] 14:58:57 INFO - TEST-START | browser/base/content/test/siteProtections/browser_protections_UI.js
[task 2019-08-20T14:58:57.904Z] 14:58:57 INFO - GECKO(1716) | ++DOCSHELL 01361C00 == 2 [pid = 3516] [id = {ba81ba74-bed2-407b-b600-85e02ce349d5}]
[task 2019-08-20T14:58:57.904Z] 14:58:57 INFO - GECKO(1716) | ++DOMWINDOW == 3 (01373040) [pid = 3516] [serial = 6] [outer = 00000000]
[task 2019-08-20T14:58:57.904Z] 14:58:57 INFO - GECKO(1716) | ++DOMWINDOW == 4 (01369400) [pid = 3516] [serial = 7] [outer = 01373040]
[task 2019-08-20T14:58:57.907Z] 14:58:57 INFO - GECKO(1716) | [Child 3516, Main Thread] WARNING: No active window: file z:/build/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-20T14:58:57.910Z] 14:58:57 INFO - GECKO(1716) | [Child 3516, Main Thread] WARNING: No active window: file z:/build/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-20T14:58:57.925Z] 14:58:57 INFO - GECKO(1716) | --DOMWINDOW == 8 (0B253000) [pid = 2132] [serial = 8] [outer = 00000000] [url = about:blank]
[task 2019-08-20T14:58:57.925Z] 14:58:57 INFO - GECKO(1716) | --DOMWINDOW == 7 (092A4800) [pid = 2132] [serial = 3] [outer = 00000000] [url = https://example.com/]
[task 2019-08-20T14:58:57.925Z] 14:58:57 INFO - GECKO(1716) | --DOCSHELL 01669C00 == 0 [pid = 2132] [id = {6586e5a1-4e22-4ff0-b1da-2fb7faee43c2}] [url = http://www.example.com/]
[task 2019-08-20T14:58:57.960Z] 14:58:57 INFO - GECKO(1716) | --DOMWINDOW == 6 (016B0820) [pid = 2132] [serial = 4] [outer = 00000000] [url = http://www.example.com/]
[task 2019-08-20T14:58:57.960Z] 14:58:57 INFO - GECKO(1716) | --DOMWINDOW == 5 (016B0CA0) [pid = 2132] [serial = 7] [outer = 00000000] [url = http://www.example.com/]
[task 2019-08-20T14:58:58.075Z] 14:58:58 INFO - GECKO(1716) | ++DOMWINDOW == 5 (0A539400) [pid = 3516] [serial = 8] [outer = 01373040]
[task 2019-08-20T14:58:58.242Z] 14:58:58 INFO - GECKO(1716) | [Parent 1416, Main Thread] WARNING: '!mPresContext', file z:/build/build/src/dom/events/UIEvent.cpp, line 138
[task 2019-08-20T14:58:58.242Z] 14:58:58 INFO - GECKO(1716) | [Parent 1416, Main Thread] WARNING: '!mPresContext', file z:/build/build/src/dom/events/UIEvent.cpp, line 152
[task 2019-08-20T14:58:58.737Z] 14:58:58 INFO - TEST-INFO | started process screenshot
[task 2019-08-20T14:58:58.796Z] 14:58:58 INFO - TEST-INFO | screenshot: exit 0
[task 2019-08-20T14:58:58.797Z] 14:58:58 INFO - Buffered messages logged at 14:58:57
[task 2019-08-20T14:58:58.797Z] 14:58:58 INFO - Entering test bound setup
[task 2019-08-20T14:58:58.797Z] 14:58:58 INFO - Console message: [JavaScript Error: "uncaught exception: Object" {file: "resource://testing-common/PromiseTestUtils.jsm" line: 112}]
[task 2019-08-20T14:58:58.798Z] 14:58:58 INFO - Leaving test bound setup
[task 2019-08-20T14:58:58.798Z] 14:58:58 INFO - Entering test bound testToggleSwitch
[task 2019-08-20T14:58:58.798Z] 14:58:58 INFO - Buffered messages finished
[task 2019-08-20T14:58:58.798Z] 14:58:58 INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/siteProtections/browser_protections_UI.js | recorded telemetry for opening the popup - Got 12, expected 1
[task 2019-08-20T14:58:58.798Z] 14:58:58 INFO - Stack trace:
[task 2019-08-20T14:58:58.798Z] 14:58:58 INFO - chrome://mochikit/content/browser-test.js:test_is:1591
[task 2019-08-20T14:58:58.798Z] 14:58:58 INFO - chrome://mochitests/content/browser/browser/base/content/test/siteProtections/browser_protections_UI.js:testToggleSwitch:61
[task 2019-08-20T14:58:58.799Z] 14:58:58 INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1346
[task 2019-08-20T14:58:58.799Z] 14:58:58 INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1381
[task 2019-08-20T14:58:58.799Z] 14:58:58 INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1203
[task 2019-08-20T14:58:58.799Z] 14:58:58 INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:803
[task 2019-08-20T14:58:58.799Z] 14:58:58 INFO - TEST-PASS | browser/base/content/test/siteProtections/browser_protections_UI.js | The 'Site not working?' link should be visible. -
[task 2019-08-20T14:58:58.799Z] 14:58:58 INFO - TEST-PASS | browser/base/content/test/siteProtections/browser_protections_UI.js | TP Switch should be enabled -
[task 2019-08-20T14:58:58.799Z] 14:58:58 INFO - TEST-PASS | browser/base/content/test/siteProtections/browser_protections_UI.js | The 'Site not working?' link should be hidden after TP switch turns to off. -
[task 2019-08-20T14:58:58.878Z] 14:58:58 INFO - GECKO(1716) | --DOMWINDOW == 49 (20DBE5E0) [pid = 1416] [serial = 27] [outer = 00000000] [url = about:blank]
[task 2019-08-20T14:58:58.878Z] 14:58:58 INFO - GECKO(1716) | --DOMWINDOW == 48 (19F95160) [pid = 1416] [serial = 28] [outer = 00000000] [url = about:blank]
[task 2019-08-20T14:58:58.878Z] 14:58:58 INFO - GECKO(1716) | --DOMWINDOW == 47 (19F95940) [pid = 1416] [serial = 35] [outer = 00000000] [url = about:blank]
[task 2019-08-20T14:58:58.878Z] 14:58:58 INFO - GECKO(1716) | --DOMWINDOW == 46 (19F95040) [pid = 1416] [serial = 34] [outer = 00000000] [url = about:blank]
[task 2019-08-20T14:58:59.013Z] 14:58:59 INFO - GECKO(1716) | --DOMWINDOW == 7 (0A65B000) [pid = 2744] [serial = 9] [outer = 00000000] [url = https://example.com/]
[task 2019-08-20T14:58:59.013Z] 14:58:59 INFO - GECKO(1716) | --DOMWINDOW == 6 (090A3000) [pid = 2744] [serial = 14] [outer = 00000000] [url = about:blank]
[task 2019-08-20T14:58:59.040Z] 14:58:59 INFO - GECKO(1716) | --DOMWINDOW == 5 (013BA940) [pid = 2744] [serial = 10] [outer = 00000000] [url = http://www.example.com/]
[task 2019-08-20T14:58:59.040Z] 14:58:59 INFO - GECKO(1716) | --DOMWINDOW == 4 (013BA280) [pid = 2744] [serial = 13] [outer = 00000000] [url = http://www.example.com/]
[task 2019-08-20T14:58:59.255Z] 14:58:59 INFO - Not taking screenshot here: see the one that was previously logged

Comment 1

[Intermittent Failures Robot]

27 failures in 965 pushes (0.028 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 8
• mozilla-central: 11
• mozilla-inbound: 8

Platform breakdown:

• linux64: 4
• macosx1014-64: 3
• windows10-64: 4
• windows7-32: 4
• macosx1014-64-shippable: 3
• linux64-shippable: 3
• windows7-32-shippable: 3
• windows10-64-shippable: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1575246&startday=2019-08-20&endday=2019-08-20&tree=all

Comment 2

[Razvan Maries]

It looks like after bug 1560327, revision 99564307dcb9 got landed this became perma TV tier 2:
https://treeherder.mozilla.org/#/jobs?repo=autoland&searchStr=windows%2C7%2Cdebug%2Ctest-windows7-32%2Fdebug-test-verify-e10s%2C%28tv%29&tochange=99564307dcb9614cbf7643b61b9ce1966997d8a8&fromchange=12c8584d2a1335692312260583d61c6d4d494443

Nihanth, could you take a look?

Comment 3

[Intermittent Failures Robot]

26 failures in 952 pushes (0.027 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 8
• mozilla-central: 11
• mozilla-inbound: 7

Platform breakdown:

• linux64: 3
• macosx1014-64: 3
• windows10-64: 4
• windows7-32: 4
• linux64-shippable: 3
• macosx1014-64-shippable: 3
• windows10-64-shippable: 3
• windows7-32-shippable: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1575246&startday=2019-08-22&endday=2019-08-22&tree=all

Comment 4

[Intermittent Failures Robot]

80 failures in 5073 pushes (0.016 failures/push) were associated with this bug in the last 7 days.

This is the #22 most frequent failure this week.

** This failure happened more than 75 times this week! Resolving this bug is a very high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 1 week, the affected test(s) may be disabled. **

Repository breakdown:

• autoland: 24
• mozilla-central: 33
• mozilla-inbound: 23

Platform breakdown:

• linux64: 11
• macosx1014-64: 9
• windows10-64: 12
• windows7-32: 12
• macosx1014-64-shippable: 9
• linux64-shippable: 9
• windows7-32-shippable: 9
• windows10-64-shippable: 9

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1575246&startday=2019-08-19&endday=2019-08-25&tree=all

Comment 5

[(inactive) Nihanth Subramanya [:nhnt11]]

Attachment: Bug 1575246 - Clear telemetry events before and after protections panel tests. r=johannh

Comment 6

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/d3025ffd55d1
Clear telemetry events before and after protections panel tests. r=johannh

Comment 7

[Cosmin Sabou [:CosminS]]

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