Closed
Bug 1639100
Opened 6 years ago
Closed 6 years ago
Intermittent telemetry/marionette/tests/client/test_main_tab_scalars.py TestMainTabScalars.test_main_tab_scalars | KeyError: 'browser.engagement.max_concurrent_tab_count'
Categories
(Toolkit :: Telemetry, defect, P5)
Toolkit
Telemetry
Tracking
()
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: btara [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=302768892&repo=mozilla-release
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/G_BzHzusTyaEcYq2kJeqIg/runs/0/artifacts/public/logs/live_backing.log
...
[task 2020-05-18T15:41:06.423Z] 15:41:06 INFO - 1589816466419 Marionette TRACE Received observer notification marionette-startup-requested
[task 2020-05-18T15:41:06.423Z] 15:41:06 INFO - 1589816466420 Marionette TRACE Waiting until startup recorder finished recording startup scripts...
[task 2020-05-18T15:41:06.570Z] 15:41:06 INFO - 1589816466567 Marionette TRACE All scripts recorded.
[task 2020-05-18T15:41:06.625Z] 15:41:06 INFO - 1589816466620 Marionette INFO Listening on port 2828
[task 2020-05-18T15:41:06.625Z] 15:41:06 INFO - 1589816466621 Marionette DEBUG Marionette is listening
[task 2020-05-18T15:41:06.660Z] 15:41:06 INFO - 1589816466651 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-engine-modified, aData: engine-changed
[task 2020-05-18T15:41:06.660Z] 15:41:06 INFO - 1589816466652 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-engine-modified, aData: engine-changed
[task 2020-05-18T15:41:06.660Z] 15:41:06 INFO - 1589816466655 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-engine-modified, aData: engine-changed
[task 2020-05-18T15:41:06.660Z] 15:41:06 INFO - 1589816466657 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-engine-modified, aData: engine-changed
[task 2020-05-18T15:41:06.661Z] 15:41:06 INFO - 1589816466658 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-engine-modified, aData: engine-changed
[task 2020-05-18T15:41:06.661Z] 15:41:06 INFO - 1589816466660 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-engine-modified, aData: engine-changed
[task 2020-05-18T15:41:06.728Z] 15:41:06 INFO - 1589816466724 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-engine-modified, aData: engine-changed
[task 2020-05-18T15:41:06.728Z] 15:41:06 INFO - 1589816466724 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-engine-modified, aData: engine-changed
[task 2020-05-18T15:41:06.728Z] 15:41:06 INFO - 1589816466726 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-engine-modified, aData: engine-changed
[task 2020-05-18T15:41:06.728Z] 15:41:06 INFO - 1589816466728 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-engine-modified, aData: engine-changed
[task 2020-05-18T15:41:06.731Z] 15:41:06 INFO - 1589816466728 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-engine-modified, aData: engine-changed
[task 2020-05-18T15:41:06.734Z] 15:41:06 INFO - 1589816466730 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-engine-modified, aData: engine-changed
[task 2020-05-18T15:41:06.734Z] 15:41:06 INFO - 1589816466732 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-engine-modified, aData: engine-changed
[task 2020-05-18T15:41:06.734Z] 15:41:06 INFO - 1589816466732 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-engine-modified, aData: engine-changed
[task 2020-05-18T15:41:06.734Z] 15:41:06 INFO - 1589816466734 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-engine-modified, aData: engine-changed
[task 2020-05-18T15:41:06.741Z] 15:41:06 INFO - 1589816466736 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-engine-modified, aData: engine-changed
[task 2020-05-18T15:41:06.741Z] 15:41:06 INFO - 1589816466736 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-engine-modified, aData: engine-changed
[task 2020-05-18T15:41:06.741Z] 15:41:06 INFO - 1589816466738 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-engine-modified, aData: engine-changed
[task 2020-05-18T15:41:06.756Z] 15:41:06 INFO - 1589816466748 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-service, aData: write-cache-to-disk-complete
[task 2020-05-18T15:41:06.756Z] 15:41:06 INFO - 1589816466749 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: browser-search-service, aData: engines-reloaded
[task 2020-05-18T15:41:06.804Z] 15:41:06 INFO - 1589816466799 Toolkit.Telemetry TRACE TelemetryEnvironment::_updateAddons
[task 2020-05-18T15:41:06.819Z] 15:41:06 INFO - 1589816466811 Toolkit.Telemetry TRACE TelemetryEnvironment::_updateAddons: addons differ
[task 2020-05-18T15:41:06.819Z] 15:41:06 INFO - 1589816466813 Toolkit.Telemetry TRACE TelemetryEnvironment::_startWatchingPrefs - [object Map]
[task 2020-05-18T15:41:07.074Z] 15:41:07 INFO - 1589816467066 Marionette DEBUG Accepted connection 0 from 127.0.0.1:49535
[task 2020-05-18T15:41:07.074Z] 15:41:07 INFO - 1589816467068 Marionette DEBUG Accepted connection 1 from 127.0.0.1:49538
[task 2020-05-18T15:41:07.074Z] 15:41:07 INFO - 1589816467071 Marionette DEBUG Closed connection 1
[task 2020-05-18T15:41:07.075Z] 15:41:07 INFO - 1589816467072 Marionette DEBUG Closed connection 0
[task 2020-05-18T15:41:07.078Z] 15:41:07 INFO - 1589816467073 Marionette DEBUG Accepted connection 2 from 127.0.0.1:49539
[task 2020-05-18T15:41:07.085Z] 15:41:07 INFO - 1589816467080 Marionette DEBUG 2 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2020-05-18T15:41:07.105Z] 15:41:07 INFO - 1589816467098 Marionette TRACE [10] Frame script loaded
[task 2020-05-18T15:41:07.105Z] 15:41:07 INFO - 1589816467099 Marionette TRACE [10] Frame script registered
[task 2020-05-18T15:41:07.105Z] 15:41:07 INFO - 1589816467100 Toolkit.Telemetry TRACE TelemetryEnvironment::observe - aTopic: nsPref:changed, aData: marionette.contentListener
[task 2020-05-18T15:41:07.112Z] 15:41:07 INFO - 1589816467109 Marionette DEBUG 2 <- [1,1,null,{"sessionId":"c42304f3-dcc1-410d-a552-751e5fd1428b","capabilities":{"browserName":"firefox","browserVersion":"76.0. ... d\\tmptjgy26.mozrunner","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true}}]
[task 2020-05-18T15:41:07.127Z] 15:41:07 INFO - 1589816467118 Marionette DEBUG 2 -> [0,2,"Marionette:SetContext",{"value":"content"}]
[task 2020-05-18T15:41:07.127Z] 15:41:07 INFO - 1589816467119 Marionette DEBUG 2 <- [1,2,null,{"value":null}]
[task 2020-05-18T15:41:07.127Z] 15:41:07 INFO - 1589816467123 Marionette DEBUG 2 -> [0,3,"Marionette:GetContext",{}]
[task 2020-05-18T15:41:07.127Z] 15:41:07 INFO - 1589816467124 Marionette DEBUG 2 <- [1,3,null,{"value":"content"}]
[task 2020-05-18T15:41:07.130Z] 15:41:07 INFO - 1589816467127 Marionette DEBUG 2 -> [0,4,"Marionette:SetContext",{"value":"chrome"}]
[task 2020-05-18T15:41:07.130Z] 15:41:07 INFO - 1589816467127 Marionette DEBUG 2 <- [1,4,null,{"value":null}]
[task 2020-05-18T15:41:07.145Z] 15:41:07 INFO - 1589816467138 Marionette DEBUG 2 -> [0,5,"WebDriver:ExecuteScript",{"script":"Cu.import(\"resource://gre/modules/ClientID.jsm\");return ClientID.getCachedClientI ... name":"Z:\\task_1589814791\\build\\venv\\lib\\site-packages\\telemetry_harness\\testcase.py","sandbox":"default","line":184}]
[task 2020-05-18T15:41:07.145Z] 15:41:07 INFO - 1589816467143 Marionette DEBUG 2 <- [1,5,null,{"value":"fef12d1d-e8bc-4bfb-98c6-a9e859a2feac"}]
[task 2020-05-18T15:41:07.152Z] 15:41:07 INFO - 1589816467148 Marionette DEBUG 2 -> [0,6,"Marionette:SetContext",{"value":"content"}]
[task 2020-05-18T15:41:07.152Z] 15:41:07 INFO - 1589816467149 Marionette DEBUG 2 <- [1,6,null,{"value":null}]
[task 2020-05-18T15:41:07.155Z] 15:41:07 INFO - 1589816467152 Marionette DEBUG 2 -> [0,7,"Marionette:GetContext",{}]
[task 2020-05-18T15:41:07.155Z] 15:41:07 INFO - 1589816467153 Marionette DEBUG 2 <- [1,7,null,{"value":"content"}]
[task 2020-05-18T15:41:07.158Z] 15:41:07 INFO - 1589816467154 Marionette DEBUG 2 -> [0,8,"Marionette:SetContext",{"value":"chrome"}]
[task 2020-05-18T15:41:07.158Z] 15:41:07 INFO - 1589816467155 Marionette DEBUG 2 <- [1,8,null,{"value":null}]
[task 2020-05-18T15:41:07.161Z] 15:41:07 INFO - 1589816467158 Marionette DEBUG 2 -> [0,9,"WebDriver:TakeScreenshot",{"full":true,"hash":false,"id":null,"scroll":true}]
[task 2020-05-18T15:41:07.308Z] 15:41:07 INFO - 1589816467303 Marionette DEBUG 2 <- [1,9,null,{"value":"iVBORw0KGgoAAAANSUhEUgAABQAAAAQuCAYAAACDNZAFAAAgAElEQVR4nOzde7QddX03/vPns37PPmHZhVixWgt9fBYUXSgoKtUmRSuir ... IgAAAAAFPY+RKQx7Rte3A6ARAAAACAKQiAMyUAAgAAADAFAXCmBEAAAAAApjDrAPgtEwABAAAAmIIAOFMCIAAAAABT+D9aA2nqT0w+BgAAAABJRU5ErkJggg=="}]
[task 2020-05-18T15:41:07.315Z] 15:41:07 INFO - 1589816467311 Marionette DEBUG 2 -> [0,10,"Marionette:SetContext",{"value":"content"}]
[task 2020-05-18T15:41:07.315Z] 15:41:07 INFO - 1589816467312 Marionette DEBUG 2 <- [1,10,null,{"value":null}]
[task 2020-05-18T15:41:07.318Z] 15:41:07 INFO - 1589816467315 Marionette DEBUG 2 -> [0,11,"Marionette:GetContext",{}]
[task 2020-05-18T15:41:07.318Z] 15:41:07 INFO - 1589816467316 Marionette DEBUG 2 <- [1,11,null,{"value":"content"}]
[task 2020-05-18T15:41:07.341Z] 15:41:07 INFO - 1589816467338 Marionette DEBUG 2 -> [0,12,"Marionette:SetContext",{"value":"content"}]
[task 2020-05-18T15:41:07.341Z] 15:41:07 INFO - 1589816467338 Marionette DEBUG 2 <- [1,12,null,{"value":null}]
[task 2020-05-18T15:41:07.344Z] 15:41:07 INFO - 1589816467341 Marionette DEBUG 2 -> [0,13,"WebDriver:GetPageSource",{}]
[task 2020-05-18T15:41:07.351Z] 15:41:07 INFO - 1589816467345 Marionette DEBUG 2 <- [1,13,null,{"value":"<html xmlns=\"http://www.w3.org/1999/xhtml\" dir=\"ltr\" lang=\"en-US\"><head>\n <meta charset=\"utf-8\ ... bout:webrtc\">about:webrtc</a></li><li><a href=\"about:welcome\">about:welcome</a></li></ul>\n </div>\n\n\n</body></html>"}]
[task 2020-05-18T15:41:07.392Z] 15:41:07 INFO - TEST-UNEXPECTED-ERROR | telemetry/marionette/tests/client/test_main_tab_scalars.py TestMainTabScalars.test_main_tab_scalars | KeyError: 'browser.engagement.max_concurrent_tab_count'
[task 2020-05-18T15:41:07.392Z] 15:41:07 INFO - Traceback (most recent call last):
[task 2020-05-18T15:41:07.392Z] 15:41:07 INFO - File "Z:\task_1589814791\build\venv\lib\site-packages\marionette_harness\marionette_test\testcases.py", line 159, in run
[task 2020-05-18T15:41:07.392Z] 15:41:07 INFO - testMethod()
[task 2020-05-18T15:41:07.392Z] 15:41:07 INFO - File "Z:\task_1589814791\build\tests\telemetry\marionette\tests\client\test_main_tab_scalars.py", line 38, in test_main_tab_scalars
[task 2020-05-18T15:41:07.392Z] 15:41:07 INFO - scalars["browser.engagement.max_concurrent_tab_count"], 3
[task 2020-05-18T15:41:07.392Z] 15:41:07 INFO - TEST-INFO took 14592ms
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 2•6 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•